[58.606842] Initializing watchdogs
[58.606894]   /dev/watchdog0
[58.620102] [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]
[58.624354] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.626466] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.629923] [001/131] (960s left) gem_blits (basic)
[58.699720] Starting subtest: basic
[60.914634] Subtest basic: SUCCESS (2.184s)
[61.048809] [002/131] (958s left) gem_exec_reloc (basic-scanout)
[61.115451] Subtest basic-scanout: SKIP (0.000s)
[61.181731] [003/131] (958s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[61.285005] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[61.289420] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[61.395833] [004/131] (957s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[61.496795] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[61.501471] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[61.587152] [005/131] (957s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[61.957639] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[62.800629] [006/131] (956s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[62.900225] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[62.903006] Starting dynamic subtest: pipe-A-default-mode
[63.192073] Dynamic subtest pipe-A-default-mode: SKIP (0.286s)
[63.197543] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.286s)
[64.051903] [007/131] (955s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[64.151290] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[64.156049] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[64.263567] [008/131] (955s left) kms_big_fb (linear-8bpp-rotate-0)
[64.363301] Starting subtest: linear-8bpp-rotate-0
[65.605137] Subtest linear-8bpp-rotate-0: SUCCESS (1.235s)
[65.791747] [009/131] (953s left) gem_vm_create (invalid-create)
[65.845400] Starting subtest: invalid-create
[65.847854] Subtest invalid-create: SUCCESS (0.002s)
[65.953972] [010/131] (953s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[66.048075] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[66.051864] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[66.142365] [011/131] (953s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[66.257209] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[66.260686] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[66.362932] [012/131] (953s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[66.450991] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[66.461557] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.010s)
[66.582602] [013/131] (952s left) kms_vblank (query-busy)
[66.680577] Starting subtest: query-busy
[66.682659] Starting dynamic subtest: pipe-A-eDP-1
[68.584745] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.894s)
[68.597024] Starting dynamic subtest: pipe-D-eDP-1
[71.148608] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.553s)
[71.151173] Subtest query-busy: SUCCESS (4.450s)
[71.953480] [014/131] (947s left) kms_plane_lowres (tiling-y)
[72.063049] Starting subtest: tiling-y
[72.067821] Subtest tiling-y: SKIP (0.000s)
[72.271061] [015/131] (947s left) prime_vgem (basic-fence-blt)
[72.400477] Starting subtest: basic-fence-blt
[72.482455] Subtest basic-fence-blt: SUCCESS (0.081s)
[72.622527] [FACT prime_vgem (basic-fence-blt)] new: kernel.kmod_is_loaded.vgem: true
[72.625344] [016/131] (947s left) kms_chamelium_hpd (dp-hpd-fast)
[73.004672] Subtest dp-hpd-fast: SKIP (0.000s)
[73.763515] [017/131] (945s left) gem_pread (bench)
[73.819453] Subtest bench: SKIP (0.000s)
[73.884223] [018/131] (945s left) kms_psr (fbc-psr2-primary-page-flip)
[73.975081] Starting subtest: fbc-psr2-primary-page-flip
[73.977219] Starting dynamic subtest: eDP-1
[73.981134] Dynamic subtest eDP-1: SKIP (0.000s)
[73.985135] Subtest fbc-psr2-primary-page-flip: SKIP (0.000s)
[74.043659] [019/131] (945s left) gem_fence_thrash (bo-write-verify-x)
[74.075597] Starting subtest: bo-write-verify-x
[74.099965] Subtest bo-write-verify-x: SKIP (0.020s)
[74.152733] [020/131] (945s left) gem_ctx_exec (basic-norecovery)
[74.200157] Starting subtest: basic-norecovery
[74.476085] Subtest basic-norecovery: SUCCESS (0.277s)
[74.599336] [021/131] (945s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[74.662159] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[74.737236] [022/131] (945s left) kms_feature_discovery (display-4x)
[74.828086] Starting subtest: display-4x
[74.831504] Subtest display-4x: SKIP (0.000s)
[74.894111] [023/131] (945s left) kms_flip (basic-flip-vs-wf_vblank)
[74.986887] Starting subtest: basic-flip-vs-wf_vblank
[74.988891] Starting dynamic subtest: A-eDP1
[76.937690] Dynamic subtest A-eDP1: SUCCESS (1.946s)
[76.947475] Starting dynamic subtest: B-eDP1
[78.863831] Dynamic subtest B-eDP1: SUCCESS (1.923s)
[78.873978] Starting dynamic subtest: C-eDP1
[80.775073] Dynamic subtest C-eDP1: SUCCESS (1.909s)
[80.783861] Starting dynamic subtest: D-eDP1
[82.698445] Dynamic subtest D-eDP1: SUCCESS (1.921s)
[82.700747] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.706s)
[83.914124] [024/131] (936s left) kms_async_flips (test-time-stamp-atomic)
[83.997094] Starting subtest: test-time-stamp-atomic
[84.370313] Starting dynamic subtest: pipe-A-eDP-1
[85.117519] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.745s)
[85.483092] Starting dynamic subtest: pipe-B-eDP-1
[86.240163] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.761s)
[86.604959] Starting dynamic subtest: pipe-C-eDP-1
[87.365738] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.765s)
[87.726941] Starting dynamic subtest: pipe-D-eDP-1
[88.488904] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.767s)
[88.491632] Subtest test-time-stamp-atomic: SUCCESS (4.485s)
[89.635106] [025/131] (930s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[89.727294] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[93.355031] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.630s)
[94.531287] [026/131] (925s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[94.589152] Starting subtest: etime-single-wait-for-submit-unsubmitted
[94.696870] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.107s)
[94.770109] [027/131] (925s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[94.874840] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[94.879431] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[94.982215] [028/131] (925s left) syncobj_timeline (invalid-signal-bad-pad)
[95.034045] Starting subtest: invalid-signal-bad-pad
[95.036283] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[95.136265] [029/131] (925s left) i915_pm_rpm (gem-execbuf)
[97.086287] Starting subtest: gem-execbuf
[97.089586] Starting dynamic subtest: smem0
[98.502389] Dynamic subtest smem0: SUCCESS (1.416s)
[98.504766] Subtest gem-execbuf: SUCCESS (1.416s)
[98.584679] [030/131] (921s left) gem_ctx_persistence (legacy-engines-queued)
[98.645648] Starting subtest: legacy-engines-queued
[98.648136] Starting dynamic subtest: render
[98.761921] Dynamic subtest render: SUCCESS (0.116s)
[98.770673] Starting dynamic subtest: bsd1
[99.893397] Dynamic subtest bsd1: SUCCESS (1.128s)
[99.902213] Starting dynamic subtest: bsd2
[101.875790] Dynamic subtest bsd2: SUCCESS (1.979s)
[101.885399] Starting dynamic subtest: blt
[101.960856] Dynamic subtest blt: SUCCESS (0.085s)
[101.970111] Starting dynamic subtest: vebox
[103.858646] Dynamic subtest vebox: SUCCESS (1.894s)
[103.861330] Subtest legacy-engines-queued: SUCCESS (5.209s)
[103.936260] [031/131] (916s left) sysfs_timeslice_duration (timeout)
[103.996446] Starting subtest: timeout
[103.998915] Starting dynamic subtest: vecs0
[113.966699] Dynamic subtest vecs0: SUCCESS (9.964s)
[113.976844] Starting dynamic subtest: ccs0
[115.282082] Dynamic subtest ccs0: SUCCESS (1.316s)
[115.289778] Starting dynamic subtest: vcs0
[124.888926] Dynamic subtest vcs0: SUCCESS (9.606s)
[124.899220] Starting dynamic subtest: bcs0
[125.550891] Dynamic subtest bcs0: SUCCESS (0.659s)
[125.561539] Starting dynamic subtest: rcs0
[126.806558] Dynamic subtest rcs0: SUCCESS (1.255s)
[126.820294] Starting dynamic subtest: vcs1
[135.912461] Dynamic subtest vcs1: SUCCESS (9.102s)
[135.915165] Subtest timeout: SUCCESS (31.905s)
[135.984113] [032/131] (884s left) gem_exec_schedule (u-submit-golden-slice)
[136.052806] Starting subtest: u-submit-golden-slice
[136.055196] Starting dynamic subtest: rcs0
[136.101747] Dynamic subtest rcs0: SUCCESS (0.057s)
[136.109795] Starting dynamic subtest: bcs0
[136.160799] Dynamic subtest bcs0: SUCCESS (0.058s)
[136.172359] Starting dynamic subtest: vcs0
[136.211746] Dynamic subtest vcs0: SUCCESS (0.052s)
[136.222314] Starting dynamic subtest: vcs1
[136.264954] Dynamic subtest vcs1: SUCCESS (0.053s)
[136.275078] Starting dynamic subtest: vecs0
[136.309022] Dynamic subtest vecs0: SUCCESS (0.044s)
[136.319248] Starting dynamic subtest: ccs0
[136.370998] Dynamic subtest ccs0: SUCCESS (0.061s)
[136.374054] Subtest u-submit-golden-slice: SUCCESS (0.327s)
[138.053452] [033/131] (882s left) api_intel_bb (misplaced-blitter)
[138.107250] Starting subtest: misplaced-blitter
[138.113320] Subtest misplaced-blitter: SUCCESS (0.009s)
[138.243205] [034/131] (882s left) fbdev (pan)
[138.277324] Starting subtest: pan
[138.306375] Subtest pan: SUCCESS (0.033s)
[138.378768] [035/131] (882s left) gem_ctx_persistence (heartbeat-hang)
[138.444803] Starting subtest: heartbeat-hang
[138.449391] Subtest heartbeat-hang: SKIP (0.000s)
[138.543245] [036/131] (881s left) syncobj_timeline (single-wait-all-available-signaled)
[138.600872] Starting subtest: single-wait-all-available-signaled
[138.603228] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[138.707853] [037/131] (881s left) kms_tv_load_detect (load-detect)
[138.772264] Subtest load-detect: SKIP (0.000s)
[138.842435] [038/131] (881s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[139.098754] Starting subtest: parallel-dmabuf-import-out-fence
[140.207514] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.089s)
[140.297539] [039/131] (880s left) perf (disabled-read-error)
[140.400708] Starting subtest: disabled-read-error
[140.426853] Subtest disabled-read-error: SUCCESS (0.028s)
[140.472770] [040/131] (880s left) gem_exec_schedule (preempt-other-chain)
[140.533783] Starting subtest: preempt-other-chain
[140.536209] Starting dynamic subtest: rcs0
[140.658363] Dynamic subtest rcs0: SUCCESS (0.129s)
[140.670155] Starting dynamic subtest: bcs0
[140.794118] Dynamic subtest bcs0: SUCCESS (0.135s)
[140.806035] Starting dynamic subtest: vcs0
[140.926492] Dynamic subtest vcs0: SUCCESS (0.132s)
[140.938633] Starting dynamic subtest: vcs1
[141.053413] Dynamic subtest vcs1: SUCCESS (0.127s)
[141.064255] Starting dynamic subtest: vecs0
[141.180590] Dynamic subtest vecs0: SUCCESS (0.128s)
[141.188519] Starting dynamic subtest: ccs0
[141.310026] Dynamic subtest ccs0: SUCCESS (0.128s)
[141.312505] Subtest preempt-other-chain: SUCCESS (0.781s)
[142.032824] [041/131] (878s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[142.149358] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[142.153877] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[142.253493] [042/131] (878s left) kms_setmode (invalid-clone-single-crtc)
[142.306072] Starting subtest: invalid-clone-single-crtc
[142.312835] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[142.410482] [043/131] (878s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[142.506182] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[142.508602] Starting dynamic subtest: pipe-A
[142.518292] Dynamic subtest pipe-A: SKIP (0.005s)
[142.527615] Starting dynamic subtest: pipe-B
[142.549890] Dynamic subtest pipe-B: SKIP (0.022s)
[142.558061] Starting dynamic subtest: pipe-C
[142.566726] Dynamic subtest pipe-C: SKIP (0.018s)
[142.574494] Starting dynamic subtest: pipe-D
[142.582179] Dynamic subtest pipe-D: SKIP (0.020s)
[142.586156] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.066s)
[142.660927] [044/131] (878s left) perf_pmu (module-unload)
[142.734200] Starting subtest: module-unload
[151.069974] Subtest module-unload: FAIL (8.226s)
[151.102949] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[151.103678] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[151.106948] [045/131] (869s left) perf (polling)
[152.556536] Starting subtest: polling
[152.558953] Starting dynamic subtest: 0-rcs0
[162.594398] Dynamic subtest 0-rcs0: SUCCESS (10.037s)
[162.604849] Starting dynamic subtest: 1-vcs0
[172.613425] Dynamic subtest 1-vcs0: SUCCESS (10.019s)
[172.616016] Subtest polling: SUCCESS (20.057s)
[172.653353] [FACT perf (polling)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[172.654527] [FACT perf (polling)] new: kernel.kmod_is_loaded.i915: true
[172.658278] [046/131] (848s left) kms_flip (flip-vs-rmfb)
[172.776298] Starting subtest: flip-vs-rmfb
[172.778493] Starting dynamic subtest: A-eDP1
[181.492369] Dynamic subtest A-eDP1: SUCCESS (8.716s)
[181.502158] Starting dynamic subtest: B-eDP1
[190.123551] Dynamic subtest B-eDP1: SUCCESS (8.630s)
[190.132953] Starting dynamic subtest: C-eDP1
[198.838789] Dynamic subtest C-eDP1: SUCCESS (8.715s)
[198.847579] Starting dynamic subtest: D-eDP1
[207.457335] Dynamic subtest D-eDP1: SUCCESS (8.617s)
[207.461879] Subtest flip-vs-rmfb: SUCCESS (34.684s)
[208.627114] [047/131] (812s left) kms_psr (psr-primary-blt)
[208.728486] Starting subtest: psr-primary-blt
[208.730859] Starting dynamic subtest: eDP-1
[210.527271] Dynamic subtest eDP-1: SUCCESS (1.798s)
[210.529469] Subtest psr-primary-blt: SUCCESS (1.799s)
[211.382659] [048/131] (809s left) i915_pm_rps (basic-api)
[211.442424] Starting subtest: basic-api
[211.446813] Subtest basic-api: SKIP (0.001s)
[211.522874] [049/131] (809s left) kms_addfb_basic (invalid-set-prop-any)
[211.570360] Starting subtest: invalid-set-prop-any
[211.572802] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[211.722352] [050/131] (809s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[211.821686] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[211.825844] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[211.936367] [051/131] (809s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[211.994685] Starting subtest: yf-tiled-to-vebox-x-tiled
[211.999756] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[212.173752] [052/131] (808s left) i915_selftest (perf)
[215.642726] Starting subtest: perf
[215.645366] Starting dynamic subtest: engine_cs
[220.057513] Dynamic subtest engine_cs: SUCCESS (4.414s)
[220.066723] Starting dynamic subtest: request
[227.395278] Dynamic subtest request: SUCCESS (7.336s)
[227.403875] Starting dynamic subtest: migrate
[231.800255] Dynamic subtest migrate: SUCCESS (4.402s)
[231.810112] Starting dynamic subtest: region
[237.748066] Dynamic subtest region: SUCCESS (5.946s)
[237.751060] Subtest perf: SUCCESS (22.105s)
[237.778340] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[237.779028] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[237.782222] [053/131] (783s left) kms_cursor_crc (cursor-size-hints)
[239.279169] Starting subtest: cursor-size-hints
[239.281499] Starting dynamic subtest: pipe-A-eDP-1
[239.934699] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.654s)
[239.943497] Starting dynamic subtest: pipe-D-eDP-1
[241.155429] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.218s)
[241.157783] Subtest cursor-size-hints: SUCCESS (1.874s)
[241.940879] [FACT kms_cursor_crc (cursor-size-hints)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[241.942068] [FACT kms_cursor_crc (cursor-size-hints)] new: kernel.kmod_is_loaded.i915: true
[241.945687] [054/131] (779s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[242.041747] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[242.045876] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[242.161233] [055/131] (779s left) syncobj_timeline (wait-all-complex)
[242.224221] Starting subtest: wait-all-complex
[242.435878] Subtest wait-all-complex: SUCCESS (0.213s)
[242.509335] [056/131] (778s left) gem_exec_reloc (basic-gtt-cpu-active)
[242.565905] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[242.624080] [057/131] (778s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[242.689541] Starting subtest: invalid-bsd1-flag-on-blt
[242.691929] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[242.804252] [058/131] (778s left) kms_pm_dc (dc5-psr)
[243.910027] Starting subtest: dc5-psr
[246.787961] Subtest dc5-psr: SUCCESS (2.878s)
[247.654507] [059/131] (773s left) gem_tiled_fence_blits (normal)
[247.714416] Subtest normal: SKIP (0.000s)
[247.790060] [060/131] (773s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[247.882323] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[247.886423] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[247.966163] [061/131] (773s left) i915_drm_fdinfo (virtual-idle)
[248.004890] Starting subtest: virtual-idle
[251.046042] Subtest virtual-idle: SUCCESS (3.040s)
[251.122019] [062/131] (770s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[251.235306] Starting subtest: y-tiled-8bpp-rotate-270
[251.239707] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[251.348762] [063/131] (770s left) kms_atomic_interruptible (universal-setplane-primary)
[251.445918] Starting subtest: universal-setplane-primary
[251.448317] Starting dynamic subtest: pipe-A-eDP-1
[258.853380] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.409s)
[258.855815] Subtest universal-setplane-primary: SUCCESS (7.410s)
[259.695914] [064/131] (761s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[259.744538] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[259.796232] [065/131] (761s left) kms_pipe_crc_basic (read-crc)
[259.881343] Starting subtest: read-crc
[259.883672] Starting dynamic subtest: pipe-A-eDP-1
[260.617490] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.733s)
[260.625859] Starting dynamic subtest: pipe-B-eDP-1
[261.978791] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.360s)
[261.986241] Starting dynamic subtest: pipe-C-eDP-1
[263.252714] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.272s)
[263.260345] Starting dynamic subtest: pipe-D-eDP-1
[264.591761] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.336s)
[264.593856] Subtest read-crc: SUCCESS (4.707s)
[265.406953] [066/131] (756s left) gem_userptr_blits (set-cache-level)
[265.472328] Starting subtest: set-cache-level
[265.476886] Subtest set-cache-level: SKIP (0.000s)
[265.617562] [067/131] (756s left) gem_reg_read (timestamp-monotonic)
[265.669315] Starting subtest: timestamp-monotonic
[269.729391] Subtest timestamp-monotonic: SUCCESS (4.059s)
[269.799761] [068/131] (751s left) gem_exec_whisper (basic-fds-all)
[269.854099] Starting subtest: basic-fds-all
[281.863500] Subtest basic-fds-all: SUCCESS (12.006s)
[282.041336] [069/131] (739s left) kms_dsc (dsc-basic)
[282.141059] Starting subtest: dsc-basic
[282.153743] Subtest dsc-basic: SKIP (0.000s)
[282.212688] [070/131] (739s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[282.300121] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[282.302440] Starting dynamic subtest: pipe-A-eDP-1
[282.327746] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[282.337427] Starting dynamic subtest: pipe-B-eDP-1
[282.361298] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[282.368985] Starting dynamic subtest: pipe-C-eDP-1
[282.392999] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[282.400843] Starting dynamic subtest: pipe-D-eDP-1
[282.425541] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[282.429677] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[284.458568] [071/131] (737s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[284.566195] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[284.570611] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[284.660311] [072/131] (737s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[289.701660] Starting subtest: pr-plane-move-sf-dmg-area
[289.706613] Subtest pr-plane-move-sf-dmg-area: SKIP (0.002s)
[290.565257] [073/131] (731s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[290.670274] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[290.672612] Starting dynamic subtest: pipe-A-eDP-1
[290.696262] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[290.704761] Starting dynamic subtest: pipe-B-eDP-1
[290.727969] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[290.737237] Starting dynamic subtest: pipe-C-eDP-1
[290.759239] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[290.766900] Starting dynamic subtest: pipe-D-eDP-1
[290.789513] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[290.794071] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.006s)
[292.811794] [074/131] (729s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[292.909143] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[292.911433] Starting dynamic subtest: pipe-A-eDP-1
[292.957099] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.047s)
[292.965890] Starting dynamic subtest: pipe-B-eDP-1
[293.004369] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.046s)
[293.012652] Starting dynamic subtest: pipe-C-eDP-1
[293.050477] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.045s)
[293.059361] Starting dynamic subtest: pipe-D-eDP-1
[293.097657] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.046s)
[293.099795] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.189s)
[295.358355] [075/131] (726s left) kms_invalid_mode (bad-vsync-end)
[295.443189] Starting subtest: bad-vsync-end
[295.445353] Starting dynamic subtest: pipe-A-eDP-1
[295.727446] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.282s)
[295.736892] Starting dynamic subtest: pipe-B-eDP-1
[295.739239] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[295.747085] Starting dynamic subtest: pipe-C-eDP-1
[295.749411] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[295.757061] Starting dynamic subtest: pipe-D-eDP-1
[295.759089] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[295.761059] Subtest bad-vsync-end: SUCCESS (0.287s)
[296.583465] [076/131] (725s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-cpu)
[296.672221] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-cpu
[303.314128] Subtest psr-1p-offscren-pri-indfb-draw-mmap-cpu: SUCCESS (6.644s)
[303.423831] [077/131] (718s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[303.547525] Starting subtest: 2x-cursor-vs-flip-atomic
[303.551899] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[303.689683] [078/131] (718s left) gem_exec_params (sol-reset-not-gen7)
[303.746663] Starting subtest: sol-reset-not-gen7
[303.752273] Subtest sol-reset-not-gen7: SUCCESS (0.003s)
[303.894962] [079/131] (718s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[303.988955] Starting subtest: 4-tiled-64bpp-rotate-0
[306.293632] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (2.306s)
[306.527476] [080/131] (715s left) gem_exec_suspend (basic-s3)
[306.589670] Starting subtest: basic-S3
[306.592320] Starting dynamic subtest: smem
[326.110167] Dynamic subtest smem: SUCCESS (6.212s)
[326.112972] Subtest basic-S3: SUCCESS (6.214s)
[326.298234] [081/131] (695s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[326.435644] Starting subtest: flip-vs-cursor-busy-crc-legacy
[327.266701] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.806s)
[328.079183] [082/131] (694s left) gem_exec_fence (basic-wait-all)
[328.139634] Starting subtest: basic-wait-all
[328.239497] Subtest basic-wait-all: SUCCESS (0.098s)
[330.264331] [083/131] (691s left) gem_exec_basic (basic)
[330.324278] Starting subtest: basic
[330.326796] Starting dynamic subtest: rcs0-smem
[330.329316] Dynamic subtest rcs0-smem: SUCCESS (0.004s)
[330.340173] Starting dynamic subtest: bcs0-smem
[330.342364] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[330.351245] Starting dynamic subtest: vcs0-smem
[330.353446] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[330.362199] Starting dynamic subtest: vcs1-smem
[330.364383] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[330.373260] Starting dynamic subtest: vecs0-smem
[330.375467] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[330.384831] Starting dynamic subtest: ccs0-smem
[330.387429] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[330.389921] Subtest basic: SUCCESS (0.015s)
[332.234959] [084/131] (690s left) kms_chamelium_edid (dp-mode-timings)
[332.642191] Subtest dp-mode-timings: SKIP (0.000s)
[333.489907] [085/131] (688s left) gem_lmem_swapping (verify-random)
[333.528641] Subtest verify-random: SKIP (0.000s)
[333.606465] [086/131] (688s left) gem_mmap_gtt (coherency)
[333.660965] Subtest coherency: SKIP (0.000s)
[333.709240] [087/131] (688s left) kms_psr (psr2-cursor-mmap-cpu)
[333.794622] Starting subtest: psr2-cursor-mmap-cpu
[333.796935] Starting dynamic subtest: eDP-1
[336.157925] Dynamic subtest eDP-1: FAIL (1.743s)
[336.160098] Subtest psr2-cursor-mmap-cpu: FAIL (1.744s)
[336.196946] [088/131] (686s left) gen9_exec_parse (secure-batches)
[336.263282] Subtest secure-batches: SKIP (0.000s)
[336.355556] [089/131] (686s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[336.454256] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[336.458449] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[336.556048] [090/131] (686s left) gem_flink_basic (basic)
[336.615254] Starting subtest: basic
[336.617220] Subtest basic: SUCCESS (0.000s)
[336.723024] [091/131] (685s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[336.818761] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[337.965713] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.138s)
[338.123926] [092/131] (684s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[338.232601] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[345.159509] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (6.895s)
[345.273490] [093/131] (677s left) kms_flip (2x-flip-vs-wf_vblank)
[345.367673] Starting subtest: 2x-flip-vs-wf_vblank
[345.378190] Subtest 2x-flip-vs-wf_vblank: SKIP (0.010s)
[345.489923] [094/131] (677s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[345.592702] Starting subtest: fbc-pr-sprite-mmap-cpu
[345.596767] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[345.661800] [095/131] (677s left) gem_eio (in-flight-internal-1us)
[345.879146] Starting subtest: in-flight-internal-1us
[347.251749] Subtest in-flight-internal-1us: SUCCESS (1.369s)
[347.402557] [096/131] (675s left) kms_plane_scaling (2x-scaler-multi-pipe)
[347.501687] Starting subtest: 2x-scaler-multi-pipe
[347.506185] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[347.605365] [097/131] (675s left) gem_exec_gttfill (multigpu-basic)
[347.774969] Starting subtest: multigpu-basic
[364.300739] Subtest multigpu-basic: SUCCESS (16.510s)
[364.350650] [098/131] (658s left) vgem_basic (dmabuf-fence)
[364.435739] Starting subtest: dmabuf-fence
[364.437748] Subtest dmabuf-fence: SUCCESS (0.000s)
[364.492788] [099/131] (658s left) perf_pmu (busy-double-start)
[364.533444] Starting subtest: busy-double-start
[364.535708] Starting dynamic subtest: rcs0
[368.181420] Dynamic subtest rcs0: FAIL (3.592s)
[368.191968] Starting dynamic subtest: bcs0
[371.696200] Dynamic subtest bcs0: SUCCESS (3.567s)
[371.706654] Starting dynamic subtest: vcs0
[375.698259] Dynamic subtest vcs0: SUCCESS (3.998s)
[375.711318] Starting dynamic subtest: vcs1
[379.722261] Dynamic subtest vcs1: SUCCESS (4.020s)
[379.734556] Starting dynamic subtest: vecs0
[383.715676] Dynamic subtest vecs0: SUCCESS (3.989s)
[383.726736] Starting dynamic subtest: ccs0
[387.354768] Dynamic subtest ccs0: FAIL (3.563s)
[387.357161] Subtest busy-double-start: FAIL (22.738s)
[387.403622] [100/131] (635s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[387.515001] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[387.519470] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[388.660108] [101/131] (634s left) kms_vblank (wait-forked-hang)
[388.760467] Starting subtest: wait-forked-hang
[388.762593] Starting dynamic subtest: pipe-A-eDP-1
[414.944117] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.166s)
[414.958856] Starting dynamic subtest: pipe-D-eDP-1
[429.920525] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.977s)
[429.922907] Subtest wait-forked-hang: SUCCESS (41.147s)
[430.719805] [102/131] (592s left) kms_cursor_crc (cursor-onscreen-256x256)
[430.978560] Starting subtest: cursor-onscreen-256x256
[430.983720] Starting dynamic subtest: pipe-A-eDP-1
[433.333623] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.349s)
[433.369093] Starting dynamic subtest: pipe-D-eDP-1
[436.307058] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.949s)
[436.309536] Subtest cursor-onscreen-256x256: SUCCESS (5.326s)
[437.167962] [103/131] (585s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[437.290744] Starting subtest: cursorB-vs-flipA-legacy
[437.295206] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[437.432174] [104/131] (585s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[437.536522] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[437.540656] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[437.633865] [105/131] (585s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[442.612458] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[442.620004] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.002s)
[443.469046] [106/131] (579s left) kms_psr (fbc-psr-primary-mmap-gtt)
[443.573769] Starting subtest: fbc-psr-primary-mmap-gtt
[443.576024] Starting dynamic subtest: eDP-1
[443.580516] Dynamic subtest eDP-1: SKIP (0.000s)
[443.584980] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[443.646984] [107/131] (579s left) kms_cursor_crc (cursor-offscreen-32x10)
[443.806794] Starting subtest: cursor-offscreen-32x10
[443.849820] Subtest cursor-offscreen-32x10: SKIP (0.038s)
[444.135494] [108/131] (579s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[444.236561] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[444.238682] Starting dynamic subtest: pipe-A-default-mode
[444.526289] Dynamic subtest pipe-A-default-mode: SKIP (0.285s)
[444.530752] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.286s)
[445.388742] [109/131] (577s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[445.479582] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[446.392102] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.914s)
[446.595230] [110/131] (576s left) kms_debugfs (display-on-read-all)
[446.692574] Starting subtest: display-on-read-all
[446.758926] Subtest display-on-read-all: SUCCESS (0.066s)
[446.919989] [111/131] (576s left) drm_read (fault-buffer)
[447.075133] Starting subtest: fault-buffer
[447.077633] Subtest fault-buffer: SUCCESS (0.000s)
[447.202885] [112/131] (576s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[447.309991] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[447.313291] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[447.420948] [113/131] (576s left) gen3_render_tiledy_blits
[447.558470] [114/131] (575s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[447.652026] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[447.653996] Starting dynamic subtest: pipe-A
[447.661869] Dynamic subtest pipe-A: SKIP (0.005s)
[447.672462] Starting dynamic subtest: pipe-B
[447.680274] Dynamic subtest pipe-B: SKIP (0.018s)
[447.689886] Starting dynamic subtest: pipe-C
[447.697883] Dynamic subtest pipe-C: SKIP (0.018s)
[447.707278] Starting dynamic subtest: pipe-D
[447.717867] Dynamic subtest pipe-D: SKIP (0.018s)
[447.721041] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.060s)
[447.834859] [115/131] (575s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[447.930611] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[447.934221] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[448.034894] [116/131] (575s left) gem_exec_params (rel-constants-invalid)
[448.096305] Starting subtest: rel-constants-invalid
[448.098337] Subtest rel-constants-invalid: SUCCESS (0.000s)
[448.200245] [117/131] (575s left) gem_mmap_wc (invalid-flags)
[448.255034] Subtest invalid-flags: SKIP (0.000s)
[448.315714] [118/131] (575s left) gem_mmap (bad-object)
[448.373294] Subtest bad-object: SKIP (0.000s)
[448.433201] [119/131] (575s left) gem_unref_active_buffers
[448.627895] [120/131] (575s left) gem_exec_balancer (bonded-pair)
[448.683198] Starting subtest: bonded-pair
[448.686559] Subtest bonded-pair: SKIP (0.000s)
[448.990241] [121/131] (574s left) core_getversion (all-cards)
[449.029083] Starting subtest: all-cards
[449.049829] Subtest all-cards: SUCCESS (0.025s)
[449.098573] [122/131] (574s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[449.157407] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[449.265104] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.106s)
[449.339997] [123/131] (574s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[449.447784] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[449.450053] Starting dynamic subtest: pipe-A-eDP-1
[449.473277] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[449.489527] Starting dynamic subtest: pipe-B-eDP-1
[449.511304] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[449.522520] Starting dynamic subtest: pipe-C-eDP-1
[449.543065] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[449.552610] Starting dynamic subtest: pipe-D-eDP-1
[449.575108] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[449.579582] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[451.638683] [124/131] (572s left) kms_legacy_colorkey (basic)
[451.724464] Starting subtest: basic
[451.726771] Starting dynamic subtest: pipe-A
[451.769992] Dynamic subtest pipe-A: SUCCESS (0.045s)
[451.782571] Starting dynamic subtest: pipe-B
[451.784835] Dynamic subtest pipe-B: SUCCESS (0.001s)
[451.794271] Starting dynamic subtest: pipe-C
[451.796247] Dynamic subtest pipe-C: SUCCESS (0.000s)
[451.805266] Starting dynamic subtest: pipe-D
[451.807254] Dynamic subtest pipe-D: SUCCESS (0.000s)
[451.809340] Subtest basic: SUCCESS (0.050s)
[451.845296] [125/131] (572s left) kms_flip (wf_vblank-ts-check-interruptible)
[451.948447] Starting subtest: wf_vblank-ts-check-interruptible
[451.950713] Starting dynamic subtest: A-eDP1
[460.884079] Dynamic subtest A-eDP1: SUCCESS (8.934s)
[460.896146] Starting dynamic subtest: B-eDP1
[469.804108] Dynamic subtest B-eDP1: SUCCESS (8.918s)
[469.813986] Starting dynamic subtest: C-eDP1
[478.713665] Dynamic subtest C-eDP1: SUCCESS (8.906s)
[478.723915] Starting dynamic subtest: D-eDP1
[487.643264] Dynamic subtest D-eDP1: SUCCESS (8.926s)
[487.645938] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.692s)
[488.763287] [126/131] (535s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[488.821928] Starting subtest: invalid-bsd1-flag-on-vebox
[488.824057] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[488.951880] [127/131] (535s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[489.001234] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[489.005270] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[489.185707] [128/131] (534s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[489.279560] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[495.965912] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (6.688s)
[496.076800] [129/131] (528s left) gem_pxp (create-regular-buffer)
[496.197678] Starting subtest: create-regular-buffer
[496.200211] Subtest create-regular-buffer: SUCCESS (0.000s)
[496.321660] [130/131] (527s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[501.327443] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[501.329768] Starting dynamic subtest: pipe-A-eDP-1
[502.119857] Dynamic subtest pipe-A-eDP-1: SKIP (0.787s)
[502.130120] Starting dynamic subtest: pipe-B-eDP-1
[503.244817] Dynamic subtest pipe-B-eDP-1: SKIP (1.123s)
[503.249502] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.914s)
[504.415613] [131/131] (519s left) kms_selftest (drm_format)
[504.456540] Starting subtest: drm_format
[504.490484] Starting dynamic subtest: drm_test_format_block_width_invalid
[504.641707] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.150s)
[504.653090] Starting dynamic subtest: drm_test_format_block_width_one_plane
[504.771783] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.127s)
[504.781687] Starting dynamic subtest: drm_test_format_block_width_two_plane
[504.902487] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.131s)
[504.911819] Starting dynamic subtest: drm_test_format_block_width_three_plane
[505.023561] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.120s)
[505.033531] Starting dynamic subtest: drm_test_format_block_width_tiled
[505.129928] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.106s)
[505.140788] Starting dynamic subtest: drm_test_format_block_height_invalid
[505.228352] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.099s)
[505.237930] Starting dynamic subtest: drm_test_format_block_height_one_plane
[505.340666] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.109s)
[505.351919] Starting dynamic subtest: drm_test_format_block_height_two_plane
[505.440629] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.100s)
[505.452135] Starting dynamic subtest: drm_test_format_block_height_three_plane
[505.539906] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.097s)
[505.551270] Starting dynamic subtest: drm_test_format_block_height_tiled
[505.640874] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.099s)
[505.651861] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[505.751751] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.110s)
[505.761884] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[505.843074] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.090s)
[505.852528] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[505.961062] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.117s)
[505.971949] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[506.062182] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.100s)
[506.071136] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[506.166311] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.103s)
[506.175589] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[506.272948] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.107s)
[506.281869] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[506.373099] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.098s)
[506.384255] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[506.472586] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.099s)
[506.474552] Subtest drm_format: SUCCESS (2.014s)
[506.632749] Closing watchdogs
results: parsing output: 0/ for test: gem_blits
results: parsing output: 1/ for test: gem_exec_reloc
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_chamelium_hpd
results: parsing output: 5/ for test: kms_flip_scaled_crc
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: gem_vm_create
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_flip
results: parsing output: 12/ for test: kms_vblank
results: parsing output: 13/ for test: kms_plane_lowres
results: parsing output: 14/ for test: prime_vgem
results: parsing output: 15/ for test: kms_chamelium_hpd
results: parsing output: 16/ for test: gem_pread
results: parsing output: 17/ for test: kms_psr
results: parsing output: 18/ for test: gem_fence_thrash
results: parsing output: 19/ for test: gem_ctx_exec
results: parsing output: 20/ for test: gem_exec_reloc
results: parsing output: 21/ for test: kms_feature_discovery
results: parsing output: 22/ for test: kms_flip
results: parsing output: 23/ for test: kms_async_flips
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: i915_pm_rpm
results: parsing output: 29/ for test: gem_ctx_persistence
results: parsing output: 30/ for test: sysfs_timeslice_duration
results: parsing output: 31/ for test: gem_exec_schedule
results: parsing output: 32/ for test: api_intel_bb
results: parsing output: 33/ for test: fbdev
results: parsing output: 34/ for test: gem_ctx_persistence
results: parsing output: 35/ for test: syncobj_timeline
results: parsing output: 36/ for test: kms_tv_load_detect
results: parsing output: 37/ for test: gem_exec_balancer
results: parsing output: 38/ for test: perf
results: parsing output: 39/ for test: gem_exec_schedule
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: kms_setmode
results: parsing output: 42/ for test: kms_plane_scaling
results: parsing output: 43/ for test: perf_pmu
results: parsing output: 44/ for test: perf
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: i915_pm_rps
results: parsing output: 48/ for test: kms_addfb_basic
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_render_copy
results: parsing output: 51/ for test: i915_selftest
results: parsing output: 52/ for test: kms_cursor_crc
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: gem_exec_reloc
results: parsing output: 56/ for test: gem_exec_params
results: parsing output: 57/ for test: kms_pm_dc
results: parsing output: 58/ for test: gem_tiled_fence_blits
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: i915_drm_fdinfo
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_atomic_interruptible
results: parsing output: 63/ for test: gem_mmap_gtt
results: parsing output: 64/ for test: kms_pipe_crc_basic
results: parsing output: 65/ for test: gem_userptr_blits
results: parsing output: 66/ for test: gem_reg_read
results: parsing output: 67/ for test: gem_exec_whisper
results: parsing output: 68/ for test: kms_dsc
results: parsing output: 69/ for test: kms_ccs
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: kms_psr2_sf
results: parsing output: 72/ for test: kms_ccs
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: kms_invalid_mode
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_cursor_legacy
results: parsing output: 77/ for test: gem_exec_params
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: gem_exec_suspend
results: parsing output: 80/ for test: kms_cursor_legacy
results: parsing output: 81/ for test: gem_exec_fence
results: parsing output: 82/ for test: gem_exec_basic
results: parsing output: 83/ for test: kms_chamelium_edid
results: parsing output: 84/ for test: gem_lmem_swapping
results: parsing output: 85/ for test: gem_mmap_gtt
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: gen9_exec_parse
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: gem_flink_basic
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_flip
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: gem_eio
results: parsing output: 95/ for test: kms_plane_scaling
results: parsing output: 96/ for test: gem_exec_gttfill
results: parsing output: 97/ for test: vgem_basic
results: parsing output: 98/ for test: perf_pmu
results: parsing output: 99/ for test: kms_ccs
results: parsing output: 100/ for test: kms_vblank
results: parsing output: 101/ for test: kms_cursor_crc
results: parsing output: 102/ for test: kms_cursor_legacy
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_psr2_sf
results: parsing output: 105/ for test: kms_psr
results: parsing output: 106/ for test: kms_cursor_crc
results: parsing output: 107/ for test: kms_flip_scaled_crc
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: kms_debugfs
results: parsing output: 110/ for test: drm_read
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: gen3_render_tiledy_blits
results: parsing output: 113/ for test: kms_plane_scaling
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: gem_exec_params
results: parsing output: 116/ for test: gem_mmap_wc
results: parsing output: 117/ for test: gem_mmap
results: parsing output: 118/ for test: gem_unref_active_buffers
results: parsing output: 119/ for test: gem_exec_balancer
results: parsing output: 120/ for test: core_getversion
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: kms_ccs
results: parsing output: 123/ for test: kms_legacy_colorkey
results: parsing output: 124/ for test: kms_flip
results: parsing output: 125/ for test: gem_exec_params
results: parsing output: 126/ for test: gem_render_copy
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: gem_pxp
results: parsing output: 129/ for test: kms_psr2_sf
results: parsing output: 130/ for test: kms_selftest
Done.