[57.377985] Initializing watchdogs
[57.378081]   /dev/watchdog0
[57.392071] [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.396257] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.398427] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.401787] [001/131] (960s left) kms_addfb_basic (unused-modifier)
[57.486046] Starting subtest: unused-modifier
[57.487883] Subtest unused-modifier: SUCCESS (0.000s)
[57.664364] [002/131] (960s left) prime_vgem (coherency-gtt)
[57.783410] Starting subtest: coherency-gtt
[57.788325] Subtest coherency-gtt: SKIP (0.000s)
[57.924380] [FACT prime_vgem (coherency-gtt)] new: kernel.kmod_is_loaded.vgem: true
[57.927313] [003/131] (960s left) gem_exec_balancer (parallel-bb-first)
[58.189254] Starting subtest: parallel-bb-first
[59.107879] Subtest parallel-bb-first: SUCCESS (0.924s)
[59.985235] [004/131] (958s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[60.099815] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[61.228902] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.134s)
[61.437399] [005/131] (956s left) perf_pmu (busy-idle-check-all)
[61.482325] Starting subtest: busy-idle-check-all
[61.484365] Starting dynamic subtest: rcs0
[62.153989] Dynamic subtest rcs0: SUCCESS (0.675s)
[62.164553] Starting dynamic subtest: bcs0
[62.805302] Dynamic subtest bcs0: SUCCESS (0.653s)
[62.816068] Starting dynamic subtest: vcs0
[63.895629] Dynamic subtest vcs0: SUCCESS (1.091s)
[63.906515] Starting dynamic subtest: vcs1
[65.943681] Dynamic subtest vcs1: SUCCESS (2.052s)
[65.956375] Starting dynamic subtest: vecs0
[67.863909] Dynamic subtest vecs0: SUCCESS (1.922s)
[67.876151] Starting dynamic subtest: ccs0
[68.520284] Dynamic subtest ccs0: SUCCESS (0.657s)
[68.522761] Subtest busy-idle-check-all: SUCCESS (7.057s)
[68.636576] [006/131] (949s left) gem_userptr_blits (coherency-sync)
[68.701864] Starting subtest: coherency-sync
[69.021062] Subtest coherency-sync: SKIP (0.281s)
[69.170685] [007/131] (948s left) gem_exec_fence (parallel)
[69.406609] Starting subtest: parallel
[69.408561] Starting dynamic subtest: rcs0
[71.554281] Dynamic subtest rcs0: SUCCESS (2.154s)
[71.564797] Starting dynamic subtest: bcs0
[73.705183] Dynamic subtest bcs0: SUCCESS (2.152s)
[73.715502] Starting dynamic subtest: vcs0
[75.856303] Dynamic subtest vcs0: SUCCESS (2.152s)
[75.866464] Starting dynamic subtest: vcs1
[78.010019] Dynamic subtest vcs1: SUCCESS (2.154s)
[78.020234] Starting dynamic subtest: vecs0
[80.160682] Dynamic subtest vecs0: SUCCESS (2.151s)
[80.171138] Starting dynamic subtest: ccs0
[82.313588] Dynamic subtest ccs0: SUCCESS (2.153s)
[82.315511] Subtest parallel: SUCCESS (12.918s)
[83.044647] [008/131] (935s left) gem_exec_reloc (basic-write-read-active)
[83.109689] Subtest basic-write-read-active: SKIP (0.000s)
[83.173567] [009/131] (935s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[83.287074] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[83.291114] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[83.392387] [010/131] (934s left) gem_busy (parallel)
[83.587318] Starting subtest: parallel
[83.589600] Starting dynamic subtest: rcs0
[84.889487] Dynamic subtest rcs0: SUCCESS (1.300s)
[84.899982] Starting dynamic subtest: bcs0
[86.935786] Dynamic subtest bcs0: SUCCESS (2.045s)
[86.947275] Starting dynamic subtest: vcs0
[88.920962] Dynamic subtest vcs0: SUCCESS (1.983s)
[88.932081] Starting dynamic subtest: vcs1
[90.903865] Dynamic subtest vcs1: SUCCESS (1.983s)
[90.915625] Starting dynamic subtest: vecs0
[92.889043] Dynamic subtest vecs0: SUCCESS (1.984s)
[92.901550] Starting dynamic subtest: ccs0
[94.935572] Dynamic subtest ccs0: SUCCESS (2.046s)
[94.938107] Subtest parallel: SUCCESS (11.347s)
[95.204634] [011/131] (923s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[95.328274] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[102.030107] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.706s)
[102.170909] [012/131] (916s left) kms_mmap_write_crc (main)
[102.278599] Starting subtest: main
[102.280999] Starting dynamic subtest: pipe-A-eDP-1
[105.950776] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.670s)
[105.952784] Subtest main: SUCCESS (3.671s)
[106.797142] [013/131] (911s left) syncobj_wait (invalid-reset-bad-pad)
[106.861115] Starting subtest: invalid-reset-bad-pad
[106.863088] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[106.994505] [014/131] (911s left) gem_exec_reloc (basic-scanout)
[107.063854] Subtest basic-scanout: SKIP (0.000s)
[107.135963] [015/131] (911s left) kms_rotation_crc (primary-rotation-180)
[107.237145] Starting subtest: primary-rotation-180
[114.315456] Subtest primary-rotation-180: SUCCESS (7.078s)
[115.543738] [016/131] (902s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[115.662717] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[116.742141] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.080s)
[116.908537] [017/131] (901s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[117.010958] Starting subtest: fbc-rgb565-draw-pwrite
[121.555993] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.547s)
[122.744840] [018/131] (895s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[122.842169] Starting subtest: plane-upscale-20x20-with-modifiers
[122.844544] Starting dynamic subtest: pipe-A
[123.177460] Dynamic subtest pipe-A: SUCCESS (0.338s)
[123.186549] Starting dynamic subtest: pipe-B
[124.602369] Dynamic subtest pipe-B: SUCCESS (1.424s)
[124.612237] Starting dynamic subtest: pipe-C
[126.037585] Dynamic subtest pipe-C: SUCCESS (1.435s)
[126.047611] Starting dynamic subtest: pipe-D
[127.500080] Dynamic subtest pipe-D: SUCCESS (1.462s)
[127.502429] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.661s)
[128.673273] [019/131] (889s left) kms_addfb_basic (tile-pitch-mismatch)
[128.736264] Starting subtest: tile-pitch-mismatch
[128.740656] Subtest tile-pitch-mismatch: SKIP (0.000s)
[128.899403] [020/131] (889s left) kms_getfb (getfb-reject-nv12)
[129.004066] Starting subtest: getfb-reject-nv12
[129.006360] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[129.141995] [021/131] (889s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[129.240268] Starting subtest: psr-2p-primscrn-spr-indfb-move
[129.244223] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[129.356684] [022/131] (889s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[129.463840] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc
[136.079520] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.620s)
[136.255132] [023/131] (882s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[136.369835] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[139.982065] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.617s)
[141.185784] [024/131] (877s left) kms_big_fb (linear-32bpp-rotate-270)
[141.294503] Starting subtest: linear-32bpp-rotate-270
[141.314824] Subtest linear-32bpp-rotate-270: SKIP (0.020s)
[141.475466] [025/131] (877s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[141.576159] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[141.578538] Starting dynamic subtest: pipe-A-eDP-1
[141.598804] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[141.609651] Starting dynamic subtest: pipe-B-eDP-1
[141.628417] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[141.636667] Starting dynamic subtest: pipe-C-eDP-1
[141.656052] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[141.664764] Starting dynamic subtest: pipe-D-eDP-1
[141.684824] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[141.686807] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.007s)
[143.838255] [026/131] (875s left) kms_vrr (max-min)
[143.941282] Starting subtest: max-min
[143.947976] Subtest max-min: SKIP (0.000s)
[144.038931] [027/131] (874s left) gem_tiled_partial_pwrite_pread (writes)
[144.099298] Subtest writes: SKIP (0.000s)
[144.166228] [028/131] (874s left) kms_plane_alpha_blend (constant-alpha-min)
[144.264108] Starting subtest: constant-alpha-min
[144.546798] Starting dynamic subtest: pipe-A-eDP-1
[145.270329] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.721s)
[145.279775] Starting dynamic subtest: pipe-D-eDP-1
[146.770561] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.498s)
[146.772750] Subtest constant-alpha-min: SUCCESS (2.506s)
[147.596412] [029/131] (871s left) kms_pm_lpsp (kms-lpsp)
[148.695356] Starting subtest: kms-lpsp
[148.697611] Starting dynamic subtest: pipe-A-eDP-1
[148.843088] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.151s)
[149.137376] Subtest kms-lpsp: SUCCESS (0.444s)
[150.020662] [030/131] (869s left) i915_drm_fdinfo (most-busy-idle-check-all)
[150.058052] Starting subtest: most-busy-idle-check-all
[150.060796] Starting dynamic subtest: rcs0
[150.065851] Dynamic subtest rcs0: SKIP (0.003s)
[150.076530] Starting dynamic subtest: bcs0
[150.081258] Dynamic subtest bcs0: SKIP (0.000s)
[150.091198] Starting dynamic subtest: vcs0
[150.095576] Dynamic subtest vcs0: SKIP (0.000s)
[150.104085] Starting dynamic subtest: vcs1
[150.108315] Dynamic subtest vcs1: SKIP (0.000s)
[150.116760] Starting dynamic subtest: vecs0
[150.121223] Dynamic subtest vecs0: SKIP (0.000s)
[150.129662] Starting dynamic subtest: ccs0
[150.134061] Dynamic subtest ccs0: SKIP (0.000s)
[150.138331] Subtest most-busy-idle-check-all: SKIP (0.008s)
[150.174351] [031/131] (868s left) gem_exec_params (invalid-fence-in)
[150.236165] Starting subtest: invalid-fence-in
[150.238530] Subtest invalid-fence-in: SUCCESS (0.000s)
[150.375344] [032/131] (868s left) kms_universal_plane (universal-plane-pageflip-windowed)
[150.484038] Starting subtest: universal-plane-pageflip-windowed
[150.486381] Starting dynamic subtest: pipe-A-eDP-1
[151.070234] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.588s)
[151.080794] Starting dynamic subtest: pipe-B-eDP-1
[152.325407] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.253s)
[152.335433] Starting dynamic subtest: pipe-C-eDP-1
[153.527103] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.198s)
[153.536910] Starting dynamic subtest: pipe-D-eDP-1
[154.764470] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.236s)
[154.766697] Subtest universal-plane-pageflip-windowed: SUCCESS (4.281s)
[155.635267] [033/131] (863s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[160.574582] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[160.576936] Starting dynamic subtest: pipe-A-eDP-1
[167.193710] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.619s)
[167.206758] Starting dynamic subtest: pipe-B-eDP-1
[173.778171] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.579s)
[173.780513] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (13.203s)
[174.676358] [034/131] (844s left) kms_cursor_crc (cursor-sliding-512x170)
[174.969051] Starting subtest: cursor-sliding-512x170
[174.973587] Subtest cursor-sliding-512x170: SKIP (0.001s)
[175.162925] [035/131] (844s left) gem_exec_reloc (basic-range-active)
[175.235621] Subtest basic-range-active: SKIP (0.000s)
[175.311089] [036/131] (844s left) gem_exec_flush (basic-wb-rw-before-default)
[175.381412] Starting subtest: basic-wb-rw-before-default
[180.835638] Subtest basic-wb-rw-before-default: SUCCESS (5.454s)
[181.061645] [037/131] (838s left) gem_mmap_offset (partial-unmap)
[181.135750] Starting subtest: partial-unmap
[181.138194] Starting dynamic subtest: smem0
[181.630213] Dynamic subtest smem0: SUCCESS (0.492s)
[181.632573] Subtest partial-unmap: SUCCESS (0.493s)
[181.792904] [038/131] (837s left) kms_properties (get_properties-sanity-atomic)
[181.896973] Starting subtest: get_properties-sanity-atomic
[181.899266] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[181.999878] [039/131] (837s left) kms_psr (psr2-sprite-plane-move)
[182.108793] Starting subtest: psr2-sprite-plane-move
[182.111022] Starting dynamic subtest: eDP-1
[183.879048] Dynamic subtest eDP-1: SUCCESS (1.771s)
[183.881232] Subtest psr2-sprite-plane-move: SUCCESS (1.773s)
[184.744751] [040/131] (834s left) gen9_exec_parse (bb-large)
[184.806535] Subtest bb-large: SKIP (0.000s)
[184.888169] [041/131] (834s left) kms_psr (pr-cursor-plane-move)
[184.987261] Starting subtest: pr-cursor-plane-move
[184.991500] Subtest pr-cursor-plane-move: SKIP (0.000s)
[185.086022] [042/131] (834s left) kms_cursor_crc (cursor-offscreen-32x10)
[185.270874] Starting subtest: cursor-offscreen-32x10
[185.315291] Subtest cursor-offscreen-32x10: SKIP (0.043s)
[185.628989] [043/131] (834s left) kms_feature_discovery (display-4x)
[185.730137] Starting subtest: display-4x
[185.733730] Subtest display-4x: SKIP (0.000s)
[185.825262] [044/131] (833s left) i915_pm_rpm (gem-execbuf)
[188.049441] Starting subtest: gem-execbuf
[188.051922] Starting dynamic subtest: smem0
[189.788751] Dynamic subtest smem0: SUCCESS (1.737s)
[189.791122] Subtest gem-execbuf: SUCCESS (1.738s)
[189.903596] [045/131] (829s left) kms_dsc (dsc-with-bpc-formats)
[190.007061] Starting subtest: dsc-with-bpc-formats
[190.117222] Subtest dsc-with-bpc-formats: SKIP (0.004s)
[190.169818] [046/131] (829s left) gem_userptr_blits (set-cache-level)
[190.244087] Starting subtest: set-cache-level
[190.248124] Subtest set-cache-level: SKIP (0.000s)
[190.404825] [047/131] (829s left) gem_ccs (large-ctrl-surf-copy)
[190.463586] Starting subtest: large-ctrl-surf-copy
[190.468139] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[190.612199] [048/131] (829s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[190.720413] Starting subtest: 4-tiled-8bpp-rotate-0
[191.912512] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.191s)
[192.059826] [049/131] (827s left) syncobj_wait (single-wait-all-for-submit-signaled)
[192.126062] Starting subtest: single-wait-all-for-submit-signaled
[192.127889] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[192.242655] [050/131] (827s left) kms_pm_rpm (system-suspend-modeset)
[194.074841] Starting subtest: system-suspend-modeset
[214.436658] Subtest system-suspend-modeset: SUCCESS (8.428s)
[214.836411] [051/131] (805s left) kms_psr (fbc-psr2-primary-page-flip)
[214.962519] Starting subtest: fbc-psr2-primary-page-flip
[214.964726] Starting dynamic subtest: eDP-1
[214.968707] Dynamic subtest eDP-1: SKIP (0.000s)
[214.972792] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[215.058469] [052/131] (804s left) gem_pwrite_snooped
[215.214349] [053/131] (804s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[215.303268] Starting subtest: primary-yf-tiled-reflect-x-90
[215.307601] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[215.398681] [054/131] (804s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[215.502110] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[215.504002] Starting dynamic subtest: pipe-A-default-mode
[215.836578] Dynamic subtest pipe-A-default-mode: SKIP (0.335s)
[215.840985] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.339s)
[216.622672] [055/131] (803s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[216.710768] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[216.712902] Starting dynamic subtest: pipe-A-eDP-1
[217.459557] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.753s)
[217.470692] Starting dynamic subtest: pipe-B-eDP-1
[219.343544] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.903s)
[219.354867] Starting dynamic subtest: pipe-C-eDP-1
[221.108570] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.781s)
[221.120078] Starting dynamic subtest: pipe-D-eDP-1
[222.927931] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.831s)
[222.929894] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.276s)
[224.073187] [056/131] (796s left) device_reset (cold-reset-bound)
[224.124976] Starting subtest: cold-reset-bound
[224.129657] Subtest cold-reset-bound: SKIP (0.000s)
[224.221611] [057/131] (795s left) tools_test (tools_test)
[224.282454] Starting subtest: tools_test
[224.332199] Subtest tools_test: SUCCESS (0.066s)
[224.417466] [058/131] (795s left) syncobj_wait (single-wait-signaled)
[224.484899] Starting subtest: single-wait-signaled
[224.487180] Subtest single-wait-signaled: SUCCESS (0.000s)
[224.620692] [059/131] (795s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[224.710302] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[224.712641] Starting dynamic subtest: pipe-A-default-mode
[225.013365] Dynamic subtest pipe-A-default-mode: SKIP (0.302s)
[225.017891] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.303s)
[225.897319] [060/131] (794s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[226.007414] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[226.011468] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[226.147884] [061/131] (794s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[226.250729] Starting subtest: fbc-rgb565-draw-render
[230.501948] Subtest fbc-rgb565-draw-render: SUCCESS (4.270s)
[231.670618] [062/131] (788s left) gem_mmap_gtt (big-bo-tiledx)
[231.734317] Subtest big-bo-tiledX: SKIP (0.000s)
[231.804292] [063/131] (788s left) gem_gpgpu_fill (offset-16x16)
[231.870064] Starting subtest: offset-16x16
[231.876442] Subtest offset-16x16: SUCCESS (0.009s)
[232.063765] [064/131] (788s left) gem_exec_schedule (preempt-queue-contexts-chain)
[232.142462] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[232.462920] [065/131] (788s left) kms_lease (implicit-plane-lease)
[232.567334] Starting subtest: implicit-plane-lease
[232.569603] Subtest implicit-plane-lease: SUCCESS (0.003s)
[232.706622] [066/131] (787s left) gem_spin_batch (resubmit-new)
[232.790844] Starting subtest: resubmit-new
[232.793225] Starting dynamic subtest: rcs0
[232.799635] Dynamic subtest rcs0: SUCCESS (0.009s)
[232.810583] Starting dynamic subtest: bcs0
[232.812878] Dynamic subtest bcs0: SUCCESS (0.004s)
[232.822500] Starting dynamic subtest: vcs0
[232.824798] Dynamic subtest vcs0: SUCCESS (0.005s)
[232.834257] Starting dynamic subtest: vcs1
[232.836158] Dynamic subtest vcs1: SUCCESS (0.005s)
[232.845302] Starting dynamic subtest: vecs0
[232.847156] Dynamic subtest vecs0: SUCCESS (0.005s)
[232.856257] Starting dynamic subtest: ccs0
[232.858128] Dynamic subtest ccs0: SUCCESS (0.004s)
[232.860049] Subtest resubmit-new: SUCCESS (0.035s)
[233.956061] [067/131] (786s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[234.068356] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[234.070652] Starting dynamic subtest: pipe-A-eDP-1
[234.127073] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[234.141290] Starting dynamic subtest: pipe-B-eDP-1
[234.200933] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[234.213281] Starting dynamic subtest: pipe-C-eDP-1
[234.272033] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[234.283324] Starting dynamic subtest: pipe-D-eDP-1
[234.339645] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[234.344334] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[236.331417] [068/131] (784s left) kms_hdr (static-toggle-suspend)
[236.434043] Starting subtest: static-toggle-suspend
[236.441557] Subtest static-toggle-suspend: SKIP (0.000s)
[236.532404] [069/131] (784s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[236.646977] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[236.651551] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.001s)
[236.819053] [070/131] (783s left) kms_atomic_interruptible (atomic-setmode)
[236.916295] Starting subtest: atomic-setmode
[236.918502] Starting dynamic subtest: pipe-A-eDP-1
[243.813486] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.903s)
[243.815853] Subtest atomic-setmode: SUCCESS (6.905s)
[244.717866] [071/131] (776s left) gem_ctx_persistence (legacy-engines-hang)
[244.791667] Starting subtest: legacy-engines-hang
[244.794027] Starting dynamic subtest: render
[244.963602] Dynamic subtest render: SUCCESS (0.170s)
[244.976405] Starting dynamic subtest: bsd1
[245.087263] Dynamic subtest bsd1: SUCCESS (0.121s)
[245.100134] Starting dynamic subtest: bsd2
[245.206311] Dynamic subtest bsd2: SUCCESS (0.116s)
[245.219087] Starting dynamic subtest: blt
[245.319463] Dynamic subtest blt: SUCCESS (0.110s)
[245.331511] Starting dynamic subtest: vebox
[245.433135] Dynamic subtest vebox: SUCCESS (0.111s)
[245.435944] Subtest legacy-engines-hang: SUCCESS (0.643s)
[245.541234] [072/131] (775s left) kms_chamelium_hpd (dp-hpd)
[245.941393] Subtest dp-hpd: SKIP (0.000s)
[246.719790] [073/131] (774s left) i915_pciid
[246.890403] [074/131] (774s left) kms_display_modes (extended-mode-basic)
[246.983337] Starting subtest: extended-mode-basic
[246.987306] Subtest extended-mode-basic: SKIP (0.000s)
[247.034407] [075/131] (773s left) kms_properties (colorop-properties-legacy)
[247.131292] Starting subtest: colorop-properties-legacy
[247.133464] Starting dynamic subtest: pipe-A-eDP-1
[247.470106] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.334s)
[247.480092] Starting dynamic subtest: pipe-B-eDP-1
[248.510863] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.044s)
[248.521216] Starting dynamic subtest: pipe-C-eDP-1
[249.554086] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.044s)
[249.564545] Starting dynamic subtest: pipe-D-eDP-1
[250.582730] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.026s)
[250.585151] Subtest colorop-properties-legacy: SUCCESS (3.453s)
[251.410470] [076/131] (769s left) gem_exec_balancer (indices)
[251.484646] Starting subtest: indices
[253.829647] Subtest indices: SUCCESS (2.343s)
[254.174547] [077/131] (766s left) sw_sync (sync_busy_fork_unixsocket)
[254.212659] Starting subtest: sync_busy_fork_unixsocket
[254.218324] Subtest sync_busy_fork_unixsocket: SUCCESS (0.007s)
[254.306067] [078/131] (766s left) syncobj_timeline (multi-wait-available-signaled)
[254.359291] Starting subtest: multi-wait-available-signaled
[254.361535] Subtest multi-wait-available-signaled: SUCCESS (0.000s)
[254.495375] [079/131] (766s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[254.568472] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[254.642073] [080/131] (766s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[254.749802] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[258.516047] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.770s)
[259.706570] [081/131] (761s left) kms_flip (basic-plain-flip)
[259.809632] Starting subtest: basic-plain-flip
[259.811909] Starting dynamic subtest: A-eDP1
[261.471398] Dynamic subtest A-eDP1: SUCCESS (1.663s)
[261.481873] Starting dynamic subtest: B-eDP1
[263.123183] Dynamic subtest B-eDP1: SUCCESS (1.651s)
[263.135302] Starting dynamic subtest: C-eDP1
[264.839340] Dynamic subtest C-eDP1: SUCCESS (1.715s)
[264.852433] Starting dynamic subtest: D-eDP1
[266.470257] Dynamic subtest D-eDP1: SUCCESS (1.630s)
[266.475323] Subtest basic-plain-flip: SUCCESS (6.670s)
[267.745678] [082/131] (753s left) prime_mmap_coherency (write)
[267.809035] Starting subtest: write
[273.181323] Subtest write: SUCCESS (5.372s)
[273.363750] [083/131] (747s left) kms_atomic (test-only)
[273.460297] Starting subtest: test-only
[273.505339] Starting dynamic subtest: pipe-A-eDP-1
[276.003494] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[276.005675] Subtest test-only: SUCCESS (2.544s)
[276.828512] [084/131] (744s left) gem_pxp (hw-rejects-pxp-context)
[276.961627] Starting subtest: hw-rejects-pxp-context
[276.966280] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[277.111638] [085/131] (744s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[277.217919] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[277.222329] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[277.365992] [086/131] (744s left) gem_partial_pwrite_pread (reads-display)
[277.437092] Subtest reads-display: SKIP (0.000s)
[277.524631] [087/131] (743s left) api_intel_allocator (simple-allocator)
[277.582574] Starting subtest: simple-allocator
[277.584905] Starting dynamic subtest: basic
[277.587258] Dynamic subtest basic: SUCCESS (0.003s)
[277.604430] Starting dynamic subtest: parallel-one
[277.772523] Dynamic subtest parallel-one: SUCCESS (0.187s)
[277.783755] Starting dynamic subtest: print
[277.786125] Dynamic subtest print: SUCCESS (0.000s)
[277.796282] Starting dynamic subtest: reuse
[277.798277] Dynamic subtest reuse: SUCCESS (0.000s)
[277.807538] Starting dynamic subtest: reserve
[277.809526] Dynamic subtest reserve: SUCCESS (0.000s)
[277.818600] Starting dynamic subtest: fork-reopen-allocator
[277.820490] Dynamic subtest fork-reopen-allocator: SUCCESS (0.016s)
[277.822331] Subtest simple-allocator: SUCCESS (0.211s)
[277.942735] [088/131] (743s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[278.046932] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[278.051377] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[278.181433] [089/131] (743s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[283.183394] Starting subtest: pr-cursor-plane-move-continuous-sf
[283.187988] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.002s)
[284.069739] [090/131] (737s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[284.174218] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[290.721980] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.553s)
[290.881342] [091/131] (730s left) gem_exec_whisper (basic-forked-all)
[290.942892] Starting subtest: basic-forked-all
[303.420201] Subtest basic-forked-all: SUCCESS (12.480s)
[303.629493] [092/131] (718s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[303.738139] Starting subtest: fbc-psr-sprite-mmap-cpu
[303.740441] Starting dynamic subtest: eDP-1
[303.744474] Dynamic subtest eDP-1: SKIP (0.000s)
[303.748532] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.001s)
[303.839677] [093/131] (717s left) kms_concurrent (multi-plane-atomic-lowres)
[303.936088] Starting subtest: multi-plane-atomic-lowres
[303.938417] Starting dynamic subtest: pipe-A-eDP-1
[304.439970] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.503s)
[304.442358] Subtest multi-plane-atomic-lowres: SUCCESS (0.505s)
[305.314354] [094/131] (716s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[305.377943] Starting subtest: multi-wait-for-submit-submitted-signaled
[305.380251] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[305.502600] [095/131] (716s left) kms_psr (psr-primary-page-flip)
[305.600464] Starting subtest: psr-primary-page-flip
[305.602737] Starting dynamic subtest: eDP-1
[307.305516] Dynamic subtest eDP-1: SUCCESS (1.703s)
[307.307796] Subtest psr-primary-page-flip: SUCCESS (1.705s)
[308.190089] [096/131] (713s left) gem_exec_schedule (independent)
[308.256089] Starting subtest: independent
[308.258401] Starting dynamic subtest: rcs0
[309.863492] Dynamic subtest rcs0: SUCCESS (1.615s)
[309.876181] Starting dynamic subtest: vcs0
[311.940564] Dynamic subtest vcs0: SUCCESS (2.074s)
[311.953306] Starting dynamic subtest: vcs1
[313.930666] Dynamic subtest vcs1: SUCCESS (1.986s)
[313.944026] Starting dynamic subtest: vecs0
[315.891561] Dynamic subtest vecs0: SUCCESS (1.958s)
[315.914376] Starting dynamic subtest: ccs0
[317.862845] Dynamic subtest ccs0: SUCCESS (1.967s)
[317.865834] Subtest independent: SUCCESS (9.612s)
[318.187029] [097/131] (703s left) kms_pwrite_crc
[319.822989] [098/131] (702s left) gem_mmap_gtt (cpuset-medium-copy)
[319.890792] Subtest cpuset-medium-copy: SKIP (0.000s)
[319.965682] [099/131] (702s left) sysfs_heartbeat_interval (nopreempt)
[320.028229] Starting subtest: nopreempt
[320.030577] Starting dynamic subtest: vecs0
[329.918638] Dynamic subtest vecs0: SUCCESS (9.887s)
[329.932134] Starting dynamic subtest: ccs0
[333.962900] Dynamic subtest ccs0: SUCCESS (4.041s)
[333.973942] Starting dynamic subtest: vcs0
[342.906998] Dynamic subtest vcs0: SUCCESS (8.939s)
[342.918273] Starting dynamic subtest: bcs0
[346.877055] Dynamic subtest bcs0: SUCCESS (3.970s)
[346.890437] Starting dynamic subtest: rcs0
[350.959204] Dynamic subtest rcs0: SUCCESS (4.081s)
[350.971893] Starting dynamic subtest: vcs1
[360.898995] Dynamic subtest vcs1: SUCCESS (9.937s)
[360.901647] Subtest nopreempt: SUCCESS (40.866s)
[361.002133] [100/131] (661s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[361.125782] Starting subtest: y-tiled-8bpp-rotate-270
[361.130110] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[361.236934] [101/131] (660s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[361.328143] Starting subtest: bad-pixel-format-yf-tiled-ccs
[361.330307] Starting dynamic subtest: pipe-A-eDP-1
[361.352664] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[361.363699] Starting dynamic subtest: pipe-B-eDP-1
[361.385543] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[361.397437] Starting dynamic subtest: pipe-C-eDP-1
[361.419019] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[361.430269] Starting dynamic subtest: pipe-D-eDP-1
[361.451726] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[361.455735] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.005s)
[363.586009] [102/131] (658s left) syncobj_timeline (wait-for-submit-snapshot)
[363.637179] Starting subtest: wait-for-submit-snapshot
[363.717289] Subtest wait-for-submit-snapshot: SUCCESS (0.081s)
[363.815742] [103/131] (658s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[363.877505] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[363.986790] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.108s)
[364.104773] [104/131] (658s left) kms_cursor_crc (cursor-onscreen-max-size)
[364.431920] Starting subtest: cursor-onscreen-max-size
[364.438473] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[364.585530] [105/131] (657s left) gem_exec_params (batch-first)
[364.650978] Starting subtest: batch-first
[364.656947] Subtest batch-first: SUCCESS (0.006s)
[364.812233] [106/131] (657s left) gem_ctx_shared (q-out-order)
[364.877091] Starting subtest: Q-out-order
[364.879383] Starting dynamic subtest: rcs0
[364.992680] Dynamic subtest rcs0: SUCCESS (0.113s)
[365.006133] Starting dynamic subtest: vcs0
[365.083889] Dynamic subtest vcs0: SUCCESS (0.092s)
[365.100398] Starting dynamic subtest: vcs1
[365.164588] Dynamic subtest vcs1: SUCCESS (0.080s)
[365.181921] Starting dynamic subtest: vecs0
[365.242762] Dynamic subtest vecs0: SUCCESS (0.077s)
[365.260530] Starting dynamic subtest: ccs0
[365.333865] Dynamic subtest ccs0: SUCCESS (0.090s)
[365.336418] Subtest Q-out-order: SUCCESS (0.456s)
[366.999361] [107/131] (655s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[367.106385] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[371.654553] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (4.551s)
[372.796641] [108/131] (649s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[372.907784] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[372.912051] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[373.040232] [109/131] (649s left) gem_mmap (pf-nonblock)
[373.102004] Subtest pf-nonblock: SKIP (0.000s)
[373.173371] [110/131] (649s left) kms_busy (basic-hang)
[373.269548] Starting subtest: basic-hang
[373.271813] Starting dynamic subtest: flip-pipe-A
[373.877530] Dynamic subtest flip-pipe-A: SUCCESS (0.609s)
[373.890302] Starting dynamic subtest: modeset-pipe-A
[377.528288] Dynamic subtest modeset-pipe-A: SUCCESS (3.649s)
[377.539183] Starting dynamic subtest: flip-pipe-D
[378.734147] Dynamic subtest flip-pipe-D: SUCCESS (1.205s)
[378.745186] Starting dynamic subtest: modeset-pipe-D
[382.157530] Dynamic subtest modeset-pipe-D: SUCCESS (3.420s)
[382.159855] Subtest basic-hang: SUCCESS (8.890s)
[382.978524] [111/131] (639s left) kms_flip (busy-flip)
[383.086577] Starting subtest: busy-flip
[383.088804] Starting dynamic subtest: A-eDP1
[384.777292] Dynamic subtest A-eDP1: SUCCESS (1.693s)
[384.789764] Starting dynamic subtest: B-eDP1
[386.409026] Dynamic subtest B-eDP1: SUCCESS (1.631s)
[386.420961] Starting dynamic subtest: C-eDP1
[388.037036] Dynamic subtest C-eDP1: SUCCESS (1.627s)
[388.047673] Starting dynamic subtest: D-eDP1
[389.672343] Dynamic subtest D-eDP1: SUCCESS (1.635s)
[389.674666] Subtest busy-flip: SUCCESS (6.593s)
[390.858282] [112/131] (631s left) gem_ctx_persistence (engines-mixed)
[390.915727] Starting subtest: engines-mixed
[390.918071] Starting dynamic subtest: rcs0
[391.011995] Dynamic subtest rcs0: SUCCESS (0.096s)
[391.025271] Starting dynamic subtest: bcs0
[391.089147] Dynamic subtest bcs0: SUCCESS (0.075s)
[391.102303] Starting dynamic subtest: vcs0
[391.121720] Dynamic subtest vcs0: SUCCESS (0.031s)
[391.132987] Starting dynamic subtest: vcs1
[391.207548] Dynamic subtest vcs1: SUCCESS (0.084s)
[391.220486] Starting dynamic subtest: vecs0
[391.270628] Dynamic subtest vecs0: SUCCESS (0.061s)
[391.285063] Starting dynamic subtest: ccs0
[391.342444] Dynamic subtest ccs0: SUCCESS (0.070s)
[391.345087] Subtest engines-mixed: SUCCESS (0.427s)
[391.446803] [113/131] (631s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted)
[391.510519] Starting subtest: invalid-multi-wait-all-unsubmitted
[391.512427] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[391.652003] [114/131] (631s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[391.754107] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[398.525632] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.776s)
[398.686550] [115/131] (624s left) gem_workarounds (reset-context)
[398.753299] Starting subtest: reset-context
[398.945153] Subtest reset-context: SUCCESS (0.192s)
[399.125229] [116/131] (623s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[399.234329] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[399.620948] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[402.561232] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.939s)
[402.574212] Starting dynamic subtest: pipe-A-eDP-1-4
[404.735847] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.174s)
[404.748658] Starting dynamic subtest: pipe-A-eDP-1-4
[406.744640] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s)
[406.755376] Starting dynamic subtest: pipe-A-eDP-1-x
[408.934643] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.189s)
[409.298950] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[412.076154] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.787s)
[412.086534] Starting dynamic subtest: pipe-B-eDP-1-4
[414.273686] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.196s)
[414.286078] Starting dynamic subtest: pipe-B-eDP-1-4
[416.282561] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[416.295525] Starting dynamic subtest: pipe-B-eDP-1-x
[418.472908] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[418.844921] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[421.602895] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.767s)
[421.616540] Starting dynamic subtest: pipe-C-eDP-1-4
[423.776898] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s)
[423.790114] Starting dynamic subtest: pipe-C-eDP-1-4
[425.786271] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[425.798624] Starting dynamic subtest: pipe-C-eDP-1-x
[427.964290] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[428.327969] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[431.127840] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.809s)
[431.140669] Starting dynamic subtest: pipe-D-eDP-1-4
[433.313309] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.185s)
[433.326428] Starting dynamic subtest: pipe-D-eDP-1-4
[435.322742] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[435.335313] Starting dynamic subtest: pipe-D-eDP-1-x
[437.501855] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.177s)
[437.504785] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.277s)
[438.737924] [117/131] (584s left) gem_exec_params (invalid-ring)
[438.794764] Starting subtest: invalid-ring
[438.797156] Subtest invalid-ring: SUCCESS (0.000s)
[438.926719] [118/131] (583s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[439.032125] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[446.040389] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.008s)
[446.224054] [119/131] (576s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[446.336813] Starting subtest: fbc-modesetfrombusy
[450.173049] Subtest fbc-modesetfrombusy: SUCCESS (3.840s)
[451.365824] [120/131] (571s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[451.453205] Starting subtest: blocking-absolute-wf_vblank-interruptible
[451.455619] Starting dynamic subtest: A-eDP1
[460.179474] Dynamic subtest A-eDP1: SUCCESS (8.722s)
[460.193393] Starting dynamic subtest: B-eDP1
[468.907876] Dynamic subtest B-eDP1: SUCCESS (8.724s)
[468.924197] Starting dynamic subtest: C-eDP1
[477.630073] Dynamic subtest C-eDP1: SUCCESS (8.718s)
[477.643520] Starting dynamic subtest: D-eDP1
[486.361558] Dynamic subtest D-eDP1: SUCCESS (8.730s)
[486.366962] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.905s)
[487.604702] [121/131] (535s left) kms_plane_scaling (invalid-parameters)
[487.713201] Starting subtest: invalid-parameters
[487.715551] Starting dynamic subtest: less-than-1-height-src
[487.724402] Dynamic subtest less-than-1-height-src: SUCCESS (0.013s)
[487.735128] Starting dynamic subtest: less-than-1-width-src
[487.737418] Dynamic subtest less-than-1-width-src: SUCCESS (0.013s)
[487.739604] Subtest invalid-parameters: SUCCESS (0.028s)
[487.887065] [122/131] (535s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[487.985090] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[487.987358] Starting dynamic subtest: pipe-A-eDP-1
[488.846206] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.855s)
[488.862028] Starting dynamic subtest: pipe-B-eDP-1
[490.481266] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.629s)
[490.493392] Starting dynamic subtest: pipe-C-eDP-1
[491.998061] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.517s)
[492.008758] Starting dynamic subtest: pipe-D-eDP-1
[493.517017] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.516s)
[493.519293] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.525s)
[494.701199] [123/131] (528s left) i915_query (query-topology-garbage-items)
[494.765949] Starting subtest: query-topology-garbage-items
[494.768105] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[494.888678] [124/131] (528s left) prime_vgem (wait)
[494.975306] Starting subtest: wait
[494.977224] Starting dynamic subtest: rcs0
[495.039047] Dynamic subtest rcs0: SUCCESS (0.065s)
[495.049861] Starting dynamic subtest: bcs0
[495.133087] Dynamic subtest bcs0: SUCCESS (0.093s)
[495.143749] Starting dynamic subtest: vcs0
[495.173345] Dynamic subtest vcs0: SUCCESS (0.039s)
[495.183867] Starting dynamic subtest: vcs1
[495.220001] Dynamic subtest vcs1: SUCCESS (0.046s)
[495.230344] Starting dynamic subtest: vecs0
[495.267512] Dynamic subtest vecs0: SUCCESS (0.047s)
[495.278004] Starting dynamic subtest: ccs0
[495.314726] Dynamic subtest ccs0: SUCCESS (0.046s)
[495.316830] Subtest wait: SUCCESS (0.342s)
[495.477689] [125/131] (527s left) gem_render_copy (y-tiled-to-vebox-linear)
[495.535340] Starting subtest: y-tiled-to-vebox-linear
[495.539494] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[495.744987] [126/131] (527s left) kms_vblank (crtc-id)
[495.840318] Starting subtest: crtc-id
[495.842472] Starting dynamic subtest: pipe-A-eDP-1
[496.293708] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.452s)
[496.309169] Starting dynamic subtest: pipe-D-eDP-1
[497.411644] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.116s)
[497.413831] Subtest crtc-id: SUCCESS (1.572s)
[498.256911] [127/131] (525s left) kms_atomic_transition (plane-all-transition-nonblocking)
[498.356142] Starting subtest: plane-all-transition-nonblocking
[498.358286] Starting dynamic subtest: pipe-A-eDP-1
[500.850270] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[501.163798] Starting dynamic subtest: pipe-B-eDP-1
[504.360177] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.207s)
[504.678361] Subtest plane-all-transition-nonblocking: SUCCESS (6.321s)
[505.518557] [128/131] (517s left) gem_mmap_wc (write-read-distinct)
[505.587550] Subtest write-read-distinct: SKIP (0.000s)
[505.652338] [129/131] (517s left) perf_pmu (render-node-busy-idle)
[505.736713] Starting subtest: render-node-busy-idle
[505.739262] Starting dynamic subtest: rcs0
[506.451720] Dynamic subtest rcs0: SUCCESS (0.715s)
[506.464743] Starting dynamic subtest: bcs0
[507.119675] Dynamic subtest bcs0: SUCCESS (0.666s)
[507.132689] Starting dynamic subtest: vcs0
[508.903339] Dynamic subtest vcs0: SUCCESS (1.779s)
[508.916596] Starting dynamic subtest: vcs1
[510.887358] Dynamic subtest vcs1: SUCCESS (1.981s)
[510.900870] Starting dynamic subtest: vecs0
[512.872577] Dynamic subtest vecs0: SUCCESS (1.982s)
[512.886125] Starting dynamic subtest: ccs0
[513.548440] Dynamic subtest ccs0: SUCCESS (0.675s)
[513.550958] Subtest render-node-busy-idle: SUCCESS (7.813s)
[513.652351] [130/131] (509s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[514.058908] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[514.910805] [131/131] (508s left) core_debugfs (read-all-entries)
[514.963555] Starting subtest: read-all-entries
[515.057636] Subtest read-all-entries: SUCCESS (0.094s)
[515.148125] Closing watchdogs
results: parsing output: 0/ for test: kms_addfb_basic
results: parsing output: 1/ for test: prime_vgem
results: parsing output: 2/ for test: gem_exec_balancer
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: perf_pmu
results: parsing output: 5/ for test: gem_userptr_blits
results: parsing output: 6/ for test: gem_exec_fence
results: parsing output: 7/ for test: gem_exec_reloc
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_busy
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_mmap_write_crc
results: parsing output: 12/ for test: syncobj_wait
results: parsing output: 13/ for test: gem_exec_reloc
results: parsing output: 14/ for test: kms_rotation_crc
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_plane_scaling
results: parsing output: 18/ for test: kms_addfb_basic
results: parsing output: 19/ for test: kms_getfb
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: kms_vrr
results: parsing output: 26/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 27/ for test: kms_plane_alpha_blend
results: parsing output: 28/ for test: kms_pm_lpsp
results: parsing output: 29/ for test: i915_drm_fdinfo
results: parsing output: 30/ for test: gem_exec_params
results: parsing output: 31/ for test: kms_universal_plane
results: parsing output: 32/ for test: kms_psr2_sf
results: parsing output: 33/ for test: kms_cursor_crc
results: parsing output: 34/ for test: gem_exec_reloc
results: parsing output: 35/ for test: gem_exec_flush
results: parsing output: 36/ for test: gem_mmap_offset
results: parsing output: 37/ for test: kms_properties
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: gen9_exec_parse
results: parsing output: 40/ for test: kms_psr
results: parsing output: 41/ for test: kms_cursor_crc
results: parsing output: 42/ for test: kms_feature_discovery
results: parsing output: 43/ for test: i915_pm_rpm
results: parsing output: 44/ for test: kms_dsc
results: parsing output: 45/ for test: gem_userptr_blits
results: parsing output: 46/ for test: gem_ccs
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: syncobj_wait
results: parsing output: 49/ for test: kms_pm_rpm
results: parsing output: 50/ for test: kms_psr
results: parsing output: 51/ for test: gem_pwrite_snooped
results: parsing output: 52/ for test: kms_rotation_crc
results: parsing output: 53/ for test: kms_flip_scaled_crc
results: parsing output: 54/ for test: kms_ccs
results: parsing output: 55/ for test: device_reset
results: parsing output: 56/ for test: tools_test
results: parsing output: 57/ for test: syncobj_wait
results: parsing output: 58/ for test: kms_flip_scaled_crc
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: gem_mmap_gtt
results: parsing output: 62/ for test: gem_gpgpu_fill
results: parsing output: 63/ for test: gem_exec_schedule
results: parsing output: 64/ for test: kms_lease
results: parsing output: 65/ for test: gem_spin_batch
results: parsing output: 66/ for test: kms_ccs
results: parsing output: 67/ for test: kms_hdr
results: parsing output: 68/ for test: kms_cursor_legacy
results: parsing output: 69/ for test: kms_atomic_interruptible
results: parsing output: 70/ for test: gem_ctx_persistence
results: parsing output: 71/ for test: kms_chamelium_hpd
results: parsing output: 72/ for test: i915_pciid
results: parsing output: 73/ for test: kms_display_modes
results: parsing output: 74/ for test: kms_properties
results: parsing output: 75/ for test: gem_exec_balancer
results: parsing output: 76/ for test: sw_sync
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: gem_mmap_wc
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: prime_mmap_coherency
results: parsing output: 82/ for test: kms_atomic
results: parsing output: 83/ for test: gem_pxp
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: gem_partial_pwrite_pread
results: parsing output: 86/ for test: api_intel_allocator
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_psr2_sf
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: gem_exec_whisper
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: kms_concurrent
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: gem_exec_schedule
results: parsing output: 96/ for test: kms_pwrite_crc
results: parsing output: 97/ for test: gem_mmap_gtt
results: parsing output: 98/ for test: sysfs_heartbeat_interval
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_ccs
results: parsing output: 101/ for test: syncobj_timeline
results: parsing output: 102/ for test: syncobj_timeline
results: parsing output: 103/ for test: kms_cursor_crc
results: parsing output: 104/ for test: gem_exec_params
results: parsing output: 105/ for test: gem_ctx_shared
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: gem_mmap
results: parsing output: 109/ for test: kms_busy
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: gem_ctx_persistence
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_workarounds
results: parsing output: 115/ for test: kms_async_flips
results: parsing output: 116/ for test: gem_exec_params
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_flip
results: parsing output: 120/ for test: kms_plane_scaling
results: parsing output: 121/ for test: kms_ccs
results: parsing output: 122/ for test: i915_query
results: parsing output: 123/ for test: prime_vgem
results: parsing output: 124/ for test: gem_render_copy
results: parsing output: 125/ for test: kms_vblank
results: parsing output: 126/ for test: kms_atomic_transition
results: parsing output: 127/ for test: gem_mmap_wc
results: parsing output: 128/ for test: perf_pmu
results: parsing output: 129/ for test: kms_chamelium_hpd
results: parsing output: 130/ for test: core_debugfs
Done.