[57.613261] Initializing watchdogs
[57.613306]   /dev/watchdog0
[57.628224] [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]
[57.632774] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.635045] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.638561] [001/133] (960s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc)
[57.758887] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc
[57.761289] Starting dynamic subtest: pipe-A-eDP-1
[57.785271] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[57.794550] Starting dynamic subtest: pipe-B-eDP-1
[57.816302] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[57.823044] Starting dynamic subtest: pipe-C-eDP-1
[57.845620] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[57.853045] Starting dynamic subtest: pipe-D-eDP-1
[57.875511] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[57.880037] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[59.982252] [002/133] (958s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[60.086899] Starting subtest: fbc-pr-cursor-mmap-gtt
[60.091766] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[60.153896] [003/133] (958s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[60.248304] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[60.252843] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s)
[60.313725] [004/133] (957s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[60.401836] Starting subtest: fbc-psr-sprite-mmap-gtt
[60.404162] Starting dynamic subtest: eDP-1
[60.408430] Dynamic subtest eDP-1: SKIP (0.000s)
[60.412812] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[60.473942] [005/133] (957s left) gem_mmap_gtt (basic-copy)
[60.537476] Subtest basic-copy: SKIP (0.000s)
[60.588206] [006/133] (957s left) gem_exec_params (invalid-bsd-ring)
[60.654580] Starting subtest: invalid-bsd-ring
[60.657057] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[60.742191] [007/133] (957s left) kms_addfb_basic (invalid-set-prop)
[60.798001] Starting subtest: invalid-set-prop
[60.800308] Subtest invalid-set-prop: SUCCESS (0.000s)
[60.942493] [008/133] (957s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[61.031958] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[61.035358] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[61.136549] [009/133] (957s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[61.238357] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[61.241905] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[61.315919] [010/133] (957s left) kms_feature_discovery (display-2x)
[61.413237] Starting subtest: display-2x
[61.417076] Subtest display-2x: SKIP (0.000s)
[61.495188] [011/133] (957s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[61.874743] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[62.704677] [012/133] (955s left) gem_linear_blits (normal)
[63.063702] Starting subtest: normal
[66.500590] Subtest normal: SUCCESS (3.421s)
[66.858432] [013/133] (951s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[67.062412] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[67.064513] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[67.323954] [014/133] (951s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[67.455602] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[67.460151] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[67.641204] [015/133] (951s left) kms_lease (lease-invalid-crtc)
[67.791239] Starting subtest: lease-invalid-crtc
[67.793599] Starting dynamic subtest: pipe-A-eDP-1
[67.795628] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[67.804213] Starting dynamic subtest: pipe-B-eDP-1
[67.806553] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[67.813960] Starting dynamic subtest: pipe-C-eDP-1
[67.816348] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[67.824261] Starting dynamic subtest: pipe-D-eDP-1
[67.826177] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[67.828040] Subtest lease-invalid-crtc: SUCCESS (0.003s)
[67.862346] [016/133] (950s left) gem_ctx_shared (single-timeline)
[67.921497] Starting subtest: single-timeline
[67.941859] Subtest single-timeline: SUCCESS (0.013s)
[68.192343] [017/133] (950s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[68.293972] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[68.298620] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[68.395502] [018/133] (950s left) core_setmaster_vs_auth
[68.564691] [019/133] (950s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[68.672667] Starting subtest: yf-tiled-16bpp-rotate-0
[68.677202] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[68.765232] [020/133] (950s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[68.973462] Starting subtest: cursor-rapid-movement-64x21
[69.021060] Subtest cursor-rapid-movement-64x21: SKIP (0.043s)
[69.244546] [021/133] (949s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[69.344955] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[69.348336] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[69.435345] [022/133] (949s left) kms_psr (psr-sprite-mmap-cpu)
[69.530697] Starting subtest: psr-sprite-mmap-cpu
[69.532567] Starting dynamic subtest: eDP-1
[71.282378] Dynamic subtest eDP-1: SUCCESS (1.745s)
[71.284711] Subtest psr-sprite-mmap-cpu: SUCCESS (1.746s)
[72.123209] [023/133] (946s left) gem_exec_whisper (basic-queues-priority)
[72.199733] Starting subtest: basic-queues-priority
[95.297915] Subtest basic-queues-priority: SUCCESS (23.078s)
[95.481756] [024/133] (923s left) kms_cursor_crc (cursor-offscreen-64x64)
[95.663963] Starting subtest: cursor-offscreen-64x64
[95.668619] Starting dynamic subtest: pipe-A-eDP-1
[97.635727] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.967s)
[97.665199] Starting dynamic subtest: pipe-D-eDP-1
[100.269865] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.609s)
[100.272064] Subtest cursor-offscreen-64x64: SUCCESS (4.603s)
[101.139584] [025/133] (917s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[101.238892] Starting subtest: y-tiled-32bpp-rotate-180
[101.243296] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[101.356463] [026/133] (917s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[101.417064] Starting subtest: yf-tiled-ccs-to-x-tiled
[101.421679] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[101.608947] [027/133] (917s left) kms_flip (flip-vs-panning-interruptible)
[101.712934] Starting subtest: flip-vs-panning-interruptible
[101.715070] Starting dynamic subtest: A-eDP1
[110.432911] Dynamic subtest A-eDP1: SUCCESS (8.717s)
[110.445347] Starting dynamic subtest: B-eDP1
[119.168092] Dynamic subtest B-eDP1: SUCCESS (8.731s)
[119.178049] Starting dynamic subtest: C-eDP1
[127.894575] Dynamic subtest C-eDP1: SUCCESS (8.724s)
[127.905623] Starting dynamic subtest: D-eDP1
[136.617871] Dynamic subtest D-eDP1: SUCCESS (8.721s)
[136.622260] Subtest flip-vs-panning-interruptible: SUCCESS (34.901s)
[137.776491] [028/133] (881s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[137.840680] Starting subtest: invalid-smem-bo-on-discrete
[137.844855] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s)
[137.961395] [029/133] (881s left) gen9_exec_parse (bb-oversize)
[138.021589] Subtest bb-oversize: SKIP (0.000s)
[138.096393] [030/133] (881s left) api_intel_allocator (reopen)
[138.154127] Starting subtest: reopen
[138.158594] Subtest reopen: SUCCESS (0.004s)
[138.278520] [031/133] (881s left) kms_prop_blob (invalid-get-prop-any)
[138.340568] Starting subtest: invalid-get-prop-any
[138.342964] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[138.464385] [032/133] (880s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[138.569895] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[142.614863] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (4.046s)
[143.785081] [033/133] (875s left) prime_mmap (test_map_unmap)
[143.842371] Starting subtest: test_map_unmap
[143.844710] Starting dynamic subtest: test_map_unmap-smem
[143.891892] Dynamic subtest test_map_unmap-smem: SUCCESS (0.050s)
[143.894685] Subtest test_map_unmap: SUCCESS (0.051s)
[143.985451] [034/133] (875s left) gem_lmem_swapping (verify-random-ccs)
[144.027751] Subtest verify-random-ccs: SKIP (0.000s)
[144.067574] [035/133] (875s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[144.201428] Starting subtest: flip-vs-cursor-crc-atomic
[144.884607] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.683s)
[145.707388] [036/133] (873s left) kms_psr (pr-no-drrs)
[145.815091] Starting subtest: pr-no-drrs
[145.819419] Subtest pr-no-drrs: SKIP (0.000s)
[145.906935] [037/133] (873s left) gem_pxp (fail-invalid-protected-context)
[146.025653] Starting subtest: fail-invalid-protected-context
[146.027592] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[146.124696] [038/133] (873s left) gem_pipe_control_store_loop (fresh-buffer)
[146.177644] Starting subtest: fresh-buffer
[148.330046] Subtest fresh-buffer: SUCCESS (2.151s)
[148.440503] [039/133] (871s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[148.539467] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[148.543968] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[148.636104] [040/133] (871s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[148.693481] Starting subtest: multi-wait-for-submit-available-signaled
[148.695482] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.000s)
[148.797459] [041/133] (870s left) perf_pmu (semaphore-busy)
[148.834210] Starting subtest: semaphore-busy
[148.836267] Starting dynamic subtest: rcs0
[150.470269] Dynamic subtest rcs0: SUCCESS (1.633s)
[150.480544] Starting dynamic subtest: bcs0
[152.102218] Dynamic subtest bcs0: SUCCESS (1.629s)
[152.113376] Starting dynamic subtest: vcs0
[156.435034] Dynamic subtest vcs0: SUCCESS (4.331s)
[156.443878] Starting dynamic subtest: vcs1
[162.386517] Dynamic subtest vcs1: SUCCESS (5.948s)
[162.397659] Starting dynamic subtest: vecs0
[168.402934] Dynamic subtest vecs0: SUCCESS (6.014s)
[168.411852] Starting dynamic subtest: ccs0
[171.478040] Dynamic subtest ccs0: SUCCESS (3.072s)
[171.480773] Subtest semaphore-busy: SUCCESS (22.642s)
[171.587768] [042/133] (848s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[171.682164] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[171.684452] Starting dynamic subtest: pipe-A-eDP-1
[171.706680] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[171.718104] Starting dynamic subtest: pipe-B-eDP-1
[171.739093] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[171.746970] Starting dynamic subtest: pipe-C-eDP-1
[171.768289] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[171.776382] Starting dynamic subtest: pipe-D-eDP-1
[171.797348] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[171.801212] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[173.975774] [043/133] (845s left) gem_exec_parallel (userptr)
[174.043684] Starting subtest: userptr
[174.045961] Starting dynamic subtest: rcs0
[175.472989] Dynamic subtest rcs0: SUCCESS (1.429s)
[175.484384] Starting dynamic subtest: bcs0
[176.930339] Dynamic subtest bcs0: SUCCESS (1.456s)
[176.941920] Starting dynamic subtest: vcs0
[178.904453] Dynamic subtest vcs0: SUCCESS (1.971s)
[178.913935] Starting dynamic subtest: vcs1
[180.886893] Dynamic subtest vcs1: SUCCESS (1.980s)
[180.896695] Starting dynamic subtest: vecs0
[182.871403] Dynamic subtest vecs0: SUCCESS (1.982s)
[182.882834] Starting dynamic subtest: ccs0
[184.348990] Dynamic subtest ccs0: SUCCESS (1.477s)
[184.351571] Subtest userptr: SUCCESS (10.306s)
[184.536899] [044/133] (835s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[184.645587] Starting subtest: x-tiled-32bpp-rotate-0
[186.015880] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.370s)
[186.134681] [045/133] (833s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[186.228512] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[186.232195] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[186.327974] [046/133] (833s left) prime_mmap_coherency (write)
[186.391168] Starting subtest: write
[191.772611] Subtest write: SUCCESS (5.379s)
[191.931091] [047/133] (827s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[192.032734] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[192.036834] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[192.118126] [048/133] (827s left) gem_exec_schedule (noreorder-priority)
[192.298845] Starting subtest: noreorder-priority
[192.301599] Starting dynamic subtest: rcs0
[193.433795] Dynamic subtest rcs0: SUCCESS (1.136s)
[193.445144] Starting dynamic subtest: vcs0
[194.900376] Dynamic subtest vcs0: SUCCESS (1.463s)
[194.912939] Starting dynamic subtest: vcs1
[196.881157] Dynamic subtest vcs1: SUCCESS (1.979s)
[196.892745] Starting dynamic subtest: vecs0
[198.867292] Dynamic subtest vecs0: SUCCESS (1.984s)
[198.878614] Starting dynamic subtest: ccs0
[200.006714] Dynamic subtest ccs0: SUCCESS (1.139s)
[200.009194] Subtest noreorder-priority: SUCCESS (7.710s)
[200.194254] [049/133] (819s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[200.286824] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[200.291099] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[200.358169] [050/133] (819s left) kms_chamelium_audio (dp-audio-edid)
[200.738638] Subtest dp-audio-edid: SKIP (0.000s)
[201.585396] [051/133] (818s left) kms_addfb_basic (bad-pitch-0)
[201.633546] Starting subtest: bad-pitch-0
[201.635563] Subtest bad-pitch-0: SUCCESS (0.000s)
[201.773618] [052/133] (818s left) gem_exec_schedule (preempt-self)
[201.836732] Starting subtest: preempt-self
[201.838700] Starting dynamic subtest: rcs0
[201.852065] Dynamic subtest rcs0: SUCCESS (0.023s)
[201.863763] Starting dynamic subtest: bcs0
[201.876465] Dynamic subtest bcs0: SUCCESS (0.024s)
[201.885864] Starting dynamic subtest: vcs0
[201.892727] Dynamic subtest vcs0: SUCCESS (0.016s)
[201.901670] Starting dynamic subtest: vcs1
[201.909873] Dynamic subtest vcs1: SUCCESS (0.016s)
[201.923365] Starting dynamic subtest: vecs0
[201.928751] Dynamic subtest vecs0: SUCCESS (0.018s)
[201.937769] Starting dynamic subtest: ccs0
[201.948738] Dynamic subtest ccs0: SUCCESS (0.019s)
[201.950878] Subtest preempt-self: SUCCESS (0.120s)
[202.983384] [053/133] (817s left) gem_spin_batch (spin-all-new)
[203.058953] Starting subtest: spin-all-new
[203.074357] Subtest spin-all-new: SUCCESS (0.014s)
[204.925209] [054/133] (815s left) kms_big_fb (4-tiled-addfb)
[205.025256] Starting subtest: 4-tiled-addfb
[205.027437] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[205.123238] [055/133] (815s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[205.232483] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[205.236342] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[205.328851] [056/133] (814s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[205.420964] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[209.899678] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.481s)
[211.017414] [057/133] (809s left) gem_userptr_blits (mmap-offset-banned)
[211.096360] Starting subtest: mmap-offset-banned
[211.098716] Starting dynamic subtest: wb
[211.100902] Dynamic subtest wb: SUCCESS (0.000s)
[211.114402] Starting dynamic subtest: wc
[211.116311] Dynamic subtest wc: SUCCESS (0.000s)
[211.125487] Starting dynamic subtest: uc
[211.129737] Dynamic subtest uc: SUCCESS (0.000s)
[211.131660] Subtest mmap-offset-banned: SUCCESS (0.002s)
[211.222581] [058/133] (809s left) syncobj_timeline (wait-zero-handles)
[211.286300] Starting subtest: wait-zero-handles
[211.288504] Subtest wait-zero-handles: SUCCESS (0.000s)
[211.383550] [059/133] (809s left) gem_exec_balancer (full)
[211.438212] Starting subtest: full
[215.817140] Subtest full: SUCCESS (4.378s)
[216.144342] [060/133] (804s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[216.271570] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[225.420061] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (9.148s)
[226.238993] [061/133] (794s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[226.325453] Starting subtest: nonblocking-crc-frame-sequence
[226.327799] Starting dynamic subtest: pipe-A-eDP-1
[227.076849] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.750s)
[227.086648] Starting dynamic subtest: pipe-B-eDP-1
[228.513913] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.435s)
[228.524944] Starting dynamic subtest: pipe-C-eDP-1
[229.872678] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.360s)
[229.883457] Starting dynamic subtest: pipe-D-eDP-1
[231.269569] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.395s)
[231.271991] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.945s)
[232.078216] [062/133] (788s left) kms_async_flips (invalid-async-flip)
[232.171310] Starting subtest: invalid-async-flip
[232.545021] Starting dynamic subtest: pipe-A-eDP-1
[233.397341] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.853s)
[233.770119] Starting dynamic subtest: pipe-B-eDP-1
[234.548387] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.786s)
[234.909751] Starting dynamic subtest: pipe-C-eDP-1
[235.681073] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.778s)
[236.040327] Starting dynamic subtest: pipe-D-eDP-1
[236.809114] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.776s)
[236.811437] Subtest invalid-async-flip: SUCCESS (4.640s)
[237.961526] [063/133] (782s left) prime_self_import (export-vs-gem_close-race)
[238.001397] Starting subtest: export-vs-gem_close-race
[243.099230] Subtest export-vs-gem_close-race: SUCCESS (5.095s)
[243.172711] [064/133] (777s left) kms_psr (psr2-cursor-render)
[243.273267] Starting subtest: psr2-cursor-render
[243.275542] Starting dynamic subtest: eDP-1
[244.939511] Dynamic subtest eDP-1: SUCCESS (1.664s)
[244.941468] Subtest psr2-cursor-render: SUCCESS (1.666s)
[245.724287] [065/133] (774s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[245.837876] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[245.842392] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[245.953683] [066/133] (774s left) gem_mmap_wc (coherency)
[246.015351] Subtest coherency: SKIP (0.000s)
[246.079433] [067/133] (774s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[246.145811] Starting subtest: yf-tiled-ccs-to-y-tiled
[246.150344] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[246.334163] [068/133] (774s left) core_getclient (basic)
[246.395337] Starting subtest: basic
[246.397632] Subtest basic: SUCCESS (0.000s)
[246.489486] [069/133] (774s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[246.886663] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[247.722467] [070/133] (773s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[247.829808] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[249.064628] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: FAIL (0.643s)
[249.107293] [071/133] (771s left) perf_pmu (busy-accuracy-2)
[249.150452] Starting subtest: busy-accuracy-2
[249.152077] Starting dynamic subtest: rcs0
[252.195046] Dynamic subtest rcs0: SUCCESS (3.041s)
[252.206364] Starting dynamic subtest: bcs0
[255.250434] Dynamic subtest bcs0: SUCCESS (3.053s)
[255.261692] Starting dynamic subtest: vcs0
[258.300242] Dynamic subtest vcs0: SUCCESS (3.047s)
[258.311307] Starting dynamic subtest: vcs1
[261.344437] Dynamic subtest vcs1: SUCCESS (3.042s)
[261.355414] Starting dynamic subtest: vecs0
[264.392064] Dynamic subtest vecs0: SUCCESS (3.044s)
[264.403077] Starting dynamic subtest: ccs0
[267.450705] Dynamic subtest ccs0: SUCCESS (3.056s)
[267.453658] Subtest busy-accuracy-2: SUCCESS (18.298s)
[267.570957] [072/133] (753s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[267.675459] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[267.679582] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[267.766670] [073/133] (753s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[267.867905] Starting subtest: psr-rgb565-draw-blt
[274.989276] Subtest psr-rgb565-draw-blt: SUCCESS (7.124s)
[275.136168] [074/133] (745s left) syncobj_timeline (invalid-query-one-illegal-handle)
[275.192625] Starting subtest: invalid-query-one-illegal-handle
[275.194596] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s)
[275.292906] [075/133] (745s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[275.392963] Starting subtest: plane-lut1d-post-ctm3x4
[275.539059] Starting dynamic subtest: pipe-A-plane-0
[275.910698] Dynamic subtest pipe-A-plane-0: FAIL (0.198s)
[275.919052] Starting dynamic subtest: pipe-A-plane-1
[276.092926] Dynamic subtest pipe-A-plane-1: FAIL (0.165s)
[276.103093] Starting dynamic subtest: pipe-A-plane-2
[276.312954] Dynamic subtest pipe-A-plane-2: FAIL (0.177s)
[277.307912] Starting dynamic subtest: pipe-B-plane-0
[277.758052] Dynamic subtest pipe-B-plane-0: FAIL (0.175s)
[277.768726] Starting dynamic subtest: pipe-B-plane-1
[278.093433] Dynamic subtest pipe-B-plane-1: FAIL (0.177s)
[278.103104] Starting dynamic subtest: pipe-B-plane-2
[278.394804] Dynamic subtest pipe-B-plane-2: FAIL (0.177s)
[279.009691] Starting dynamic subtest: pipe-C-plane-0
[279.500844] Dynamic subtest pipe-C-plane-0: FAIL (0.140s)
[279.513527] Starting dynamic subtest: pipe-C-plane-1
[279.911643] Dynamic subtest pipe-C-plane-1: FAIL (0.166s)
[279.921934] Starting dynamic subtest: pipe-C-plane-2
[280.290851] Dynamic subtest pipe-C-plane-2: FAIL (0.635s)
[281.138260] Starting dynamic subtest: pipe-D-plane-0
[281.754582] Dynamic subtest pipe-D-plane-0: FAIL (0.151s)
[281.765611] Starting dynamic subtest: pipe-D-plane-1
[282.232553] Dynamic subtest pipe-D-plane-1: FAIL (0.627s)
[282.242805] Starting dynamic subtest: pipe-D-plane-2
[282.693033] Dynamic subtest pipe-D-plane-2: FAIL (0.570s)
[282.783189] Subtest plane-lut1d-post-ctm3x4: FAIL (7.391s)
[283.604655] [076/133] (737s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[283.709372] Starting subtest: primary-y-tiled-reflect-x-0
[283.780463] Subtest primary-y-tiled-reflect-x-0: SKIP (0.071s)
[283.882123] [077/133] (737s left) kms_addfb_basic (invalid-get-prop-any)
[283.944077] Starting subtest: invalid-get-prop-any
[283.946315] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[284.081152] [078/133] (737s left) gem_busy (semaphore)
[284.264112] Subtest semaphore: SKIP (0.000s)
[284.491719] [079/133] (736s left) kms_cursor_crc (cursor-sliding-256x85)
[284.742982] Starting subtest: cursor-sliding-256x85
[284.796657] Subtest cursor-sliding-256x85: SKIP (0.048s)
[284.960151] [080/133] (736s left) kms_selftest (drm_format)
[285.009088] Starting subtest: drm_format
[285.063957] Starting dynamic subtest: drm_test_format_block_width_invalid
[285.180225] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.114s)
[285.190579] Starting dynamic subtest: drm_test_format_block_width_one_plane
[285.274453] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.094s)
[285.284603] Starting dynamic subtest: drm_test_format_block_width_two_plane
[285.369446] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.095s)
[285.379965] Starting dynamic subtest: drm_test_format_block_width_three_plane
[285.475176] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.103s)
[285.485488] Starting dynamic subtest: drm_test_format_block_width_tiled
[285.576850] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.100s)
[285.585327] Starting dynamic subtest: drm_test_format_block_height_invalid
[285.685970] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.109s)
[285.695737] Starting dynamic subtest: drm_test_format_block_height_one_plane
[285.786126] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.098s)
[285.795440] Starting dynamic subtest: drm_test_format_block_height_two_plane
[285.878461] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.091s)
[285.888744] Starting dynamic subtest: drm_test_format_block_height_three_plane
[285.980185] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.102s)
[285.990594] Starting dynamic subtest: drm_test_format_block_height_tiled
[286.089984] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.108s)
[286.099171] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[286.201761] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.112s)
[286.212273] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[286.298347] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.094s)
[286.306525] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[286.396538] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.097s)
[286.406539] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[286.490287] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.094s)
[286.498317] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[286.593612] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.102s)
[286.603237] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[286.687833] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.093s)
[286.698593] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[286.782870] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.092s)
[286.798163] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[286.882017] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.097s)
[286.883659] Subtest drm_format: SUCCESS (1.871s)
[287.034942] [081/133] (734s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[287.139214] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[287.141277] Starting dynamic subtest: pipe-A-eDP-1
[287.158371] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[287.168757] Starting dynamic subtest: pipe-B-eDP-1
[287.184817] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[287.193603] Starting dynamic subtest: pipe-C-eDP-1
[287.209480] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[287.217864] Starting dynamic subtest: pipe-D-eDP-1
[287.234088] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[287.235880] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[289.371413] [082/133] (731s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[289.480587] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[289.485107] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[289.587541] [083/133] (731s left) kms_content_protection (dp-mst-type-1-suspend-resume)
[289.732420] Starting subtest: dp-mst-type-1-suspend-resume
[289.736956] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s)
[289.864676] [084/133] (731s left) i915_drm_fdinfo (memory-info-shared)
[289.904170] Starting subtest: memory-info-shared
[289.906571] Starting dynamic subtest: smem0
[289.961999] Dynamic subtest smem0: SUCCESS (0.058s)
[289.965025] Subtest memory-info-shared: SUCCESS (0.059s)
[290.047636] [085/133] (731s left) syncobj_basic (bad-destroy)
[290.108841] Starting subtest: bad-destroy
[290.111168] Subtest bad-destroy: SUCCESS (0.000s)
[290.225984] [086/133] (731s left) prime_mmap (test_refcounting)
[290.288619] Starting subtest: test_refcounting
[290.290627] Starting dynamic subtest: test_refcounting-smem
[290.318506] Dynamic subtest test_refcounting-smem: SUCCESS (0.033s)
[290.320532] Subtest test_refcounting: SUCCESS (0.034s)
[290.421367] [087/133] (731s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[290.514023] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[290.515935] Starting dynamic subtest: pipe-A-eDP-1
[290.613295] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s)
[290.624179] Starting dynamic subtest: pipe-B-eDP-1
[291.753966] Dynamic subtest pipe-B-eDP-1: SKIP (1.137s)
[291.758323] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.240s)
[292.943961] [088/133] (728s left) kms_hdr (static-toggle-dpms)
[293.045122] Starting subtest: static-toggle-dpms
[293.051623] Subtest static-toggle-dpms: SKIP (0.000s)
[293.117732] [089/133] (728s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[293.216358] Starting subtest: fbcpsr-tiling-4
[300.377312] Subtest fbcpsr-tiling-4: SUCCESS (7.164s)
[300.512202] [090/133] (721s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[300.606155] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[307.393405] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.789s)
[307.528467] [091/133] (714s left) kms_plane_multiple (tiling-y)
[307.614196] Starting subtest: tiling-y
[307.618539] Subtest tiling-y: SKIP (0.000s)
[307.687883] [092/133] (714s left) prime_mmap (test_invalid_sync_flags)
[307.747511] Starting subtest: test_invalid_sync_flags
[307.749844] Starting dynamic subtest: test_invalid_sync_flags-smem
[307.751830] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[307.753827] Subtest test_invalid_sync_flags: SUCCESS (0.001s)
[307.833623] [093/133] (713s left) gem_fence_thrash (bo-write-verify-threaded-none)
[307.871579] Starting subtest: bo-write-verify-threaded-none
[307.890974] Subtest bo-write-verify-threaded-none: SKIP (0.021s)
[307.958491] [094/133] (713s left) gem_ctx_shared (create-shared-gtt)
[308.023679] Starting subtest: create-shared-gtt
[310.176321] Subtest create-shared-gtt: SUCCESS (2.153s)
[310.547121] [095/133] (711s left) gem_userptr_blits (stress-mm-invalidate-close)
[310.621394] Starting subtest: stress-mm-invalidate-close
[312.767856] Subtest stress-mm-invalidate-close: SUCCESS (2.148s)
[312.901297] [096/133] (708s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[313.003210] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[313.015167] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.011s)
[313.089022] [097/133] (708s left) gem_mmap_offset (mmap-boundaries)
[313.145127] Starting subtest: mmap-boundaries
[313.147387] Starting dynamic subtest: smem0
[313.427921] Dynamic subtest smem0: SUCCESS (0.283s)
[313.431069] Subtest mmap-boundaries: SUCCESS (0.284s)
[313.574496] [098/133] (708s left) gem_exec_params (cliprects-invalid)
[313.631959] Starting subtest: cliprects-invalid
[313.634642] Subtest cliprects-invalid: SUCCESS (0.000s)
[313.737268] [099/133] (708s left) i915_pm_rps (fence-order)
[313.813329] Starting subtest: fence-order
[316.772518] Subtest fence-order: SUCCESS (2.956s)
[316.885722] [100/133] (705s left) kms_pm_dc (dc3co-vpb-simulation)
[318.003127] Starting subtest: dc3co-vpb-simulation
[326.864755] Subtest dc3co-vpb-simulation: SKIP (8.858s)
[326.984095] [101/133] (695s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[327.078157] Starting subtest: fbc-pr-sprite-mmap-cpu
[327.082678] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[327.165577] [102/133] (694s left) prime_vgem (basic-blt)
[327.284435] Starting subtest: basic-blt
[327.310409] Subtest basic-blt: SUCCESS (0.026s)
[327.427619] [FACT prime_vgem (basic-blt)] new: kernel.kmod_is_loaded.vgem: true
[327.430955] [103/133] (694s left) kms_pm_rpm (pc8-residency)
[329.062362] Starting subtest: pc8-residency
[329.067661] Subtest pc8-residency: SKIP (0.000s)
[329.743392] [104/133] (692s left) syncobj_wait (wait-any-interrupted)
[329.820457] Starting subtest: wait-any-interrupted
[329.923913] Subtest wait-any-interrupted: SUCCESS (0.104s)
[330.002727] [105/133] (692s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[330.097284] Starting subtest: psr-dirtyfb-ioctl
[330.099271] Starting dynamic subtest: A-eDP-1
[334.016254] Dynamic subtest A-eDP-1: SUCCESS (3.918s)
[334.018679] Subtest psr-dirtyfb-ioctl: SUCCESS (3.919s)
[334.818438] [106/133] (687s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[334.911295] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[334.915801] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[334.986750] [107/133] (687s left) gem_ctx_persistence (engines-hostile)
[335.045980] Starting subtest: engines-hostile
[335.048571] Starting dynamic subtest: rcs0
[335.128870] Dynamic subtest rcs0: SUCCESS (0.082s)
[335.144116] Starting dynamic subtest: bcs0
[335.220858] Dynamic subtest bcs0: SUCCESS (0.087s)
[335.232489] Starting dynamic subtest: vcs0
[335.312165] Dynamic subtest vcs0: SUCCESS (0.091s)
[335.323107] Starting dynamic subtest: vcs1
[335.390065] Dynamic subtest vcs1: SUCCESS (0.075s)
[335.401371] Starting dynamic subtest: vecs0
[335.515025] Dynamic subtest vecs0: SUCCESS (0.123s)
[335.527056] Starting dynamic subtest: ccs0
[335.621643] Dynamic subtest ccs0: SUCCESS (0.105s)
[335.624059] Subtest engines-hostile: SUCCESS (0.577s)
[335.706073] [108/133] (686s left) kms_addfb_basic (bad-pitch-999)
[335.762586] Starting subtest: bad-pitch-999
[335.764452] Subtest bad-pitch-999: SUCCESS (0.000s)
[335.915136] [109/133] (686s left) kms_plane (pixel-format-linear-modifier-source-clamping)
[336.014594] Starting subtest: pixel-format-linear-modifier-source-clamping
[336.041305] Starting dynamic subtest: pipe-A-plane-0
[339.508454] Dynamic subtest pipe-A-plane-0: SUCCESS (3.467s)
[339.519636] Starting dynamic subtest: pipe-A-plane-3
[341.174694] Dynamic subtest pipe-A-plane-3: SUCCESS (1.664s)
[342.309112] Starting dynamic subtest: pipe-B-plane-0
[345.918066] Dynamic subtest pipe-B-plane-0: SUCCESS (3.622s)
[345.928975] Starting dynamic subtest: pipe-B-plane-3
[347.586547] Dynamic subtest pipe-B-plane-3: SUCCESS (1.664s)
[347.901524] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (11.886s)
[348.785073] [110/133] (673s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[348.884166] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[348.886420] Starting dynamic subtest: pipe-A
[349.932594] Dynamic subtest pipe-A: SUCCESS (1.050s)
[349.952651] Starting dynamic subtest: pipe-B
[352.089783] Dynamic subtest pipe-B: SUCCESS (2.155s)
[352.099807] Starting dynamic subtest: pipe-C
[353.271711] Dynamic subtest pipe-C: SUCCESS (1.180s)
[353.281443] Starting dynamic subtest: pipe-D
[354.424952] Dynamic subtest pipe-D: SUCCESS (1.152s)
[354.427319] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.543s)
[355.622791] [111/133] (666s left) gem_ctx_exec (basic-invalid-context)
[355.677881] Starting subtest: basic-invalid-context
[355.682555] Subtest basic-invalid-context: SUCCESS (0.004s)
[355.798745] [112/133] (666s left) core_getversion (all-cards)
[355.840526] Starting subtest: all-cards
[355.847259] Subtest all-cards: SUCCESS (0.011s)
[355.893296] [113/133] (666s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[355.983338] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[355.987460] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[356.081484] [114/133] (666s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[356.178694] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[359.813294] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.640s)
[360.949822] [115/133] (661s left) syncobj_timeline (single-wait-available-signaled)
[360.997065] Starting subtest: single-wait-available-signaled
[360.999042] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[361.095852] [116/133] (661s left) gem_ctx_param (non-root-set)
[361.151813] Starting subtest: non-root-set
[361.168077] Subtest non-root-set: SUCCESS (0.016s)
[361.256253] [117/133] (661s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[361.350132] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[361.352408] Starting dynamic subtest: pipe-A-eDP-1
[361.375805] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[361.387052] Starting dynamic subtest: pipe-B-eDP-1
[361.408741] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[361.417131] Starting dynamic subtest: pipe-C-eDP-1
[361.438751] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[361.447230] Starting dynamic subtest: pipe-D-eDP-1
[361.469224] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[361.473255] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[363.523898] [118/133] (659s left) syncobj_wait (wait-for-submit-complex)
[363.580105] Starting subtest: wait-for-submit-complex
[363.641638] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[363.722389] [119/133] (659s left) gem_mmap_wc (write-gtt-read-wc)
[363.781572] Subtest write-gtt-read-wc: SKIP (0.000s)
[363.840359] [120/133] (659s left) gem_exec_fence (submit-chain)
[364.011908] Starting subtest: submit-chain
[364.029158] Subtest submit-chain: SUCCESS (0.018s)
[365.994341] [121/133] (656s left) gem_exec_schedule (wide)
[366.178721] Starting subtest: wide
[366.180832] Starting dynamic subtest: rcs0
[377.359949] Dynamic subtest rcs0: SUCCESS (11.180s)
[377.372793] Starting dynamic subtest: vcs0
[389.268796] Dynamic subtest vcs0: SUCCESS (11.907s)
[389.281468] Starting dynamic subtest: vcs1
[400.587713] Dynamic subtest vcs1: SUCCESS (11.317s)
[400.605167] Starting dynamic subtest: vecs0
[412.423083] Dynamic subtest vecs0: SUCCESS (11.834s)
[412.435070] Starting dynamic subtest: ccs0
[425.936297] Dynamic subtest ccs0: SUCCESS (13.511s)
[425.939012] Subtest wide: SUCCESS (59.755s)
[427.179738] [122/133] (595s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[427.238271] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[427.338945] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.101s)
[427.417598] [123/133] (595s left) kms_addfb_basic (unused-pitches)
[427.464888] Starting subtest: unused-pitches
[427.466983] Subtest unused-pitches: SUCCESS (0.000s)
[427.610685] [124/133] (595s left) i915_query (query-regions-sanity-check)
[427.665916] Starting subtest: query-regions-sanity-check
[427.676266] Subtest query-regions-sanity-check: SUCCESS (0.013s)
[427.790777] [125/133] (595s left) gem_sync (basic-store-all)
[427.861251] Starting subtest: basic-store-all
[430.530628] Subtest basic-store-all: SUCCESS (2.678s)
[430.714975] [126/133] (592s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[430.808746] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[437.367314] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.562s)
[437.470415] [127/133] (585s left) i915_hangman (engine-engine-hang)
[437.532075] Starting subtest: engine-engine-hang
[437.534438] Starting dynamic subtest: rcs0
[438.902592] Dynamic subtest rcs0: SUCCESS (1.369s)
[438.919668] Starting dynamic subtest: bcs0
[440.821427] Dynamic subtest bcs0: SUCCESS (1.916s)
[440.838945] Starting dynamic subtest: vcs0
[442.870084] Dynamic subtest vcs0: SUCCESS (2.046s)
[442.882127] Starting dynamic subtest: vcs1
[444.855073] Dynamic subtest vcs1: SUCCESS (1.982s)
[444.867733] Starting dynamic subtest: vecs0
[446.838075] Dynamic subtest vecs0: SUCCESS (1.980s)
[446.851380] Starting dynamic subtest: ccs0
[448.823532] Dynamic subtest ccs0: SUCCESS (1.982s)
[448.826526] Subtest engine-engine-hang: SUCCESS (11.291s)
[448.957652] [128/133] (574s left) kms_flip (2x-plain-flip)
[449.064838] Starting subtest: 2x-plain-flip
[449.085445] Subtest 2x-plain-flip: SKIP (0.023s)
[449.177132] [129/133] (574s left) gem_exec_fence (basic-busy)
[449.358054] Starting subtest: basic-busy
[449.360948] Starting dynamic subtest: rcs0
[449.429793] Dynamic subtest rcs0: SUCCESS (0.072s)
[449.441978] Starting dynamic subtest: bcs0
[449.488577] Dynamic subtest bcs0: SUCCESS (0.057s)
[449.500778] Starting dynamic subtest: vcs0
[449.541809] Dynamic subtest vcs0: SUCCESS (0.051s)
[449.551516] Starting dynamic subtest: vcs1
[449.595156] Dynamic subtest vcs1: SUCCESS (0.051s)
[449.605875] Starting dynamic subtest: vecs0
[449.652447] Dynamic subtest vecs0: SUCCESS (0.055s)
[449.664488] Starting dynamic subtest: ccs0
[449.720418] Dynamic subtest ccs0: SUCCESS (0.066s)
[449.722879] Subtest basic-busy: SUCCESS (0.365s)
[452.026902] [130/133] (571s left) kms_getfb (getfb2-handle-not-fb)
[452.130092] Starting subtest: getfb2-handle-not-fb
[452.132472] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[452.241921] [131/133] (571s left) kms_vblank (wait-busy-hang)
[452.332310] Starting subtest: wait-busy-hang
[452.334574] Starting dynamic subtest: pipe-A-eDP-1
[478.689399] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.354s)
[478.703941] Starting dynamic subtest: pipe-D-eDP-1
[503.649682] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.958s)
[503.652070] Subtest wait-busy-hang: SUCCESS (51.316s)
[504.491850] [132/133] (518s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[504.555079] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[504.624338] [133/133] (518s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[504.725762] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[511.775159] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.051s)
[511.886869] Closing watchdogs
results: parsing output: 0/ for test: kms_ccs
results: parsing output: 1/ for test: kms_psr
results: parsing output: 2/ for test: kms_flip_scaled_crc
results: parsing output: 3/ for test: kms_psr
results: parsing output: 4/ for test: gem_mmap_gtt
results: parsing output: 5/ for test: gem_exec_params
results: parsing output: 6/ for test: kms_addfb_basic
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_feature_discovery
results: parsing output: 10/ for test: kms_chamelium_edid
results: parsing output: 11/ for test: gem_linear_blits
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_lease
results: parsing output: 15/ for test: gem_ctx_shared
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: core_setmaster_vs_auth
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_cursor_crc
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_psr
results: parsing output: 22/ for test: gem_exec_whisper
results: parsing output: 23/ for test: kms_cursor_crc
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: gem_render_copy
results: parsing output: 26/ for test: kms_flip
results: parsing output: 27/ for test: kms_addfb_basic
results: parsing output: 28/ for test: gen9_exec_parse
results: parsing output: 29/ for test: api_intel_allocator
results: parsing output: 30/ for test: kms_prop_blob
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: prime_mmap
results: parsing output: 33/ for test: gem_lmem_swapping
results: parsing output: 34/ for test: kms_cursor_legacy
results: parsing output: 35/ for test: kms_psr
results: parsing output: 36/ for test: gem_pxp
results: parsing output: 37/ for test: gem_pipe_control_store_loop
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: syncobj_timeline
results: parsing output: 40/ for test: perf_pmu
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: gem_exec_parallel
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: prime_mmap_coherency
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: gem_exec_schedule
results: parsing output: 48/ for test: kms_flip_scaled_crc
results: parsing output: 49/ for test: kms_chamelium_audio
results: parsing output: 50/ for test: kms_addfb_basic
results: parsing output: 51/ for test: gem_exec_schedule
results: parsing output: 52/ for test: gem_spin_batch
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_userptr_blits
results: parsing output: 57/ for test: syncobj_timeline
results: parsing output: 58/ for test: gem_exec_balancer
results: parsing output: 59/ for test: kms_cursor_legacy
results: parsing output: 60/ for test: kms_pipe_crc_basic
results: parsing output: 61/ for test: kms_async_flips
results: parsing output: 62/ for test: prime_self_import
results: parsing output: 63/ for test: kms_psr
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: gem_mmap_wc
results: parsing output: 66/ for test: gem_render_copy
results: parsing output: 67/ for test: core_getclient
results: parsing output: 68/ for test: kms_chamelium_hpd
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: perf_pmu
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: syncobj_timeline
results: parsing output: 74/ for test: kms_color_pipeline
results: parsing output: 75/ for test: kms_rotation_crc
results: parsing output: 76/ for test: kms_addfb_basic
results: parsing output: 77/ for test: gem_busy
results: parsing output: 78/ for test: kms_cursor_crc
results: parsing output: 79/ for test: kms_selftest
results: parsing output: 80/ for test: kms_ccs
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_content_protection
results: parsing output: 83/ for test: i915_drm_fdinfo
results: parsing output: 84/ for test: syncobj_basic
results: parsing output: 85/ for test: prime_mmap
results: parsing output: 86/ for test: kms_psr2_sf
results: parsing output: 87/ for test: kms_hdr
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_plane_multiple
results: parsing output: 91/ for test: prime_mmap
results: parsing output: 92/ for test: gem_fence_thrash
results: parsing output: 93/ for test: gem_ctx_shared
results: parsing output: 94/ for test: gem_userptr_blits
results: parsing output: 95/ for test: kms_flip
results: parsing output: 96/ for test: gem_mmap_offset
results: parsing output: 97/ for test: gem_exec_params
results: parsing output: 98/ for test: i915_pm_rps
results: parsing output: 99/ for test: kms_pm_dc
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: prime_vgem
results: parsing output: 102/ for test: kms_pm_rpm
results: parsing output: 103/ for test: syncobj_wait
results: parsing output: 104/ for test: kms_dirtyfb
results: parsing output: 105/ for test: kms_plane
results: parsing output: 106/ for test: gem_ctx_persistence
results: parsing output: 107/ for test: kms_addfb_basic
results: parsing output: 108/ for test: kms_plane
results: parsing output: 109/ for test: kms_plane_scaling
results: parsing output: 110/ for test: gem_ctx_exec
results: parsing output: 111/ for test: core_getversion
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: syncobj_timeline
results: parsing output: 115/ for test: gem_ctx_param
results: parsing output: 116/ for test: kms_ccs
results: parsing output: 117/ for test: syncobj_wait
results: parsing output: 118/ for test: gem_mmap_wc
results: parsing output: 119/ for test: gem_exec_fence
results: parsing output: 120/ for test: gem_exec_schedule
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: kms_addfb_basic
results: parsing output: 123/ for test: i915_query
results: parsing output: 124/ for test: gem_sync
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: i915_hangman
results: parsing output: 127/ for test: kms_flip
results: parsing output: 128/ for test: gem_exec_fence
results: parsing output: 129/ for test: kms_getfb
results: parsing output: 130/ for test: kms_vblank
results: parsing output: 131/ for test: gem_exec_reloc
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.