[58.288809] Initializing watchdogs
[58.288890]   /dev/watchdog0
[58.303469] [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.308058] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.310094] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.312054] [001/131] (960s left) kms_addfb_basic (unused-modifier)
[58.369998] Starting subtest: unused-modifier
[58.371143] Subtest unused-modifier: SUCCESS (0.000s)
[58.526148] [002/131] (960s left) prime_vgem (coherency-gtt)
[58.631230] Starting subtest: coherency-gtt
[58.633286] Subtest coherency-gtt: SKIP (0.000s)
[58.760275] [FACT prime_vgem (coherency-gtt)] new: kernel.kmod_is_loaded.vgem: true
[58.761921] [003/131] (960s left) gem_exec_balancer (parallel-bb-first)
[59.025845] Starting subtest: parallel-bb-first
[59.933103] Subtest parallel-bb-first: SUCCESS (0.903s)
[60.944047] [004/131] (957s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[61.050663] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[62.196896] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.142s)
[62.373114] [005/131] (956s left) perf_pmu (busy-idle-check-all)
[62.404061] Starting subtest: busy-idle-check-all
[62.404940] Starting dynamic subtest: rcs0
[63.061855] Dynamic subtest rcs0: SUCCESS (0.655s)
[63.070444] Starting dynamic subtest: bcs0
[63.720562] Dynamic subtest bcs0: SUCCESS (0.656s)
[63.731297] Starting dynamic subtest: vcs0
[64.919894] Dynamic subtest vcs0: SUCCESS (1.194s)
[64.929579] Starting dynamic subtest: vcs1
[66.904944] Dynamic subtest vcs1: SUCCESS (1.978s)
[66.915663] Starting dynamic subtest: vecs0
[68.890943] Dynamic subtest vecs0: SUCCESS (1.981s)
[68.900387] Starting dynamic subtest: ccs0
[69.544097] Dynamic subtest ccs0: SUCCESS (0.654s)
[69.545221] Subtest busy-idle-check-all: SUCCESS (7.125s)
[69.664923] [006/131] (949s left) gem_userptr_blits (coherency-sync)
[69.723237] Starting subtest: coherency-sync
[69.937549] Subtest coherency-sync: SKIP (0.198s)
[70.095715] [007/131] (948s left) gem_exec_fence (parallel)
[70.316866] Starting subtest: parallel
[70.318114] Starting dynamic subtest: rcs0
[72.470621] Dynamic subtest rcs0: SUCCESS (2.152s)
[72.477716] Starting dynamic subtest: bcs0
[74.626590] Dynamic subtest bcs0: SUCCESS (2.154s)
[74.634120] Starting dynamic subtest: vcs0
[76.777480] Dynamic subtest vcs0: SUCCESS (2.149s)
[76.785902] Starting dynamic subtest: vcs1
[78.932466] Dynamic subtest vcs1: SUCCESS (2.153s)
[78.941538] Starting dynamic subtest: vecs0
[81.083767] Dynamic subtest vecs0: SUCCESS (2.150s)
[81.092335] Starting dynamic subtest: ccs0
[83.236685] Dynamic subtest ccs0: SUCCESS (2.151s)
[83.237864] Subtest parallel: SUCCESS (12.911s)
[84.063625] [008/131] (934s left) gem_exec_reloc (basic-write-read-active)
[84.118149] Subtest basic-write-read-active: SKIP (0.000s)
[84.198597] [009/131] (934s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[84.308971] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[84.310835] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[84.451858] [010/131] (934s left) gem_busy (parallel)
[84.636681] Starting subtest: parallel
[84.637730] Starting dynamic subtest: rcs0
[85.913770] Dynamic subtest rcs0: SUCCESS (1.274s)
[85.922642] Starting dynamic subtest: bcs0
[87.897969] Dynamic subtest bcs0: SUCCESS (1.982s)
[87.908367] Starting dynamic subtest: vcs0
[89.944999] Dynamic subtest vcs0: SUCCESS (2.045s)
[89.954464] Starting dynamic subtest: vcs1
[91.929941] Dynamic subtest vcs1: SUCCESS (1.982s)
[91.938948] Starting dynamic subtest: vecs0
[93.914049] Dynamic subtest vecs0: SUCCESS (1.983s)
[93.923599] Starting dynamic subtest: ccs0
[95.898859] Dynamic subtest ccs0: SUCCESS (1.983s)
[95.900557] Subtest parallel: SUCCESS (11.256s)
[96.173157] [011/131] (922s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[96.275739] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[102.889044] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.613s)
[103.017836] [012/131] (916s left) kms_mmap_write_crc (main)
[103.115737] Starting subtest: main
[103.116693] Starting dynamic subtest: pipe-A-eDP-1
[106.666911] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.549s)
[106.667814] Subtest main: SUCCESS (3.550s)
[107.566269] [013/131] (911s left) syncobj_wait (invalid-reset-bad-pad)
[107.618053] Starting subtest: invalid-reset-bad-pad
[107.619082] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[107.732471] [014/131] (911s left) gem_exec_reloc (basic-scanout)
[107.806389] Subtest basic-scanout: SKIP (0.000s)
[107.898056] [015/131] (911s left) kms_rotation_crc (primary-rotation-180)
[107.995263] Starting subtest: primary-rotation-180
[114.932526] Subtest primary-rotation-180: SUCCESS (6.937s)
[116.130892] [016/131] (903s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[116.242093] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[117.265606] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.024s)
[117.419710] [017/131] (901s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[117.524338] Starting subtest: fbc-rgb565-draw-pwrite
[122.041656] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.518s)
[123.224898] [018/131] (896s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[123.327468] Starting subtest: plane-upscale-20x20-with-modifiers
[123.328490] Starting dynamic subtest: pipe-A
[123.664271] Dynamic subtest pipe-A: SUCCESS (0.338s)
[123.672052] Starting dynamic subtest: pipe-B
[125.089773] Dynamic subtest pipe-B: SUCCESS (1.425s)
[125.097524] Starting dynamic subtest: pipe-C
[126.516483] Dynamic subtest pipe-C: SUCCESS (1.426s)
[126.524431] Starting dynamic subtest: pipe-D
[127.946080] Dynamic subtest pipe-D: SUCCESS (1.428s)
[127.946972] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.620s)
[129.133669] [019/131] (890s left) kms_addfb_basic (tile-pitch-mismatch)
[129.189799] Starting subtest: tile-pitch-mismatch
[129.191554] Subtest tile-pitch-mismatch: SKIP (0.000s)
[129.331709] [020/131] (890s left) kms_getfb (getfb-reject-nv12)
[129.419498] Starting subtest: getfb-reject-nv12
[129.420435] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[129.544873] [021/131] (889s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[129.638222] Starting subtest: psr-2p-primscrn-spr-indfb-move
[129.639944] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[129.764786] [022/131] (889s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[129.862889] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc
[136.465471] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.600s)
[136.643402] [023/131] (882s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[136.751738] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[140.364093] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.612s)
[141.558416] [024/131] (878s left) kms_big_fb (linear-32bpp-rotate-270)
[141.658957] Starting subtest: linear-32bpp-rotate-270
[141.684671] Subtest linear-32bpp-rotate-270: SKIP (0.026s)
[141.835688] [025/131] (877s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[141.931994] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[141.933060] Starting dynamic subtest: pipe-A-eDP-1
[141.941194] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[141.950368] Starting dynamic subtest: pipe-B-eDP-1
[141.958476] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[141.967114] Starting dynamic subtest: pipe-C-eDP-1
[141.975249] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[141.982087] Starting dynamic subtest: pipe-D-eDP-1
[141.989720] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[141.990625] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.008s)
[144.205243] [026/131] (875s left) kms_vrr (max-min)
[144.292282] Starting subtest: max-min
[144.294838] Subtest max-min: SKIP (0.000s)
[144.383100] [027/131] (875s left) gem_tiled_partial_pwrite_pread (writes)
[144.440841] Subtest writes: SKIP (0.000s)
[144.528116] [028/131] (875s left) kms_plane_alpha_blend (constant-alpha-min)
[144.623885] Starting subtest: constant-alpha-min
[144.909751] Starting dynamic subtest: pipe-A-eDP-1
[145.606325] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.696s)
[145.613536] Starting dynamic subtest: pipe-D-eDP-1
[147.054577] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.446s)
[147.055539] Subtest constant-alpha-min: SUCCESS (2.430s)
[147.863273] [029/131] (871s left) kms_pm_lpsp (kms-lpsp)
[148.956273] Starting subtest: kms-lpsp
[148.957156] Starting dynamic subtest: pipe-A-eDP-1
[149.105125] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.149s)
[149.388608] Subtest kms-lpsp: SUCCESS (0.433s)
[150.207107] [030/131] (869s left) i915_drm_fdinfo (most-busy-idle-check-all)
[150.246998] Starting subtest: most-busy-idle-check-all
[150.247987] Starting dynamic subtest: rcs0
[150.252129] Dynamic subtest rcs0: SKIP (0.004s)
[150.260485] Starting dynamic subtest: bcs0
[150.262211] Dynamic subtest bcs0: SKIP (0.000s)
[150.269179] Starting dynamic subtest: vcs0
[150.270869] Dynamic subtest vcs0: SKIP (0.000s)
[150.277813] Starting dynamic subtest: vcs1
[150.279591] Dynamic subtest vcs1: SKIP (0.000s)
[150.286570] Starting dynamic subtest: vecs0
[150.288449] Dynamic subtest vecs0: SKIP (0.000s)
[150.297276] Starting dynamic subtest: ccs0
[150.298939] Dynamic subtest ccs0: SKIP (0.000s)
[150.300698] Subtest most-busy-idle-check-all: SKIP (0.009s)
[150.344833] [031/131] (869s left) gem_exec_params (invalid-fence-in)
[150.436551] Starting subtest: invalid-fence-in
[150.437824] Subtest invalid-fence-in: SUCCESS (0.000s)
[150.569941] [032/131] (869s left) kms_universal_plane (universal-plane-pageflip-windowed)
[150.668095] Starting subtest: universal-plane-pageflip-windowed
[150.669045] Starting dynamic subtest: pipe-A-eDP-1
[151.261241] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.592s)
[151.268742] Starting dynamic subtest: pipe-B-eDP-1
[152.510979] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.248s)
[152.518492] Starting dynamic subtest: pipe-C-eDP-1
[153.730808] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.219s)
[153.738096] Starting dynamic subtest: pipe-D-eDP-1
[154.963988] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.232s)
[154.965122] Subtest universal-plane-pageflip-windowed: SUCCESS (4.296s)
[155.828049] [033/131] (864s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[160.883255] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[160.885221] Starting dynamic subtest: pipe-A-eDP-1
[167.515451] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.629s)
[167.522546] Starting dynamic subtest: pipe-B-eDP-1
[174.065909] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.549s)
[174.066875] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (13.182s)
[174.969679] [034/131] (844s left) kms_cursor_crc (cursor-sliding-512x170)
[175.247582] Starting subtest: cursor-sliding-512x170
[175.249488] Subtest cursor-sliding-512x170: SKIP (0.001s)
[175.400790] [035/131] (844s left) gem_exec_reloc (basic-range-active)
[175.462398] Subtest basic-range-active: SKIP (0.000s)
[175.539389] [036/131] (844s left) gem_exec_flush (basic-wb-rw-before-default)
[175.611445] Starting subtest: basic-wb-rw-before-default
[181.067880] Subtest basic-wb-rw-before-default: SUCCESS (5.458s)
[181.265499] [037/131] (838s left) gem_mmap_offset (partial-unmap)
[181.316047] Starting subtest: partial-unmap
[181.317087] Starting dynamic subtest: smem0
[181.806790] Dynamic subtest smem0: SUCCESS (0.489s)
[181.808577] Subtest partial-unmap: SUCCESS (0.490s)
[181.946322] [038/131] (838s left) kms_properties (get_properties-sanity-atomic)
[182.052274] Starting subtest: get_properties-sanity-atomic
[182.054800] Subtest get_properties-sanity-atomic: SUCCESS (0.003s)
[182.146369] [039/131] (837s left) kms_psr (psr2-sprite-plane-move)
[182.239491] Starting subtest: psr2-sprite-plane-move
[182.240434] Starting dynamic subtest: eDP-1
[183.965574] Dynamic subtest eDP-1: SUCCESS (1.725s)
[183.966526] Subtest psr2-sprite-plane-move: SUCCESS (1.726s)
[184.821404] [040/131] (835s left) gen9_exec_parse (bb-large)
[184.882132] Subtest bb-large: SKIP (0.000s)
[184.961235] [041/131] (835s left) kms_psr (pr-cursor-plane-move)
[185.050850] Starting subtest: pr-cursor-plane-move
[185.052721] Subtest pr-cursor-plane-move: SKIP (0.000s)
[185.141998] [042/131] (834s left) kms_cursor_crc (cursor-offscreen-32x10)
[185.301666] Starting subtest: cursor-offscreen-32x10
[185.340860] Subtest cursor-offscreen-32x10: SKIP (0.037s)
[185.636499] [043/131] (834s left) kms_feature_discovery (display-4x)
[185.725402] Starting subtest: display-4x
[185.727092] Subtest display-4x: SKIP (0.000s)
[185.818475] [044/131] (834s left) i915_pm_rpm (gem-execbuf)
[188.040594] Starting subtest: gem-execbuf
[188.041490] Starting dynamic subtest: smem0
[189.779964] Dynamic subtest smem0: SUCCESS (1.739s)
[189.780864] Subtest gem-execbuf: SUCCESS (1.741s)
[189.886301] [045/131] (830s left) kms_dsc (dsc-with-bpc-formats)
[189.975688] Starting subtest: dsc-with-bpc-formats
[190.017078] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[190.071550] [046/131] (830s left) gem_userptr_blits (set-cache-level)
[190.138310] Starting subtest: set-cache-level
[190.140093] Subtest set-cache-level: SKIP (0.000s)
[190.307317] [047/131] (829s left) gem_ccs (large-ctrl-surf-copy)
[190.368862] Starting subtest: large-ctrl-surf-copy
[190.370626] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[190.499252] [048/131] (829s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[190.598761] Starting subtest: 4-tiled-8bpp-rotate-0
[191.700812] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.102s)
[191.817527] [049/131] (828s left) syncobj_wait (single-wait-all-for-submit-signaled)
[191.879013] Starting subtest: single-wait-all-for-submit-signaled
[191.880057] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[192.009836] [050/131] (828s left) kms_pm_rpm (system-suspend-modeset)
[194.029626] Starting subtest: system-suspend-modeset
[213.815108] Subtest system-suspend-modeset: SUCCESS (8.749s)
[218.236029] [051/131] (806s left) kms_psr (fbc-psr2-primary-page-flip)
[218.350933] Starting subtest: fbc-psr2-primary-page-flip
[218.351764] Starting dynamic subtest: eDP-1
[218.353475] Dynamic subtest eDP-1: SKIP (0.000s)
[218.355174] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[218.449936] [052/131] (806s left) gem_pwrite_snooped
[218.597084] [053/131] (805s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[218.687934] Starting subtest: primary-yf-tiled-reflect-x-90
[218.691137] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[218.783733] [054/131] (805s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[218.868353] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[218.869334] Starting dynamic subtest: pipe-A-default-mode
[219.199076] Dynamic subtest pipe-A-default-mode: SKIP (0.320s)
[219.201068] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.322s)
[220.091916] [055/131] (804s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[220.200479] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[220.201764] Starting dynamic subtest: pipe-A-eDP-1
[220.957243] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.736s)
[220.966074] Starting dynamic subtest: pipe-B-eDP-1
[222.751425] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.756s)
[222.760424] Starting dynamic subtest: pipe-C-eDP-1
[224.615386] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.832s)
[224.624330] Starting dynamic subtest: pipe-D-eDP-1
[226.462761] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.822s)
[226.463700] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.153s)
[227.626107] [056/131] (796s left) device_reset (cold-reset-bound)
[227.679951] Starting subtest: cold-reset-bound
[227.681915] Subtest cold-reset-bound: SKIP (0.000s)
[227.771950] [057/131] (796s left) tools_test (tools_test)
[227.808220] Starting subtest: tools_test
[227.880651] Subtest tools_test: SUCCESS (0.076s)
[227.958533] [058/131] (796s left) syncobj_wait (single-wait-signaled)
[228.017845] Starting subtest: single-wait-signaled
[228.018999] Subtest single-wait-signaled: SUCCESS (0.000s)
[228.132613] [059/131] (796s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[228.217279] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[228.218185] Starting dynamic subtest: pipe-A-default-mode
[228.508234] Dynamic subtest pipe-A-default-mode: SKIP (0.287s)
[228.509958] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.288s)
[229.367016] [060/131] (795s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[229.477341] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[229.479115] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[229.610276] [061/131] (795s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[229.695195] Starting subtest: fbc-rgb565-draw-render
[233.902079] Subtest fbc-rgb565-draw-render: SUCCESS (4.182s)
[235.103590] [062/131] (789s left) gem_mmap_gtt (big-bo-tiledx)
[235.161508] Subtest big-bo-tiledX: SKIP (0.000s)
[235.222185] [063/131] (789s left) gem_gpgpu_fill (offset-16x16)
[235.269997] Starting subtest: offset-16x16
[235.278296] Subtest offset-16x16: SUCCESS (0.008s)
[235.437533] [064/131] (789s left) gem_exec_schedule (preempt-queue-contexts-chain)
[235.501012] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[235.815876] [065/131] (789s left) kms_lease (implicit-plane-lease)
[235.895125] Starting subtest: implicit-plane-lease
[235.897198] Subtest implicit-plane-lease: SUCCESS (0.003s)
[236.030428] [066/131] (788s left) gem_spin_batch (resubmit-new)
[236.085904] Starting subtest: resubmit-new
[236.086920] Starting dynamic subtest: rcs0
[236.092852] Dynamic subtest rcs0: SUCCESS (0.009s)
[236.103025] Starting dynamic subtest: bcs0
[236.103884] Dynamic subtest bcs0: SUCCESS (0.004s)
[236.112048] Starting dynamic subtest: vcs0
[236.112854] Dynamic subtest vcs0: SUCCESS (0.004s)
[236.122500] Starting dynamic subtest: vcs1
[236.123320] Dynamic subtest vcs1: SUCCESS (0.004s)
[236.130953] Starting dynamic subtest: vecs0
[236.131777] Dynamic subtest vecs0: SUCCESS (0.004s)
[236.139362] Starting dynamic subtest: ccs0
[236.140212] Dynamic subtest ccs0: SUCCESS (0.004s)
[236.141021] Subtest resubmit-new: SUCCESS (0.033s)
[238.010363] [067/131] (786s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[238.105244] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[238.106183] Starting dynamic subtest: pipe-A-eDP-1
[238.128464] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[238.137486] Starting dynamic subtest: pipe-B-eDP-1
[238.159224] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[238.167121] Starting dynamic subtest: pipe-C-eDP-1
[238.189539] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[238.197383] Starting dynamic subtest: pipe-D-eDP-1
[238.219724] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[238.221444] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[240.279084] [068/131] (784s left) kms_hdr (static-toggle-suspend)
[240.381285] Starting subtest: static-toggle-suspend
[240.383720] Subtest static-toggle-suspend: SKIP (0.000s)
[240.475340] [069/131] (784s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[240.589932] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[240.592739] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.001s)
[240.754239] [070/131] (784s left) kms_atomic_interruptible (atomic-setmode)
[240.847360] Starting subtest: atomic-setmode
[240.848318] Starting dynamic subtest: pipe-A-eDP-1
[247.721081] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.864s)
[247.722057] Subtest atomic-setmode: SUCCESS (6.866s)
[248.557824] [071/131] (776s left) gem_ctx_persistence (legacy-engines-hang)
[248.618909] Starting subtest: legacy-engines-hang
[248.620001] Starting dynamic subtest: render
[248.718526] Dynamic subtest render: SUCCESS (0.099s)
[248.731015] Starting dynamic subtest: bsd1
[248.825395] Dynamic subtest bsd1: SUCCESS (0.104s)
[248.837965] Starting dynamic subtest: bsd2
[248.923681] Dynamic subtest bsd2: SUCCESS (0.095s)
[248.939726] Starting dynamic subtest: blt
[249.027709] Dynamic subtest blt: SUCCESS (0.101s)
[249.040945] Starting dynamic subtest: vebox
[249.120599] Dynamic subtest vebox: SUCCESS (0.090s)
[249.121727] Subtest legacy-engines-hang: SUCCESS (0.502s)
[249.218980] [072/131] (775s left) kms_chamelium_hpd (dp-hpd)
[249.597471] Subtest dp-hpd: SKIP (0.000s)
[250.427259] [073/131] (774s left) i915_pciid
[250.585650] [074/131] (774s left) kms_display_modes (extended-mode-basic)
[250.689616] Starting subtest: extended-mode-basic
[250.691634] Subtest extended-mode-basic: SKIP (0.000s)
[250.733273] [075/131] (774s left) kms_properties (colorop-properties-legacy)
[250.821241] Starting subtest: colorop-properties-legacy
[250.822224] Starting dynamic subtest: pipe-A-eDP-1
[251.167265] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.344s)
[251.175622] Starting dynamic subtest: pipe-B-eDP-1
[252.203924] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.035s)
[252.212792] Starting dynamic subtest: pipe-C-eDP-1
[253.243306] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.037s)
[253.252366] Starting dynamic subtest: pipe-D-eDP-1
[254.272347] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.027s)
[254.273326] Subtest colorop-properties-legacy: SUCCESS (3.449s)
[255.102276] [076/131] (770s left) gem_exec_balancer (indices)
[255.156145] Starting subtest: indices
[257.941339] Subtest indices: SUCCESS (2.781s)
[258.275056] [077/131] (767s left) sw_sync (sync_busy_fork_unixsocket)
[258.305891] Starting subtest: sync_busy_fork_unixsocket
[258.313090] Subtest sync_busy_fork_unixsocket: SUCCESS (0.008s)
[258.385757] [078/131] (766s left) syncobj_timeline (multi-wait-available-signaled)
[258.437011] Starting subtest: multi-wait-available-signaled
[258.437838] Subtest multi-wait-available-signaled: SUCCESS (0.000s)
[258.545417] [079/131] (766s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[258.594914] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[258.666456] [080/131] (766s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[258.758512] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[262.535690] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.777s)
[263.702432] [081/131] (761s left) kms_flip (basic-plain-flip)
[263.797125] Starting subtest: basic-plain-flip
[263.798000] Starting dynamic subtest: A-eDP1
[265.468723] Dynamic subtest A-eDP1: SUCCESS (1.671s)
[265.480265] Starting dynamic subtest: B-eDP1
[267.124541] Dynamic subtest B-eDP1: SUCCESS (1.653s)
[267.137482] Starting dynamic subtest: C-eDP1
[268.820384] Dynamic subtest C-eDP1: SUCCESS (1.691s)
[268.828975] Starting dynamic subtest: D-eDP1
[270.453029] Dynamic subtest D-eDP1: SUCCESS (1.628s)
[270.456593] Subtest basic-plain-flip: SUCCESS (6.659s)
[271.743210] [082/131] (753s left) prime_mmap_coherency (write)
[271.796065] Starting subtest: write
[277.174309] Subtest write: SUCCESS (5.373s)
[277.357923] [083/131] (748s left) kms_atomic (test-only)
[277.451139] Starting subtest: test-only
[277.499933] Starting dynamic subtest: pipe-A-eDP-1
[280.066895] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.567s)
[280.067797] Subtest test-only: SUCCESS (2.616s)
[280.957702] [084/131] (744s left) gem_pxp (hw-rejects-pxp-context)
[281.084877] Starting subtest: hw-rejects-pxp-context
[281.087045] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[281.224548] [085/131] (744s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[281.319082] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[281.320733] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[281.471829] [086/131] (744s left) gem_partial_pwrite_pread (reads-display)
[281.527764] Subtest reads-display: SKIP (0.000s)
[281.618741] [087/131] (744s left) api_intel_allocator (simple-allocator)
[281.690827] Starting subtest: simple-allocator
[281.691786] Starting dynamic subtest: basic
[281.696554] Dynamic subtest basic: SUCCESS (0.005s)
[281.706659] Starting dynamic subtest: parallel-one
[281.880327] Dynamic subtest parallel-one: SUCCESS (0.181s)
[281.888677] Starting dynamic subtest: print
[281.889521] Dynamic subtest print: SUCCESS (0.000s)
[281.897108] Starting dynamic subtest: reuse
[281.897883] Dynamic subtest reuse: SUCCESS (0.000s)
[281.905669] Starting dynamic subtest: reserve
[281.906479] Dynamic subtest reserve: SUCCESS (0.000s)
[281.914378] Starting dynamic subtest: fork-reopen-allocator
[281.915191] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s)
[281.915975] Subtest simple-allocator: SUCCESS (0.209s)
[282.042837] [088/131] (743s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[282.141506] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[282.143254] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[282.281582] [089/131] (743s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[287.313380] Starting subtest: pr-cursor-plane-move-continuous-sf
[287.316541] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.003s)
[288.182688] [090/131] (737s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[288.269950] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[294.780311] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.508s)
[294.937909] [091/131] (730s left) gem_exec_whisper (basic-forked-all)
[294.999432] Starting subtest: basic-forked-all
[307.698416] Subtest basic-forked-all: SUCCESS (12.692s)
[307.904958] [092/131] (717s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[308.005276] Starting subtest: fbc-psr-sprite-mmap-cpu
[308.006289] Starting dynamic subtest: eDP-1
[308.008238] Dynamic subtest eDP-1: SKIP (0.000s)
[308.010023] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.001s)
[308.100850] [093/131] (717s left) kms_concurrent (multi-plane-atomic-lowres)
[308.192462] Starting subtest: multi-plane-atomic-lowres
[308.193448] Starting dynamic subtest: pipe-A-eDP-1
[308.678910] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.486s)
[308.679921] Subtest multi-plane-atomic-lowres: SUCCESS (0.488s)
[309.557267] [094/131] (716s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[309.610289] Starting subtest: multi-wait-for-submit-submitted-signaled
[309.611250] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[309.749848] [095/131] (716s left) kms_psr (psr-primary-page-flip)
[309.842067] Starting subtest: psr-primary-page-flip
[309.843031] Starting dynamic subtest: eDP-1
[311.545735] Dynamic subtest eDP-1: SUCCESS (1.705s)
[311.546656] Subtest psr-primary-page-flip: SUCCESS (1.706s)
[312.429259] [096/131] (713s left) gem_exec_schedule (independent)
[312.491905] Starting subtest: independent
[312.493284] Starting dynamic subtest: rcs0
[313.975347] Dynamic subtest rcs0: SUCCESS (1.483s)
[313.985666] Starting dynamic subtest: vcs0
[316.000801] Dynamic subtest vcs0: SUCCESS (2.024s)
[316.012015] Starting dynamic subtest: vcs1
[317.965304] Dynamic subtest vcs1: SUCCESS (1.963s)
[317.976836] Starting dynamic subtest: vecs0
[319.980894] Dynamic subtest vecs0: SUCCESS (2.014s)
[319.992727] Starting dynamic subtest: ccs0
[321.974513] Dynamic subtest ccs0: SUCCESS (1.992s)
[321.975826] Subtest independent: SUCCESS (9.486s)
[322.293264] [097/131] (703s left) kms_pwrite_crc
[323.954304] [098/131] (702s left) gem_mmap_gtt (cpuset-medium-copy)
[324.019955] Subtest cpuset-medium-copy: SKIP (0.000s)
[324.078843] [099/131] (702s left) sysfs_heartbeat_interval (nopreempt)
[324.134126] Starting subtest: nopreempt
[324.135160] Starting dynamic subtest: vecs0
[332.942800] Dynamic subtest vecs0: SUCCESS (8.806s)
[332.954700] Starting dynamic subtest: ccs0
[337.014702] Dynamic subtest ccs0: SUCCESS (4.070s)
[337.025208] Starting dynamic subtest: vcs0
[346.950053] Dynamic subtest vcs0: SUCCESS (9.935s)
[346.962250] Starting dynamic subtest: bcs0
[350.887117] Dynamic subtest bcs0: SUCCESS (3.932s)
[350.898227] Starting dynamic subtest: rcs0
[354.937651] Dynamic subtest rcs0: SUCCESS (4.050s)
[354.949170] Starting dynamic subtest: vcs1
[364.940846] Dynamic subtest vcs1: SUCCESS (10.000s)
[364.942829] Subtest nopreempt: SUCCESS (40.805s)
[365.065150] [100/131] (661s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[365.172141] Starting subtest: y-tiled-8bpp-rotate-270
[365.173875] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[365.288392] [101/131] (660s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[365.386425] Starting subtest: bad-pixel-format-yf-tiled-ccs
[365.387343] Starting dynamic subtest: pipe-A-eDP-1
[365.395775] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[365.406992] Starting dynamic subtest: pipe-B-eDP-1
[365.416466] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[365.427237] Starting dynamic subtest: pipe-C-eDP-1
[365.435830] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[365.444385] Starting dynamic subtest: pipe-D-eDP-1
[365.453090] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[365.454712] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.005s)
[367.711152] [102/131] (658s left) syncobj_timeline (wait-for-submit-snapshot)
[367.770939] Starting subtest: wait-for-submit-snapshot
[367.854441] Subtest wait-for-submit-snapshot: SUCCESS (0.083s)
[367.952288] [103/131] (658s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[368.004365] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[368.114891] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.108s)
[368.211499] [104/131] (658s left) kms_cursor_crc (cursor-onscreen-max-size)
[368.526763] Starting subtest: cursor-onscreen-max-size
[368.529161] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[368.697040] [105/131] (657s left) gem_exec_params (batch-first)
[368.769417] Starting subtest: batch-first
[368.777089] Subtest batch-first: SUCCESS (0.007s)
[368.941111] [106/131] (657s left) gem_ctx_shared (q-out-order)
[368.996126] Starting subtest: Q-out-order
[368.997008] Starting dynamic subtest: rcs0
[369.146258] Dynamic subtest rcs0: SUCCESS (0.147s)
[369.157244] Starting dynamic subtest: vcs0
[369.237826] Dynamic subtest vcs0: SUCCESS (0.090s)
[369.254773] Starting dynamic subtest: vcs1
[369.319233] Dynamic subtest vcs1: SUCCESS (0.081s)
[369.335374] Starting dynamic subtest: vecs0
[369.400275] Dynamic subtest vecs0: SUCCESS (0.080s)
[369.416727] Starting dynamic subtest: ccs0
[369.491800] Dynamic subtest ccs0: SUCCESS (0.090s)
[369.493551] Subtest Q-out-order: SUCCESS (0.495s)
[371.075496] [107/131] (655s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[371.177747] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[375.775667] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (4.597s)
[376.906832] [108/131] (649s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[377.000724] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[377.002639] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[377.135661] [109/131] (649s left) gem_mmap (pf-nonblock)
[377.190600] Subtest pf-nonblock: SKIP (0.000s)
[377.251292] [110/131] (649s left) kms_busy (basic-hang)
[377.342104] Starting subtest: basic-hang
[377.342980] Starting dynamic subtest: flip-pipe-A
[377.932713] Dynamic subtest flip-pipe-A: SUCCESS (0.588s)
[377.944779] Starting dynamic subtest: modeset-pipe-A
[381.400801] Dynamic subtest modeset-pipe-A: SUCCESS (3.467s)
[381.420733] Starting dynamic subtest: flip-pipe-D
[382.599030] Dynamic subtest flip-pipe-D: SUCCESS (1.195s)
[382.610900] Starting dynamic subtest: modeset-pipe-D
[386.029900] Dynamic subtest modeset-pipe-D: SUCCESS (3.429s)
[386.030753] Subtest basic-hang: SUCCESS (8.686s)
[386.851644] [111/131] (639s left) kms_flip (busy-flip)
[386.929248] Starting subtest: busy-flip
[386.931426] Starting dynamic subtest: A-eDP1
[388.638004] Dynamic subtest A-eDP1: SUCCESS (1.706s)
[388.649481] Starting dynamic subtest: B-eDP1
[390.282814] Dynamic subtest B-eDP1: SUCCESS (1.642s)
[390.295360] Starting dynamic subtest: C-eDP1
[391.902783] Dynamic subtest C-eDP1: SUCCESS (1.618s)
[391.913009] Starting dynamic subtest: D-eDP1
[393.535182] Dynamic subtest D-eDP1: SUCCESS (1.630s)
[393.538717] Subtest busy-flip: SUCCESS (6.608s)
[394.843458] [112/131] (631s left) gem_ctx_persistence (engines-mixed)
[394.897307] Starting subtest: engines-mixed
[394.898570] Starting dynamic subtest: rcs0
[395.010278] Dynamic subtest rcs0: SUCCESS (0.112s)
[395.022932] Starting dynamic subtest: bcs0
[395.085817] Dynamic subtest bcs0: SUCCESS (0.074s)
[395.099140] Starting dynamic subtest: vcs0
[395.160738] Dynamic subtest vcs0: SUCCESS (0.073s)
[395.173771] Starting dynamic subtest: vcs1
[395.240053] Dynamic subtest vcs1: SUCCESS (0.077s)
[395.252753] Starting dynamic subtest: vecs0
[395.322926] Dynamic subtest vecs0: SUCCESS (0.080s)
[395.336246] Starting dynamic subtest: ccs0
[395.406119] Dynamic subtest ccs0: SUCCESS (0.081s)
[395.407712] Subtest engines-mixed: SUCCESS (0.510s)
[395.507116] [113/131] (631s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted)
[395.570207] Starting subtest: invalid-multi-wait-all-unsubmitted
[395.571101] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[395.698195] [114/131] (630s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[395.801805] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[402.555923] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.753s)
[402.710094] [115/131] (624s left) gem_workarounds (reset-context)
[402.777359] Starting subtest: reset-context
[402.964098] Subtest reset-context: SUCCESS (0.188s)
[403.132458] [116/131] (623s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[403.229104] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[403.622115] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[406.422826] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.797s)
[406.434426] Starting dynamic subtest: pipe-A-eDP-1-4
[408.620229] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.196s)
[408.631123] Starting dynamic subtest: pipe-A-eDP-1-4
[410.630936] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[410.641057] Starting dynamic subtest: pipe-A-eDP-1-x
[412.822234] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.190s)
[413.197705] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[415.946364] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.753s)
[415.958434] Starting dynamic subtest: pipe-B-eDP-1-4
[418.133877] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.186s)
[418.144572] Starting dynamic subtest: pipe-B-eDP-1-4
[420.143818] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.007s)
[420.152664] Starting dynamic subtest: pipe-B-eDP-1-x
[422.346172] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.200s)
[422.712044] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[425.472504] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.765s)
[425.483473] Starting dynamic subtest: pipe-C-eDP-1-4
[427.648015] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s)
[427.657287] Starting dynamic subtest: pipe-C-eDP-1-4
[429.661321] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[429.672822] Starting dynamic subtest: pipe-C-eDP-1-x
[431.838568] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[432.208611] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[435.006708] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.802s)
[435.018476] Starting dynamic subtest: pipe-D-eDP-1-4
[437.182722] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.175s)
[437.195229] Starting dynamic subtest: pipe-D-eDP-1-4
[439.192322] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.010s)
[439.202836] Starting dynamic subtest: pipe-D-eDP-1-x
[441.370460] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[441.372188] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.130s)
[442.608784] [117/131] (584s left) gem_exec_params (invalid-ring)
[442.679134] Starting subtest: invalid-ring
[442.680059] Subtest invalid-ring: SUCCESS (0.000s)
[442.817884] [118/131] (584s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[442.913449] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[449.785801] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.875s)
[449.974549] [119/131] (576s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[450.080674] Starting subtest: fbc-modesetfrombusy
[453.974918] Subtest fbc-modesetfrombusy: SUCCESS (3.896s)
[455.191498] [120/131] (571s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[455.295122] Starting subtest: blocking-absolute-wf_vblank-interruptible
[455.297424] Starting dynamic subtest: A-eDP1
[463.977332] Dynamic subtest A-eDP1: SUCCESS (8.681s)
[463.988778] Starting dynamic subtest: B-eDP1
[472.700776] Dynamic subtest B-eDP1: SUCCESS (8.722s)
[472.712672] Starting dynamic subtest: C-eDP1
[481.418705] Dynamic subtest C-eDP1: SUCCESS (8.716s)
[481.432678] Starting dynamic subtest: D-eDP1
[490.152405] Dynamic subtest D-eDP1: SUCCESS (8.733s)
[490.154641] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.863s)
[491.393082] [121/131] (535s left) kms_plane_scaling (invalid-parameters)
[491.492084] Starting subtest: invalid-parameters
[491.492895] Starting dynamic subtest: less-than-1-height-src
[491.504100] Dynamic subtest less-than-1-height-src: SUCCESS (0.012s)
[491.515150] Starting dynamic subtest: less-than-1-width-src
[491.518825] Dynamic subtest less-than-1-width-src: SUCCESS (0.012s)
[491.519818] Subtest invalid-parameters: SUCCESS (0.027s)
[491.649846] [122/131] (535s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[491.739182] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[491.740046] Starting dynamic subtest: pipe-A-eDP-1
[492.554539] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.812s)
[492.563790] Starting dynamic subtest: pipe-B-eDP-1
[494.105919] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.550s)
[494.115737] Starting dynamic subtest: pipe-C-eDP-1
[495.608528] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.501s)
[495.617707] Starting dynamic subtest: pipe-D-eDP-1
[497.115115] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.505s)
[497.115922] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.374s)
[498.325629] [123/131] (528s left) i915_query (query-topology-garbage-items)
[498.378675] Starting subtest: query-topology-garbage-items
[498.379687] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[498.500553] [124/131] (528s left) prime_vgem (wait)
[498.583314] Starting subtest: wait
[498.584438] Starting dynamic subtest: rcs0
[498.671683] Dynamic subtest rcs0: SUCCESS (0.088s)
[498.681844] Starting dynamic subtest: bcs0
[498.711515] Dynamic subtest bcs0: SUCCESS (0.039s)
[498.726904] Starting dynamic subtest: vcs0
[498.750110] Dynamic subtest vcs0: SUCCESS (0.037s)
[498.759137] Starting dynamic subtest: vcs1
[498.797908] Dynamic subtest vcs1: SUCCESS (0.047s)
[498.806842] Starting dynamic subtest: vecs0
[498.842782] Dynamic subtest vecs0: SUCCESS (0.044s)
[498.851786] Starting dynamic subtest: ccs0
[498.890316] Dynamic subtest ccs0: SUCCESS (0.047s)
[498.891166] Subtest wait: SUCCESS (0.308s)
[499.045487] [125/131] (528s left) gem_render_copy (y-tiled-to-vebox-linear)
[499.109116] Starting subtest: y-tiled-to-vebox-linear
[499.111061] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[499.310957] [126/131] (527s left) kms_vblank (crtc-id)
[499.411309] Starting subtest: crtc-id
[499.412262] Starting dynamic subtest: pipe-A-eDP-1
[499.845536] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.434s)
[499.858565] Starting dynamic subtest: pipe-D-eDP-1
[500.945007] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.096s)
[500.945894] Subtest crtc-id: SUCCESS (1.534s)
[501.794037] [127/131] (525s left) kms_atomic_transition (plane-all-transition-nonblocking)
[501.885126] Starting subtest: plane-all-transition-nonblocking
[501.886014] Starting dynamic subtest: pipe-A-eDP-1
[504.379037] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.494s)
[504.684288] Starting dynamic subtest: pipe-B-eDP-1
[507.907988] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.233s)
[508.205412] Subtest plane-all-transition-nonblocking: SUCCESS (6.320s)
[509.060286] [128/131] (518s left) gem_mmap_wc (write-read-distinct)
[509.137827] Subtest write-read-distinct: SKIP (0.000s)
[509.208319] [129/131] (517s left) perf_pmu (render-node-busy-idle)
[509.298187] Starting subtest: render-node-busy-idle
[509.299579] Starting dynamic subtest: rcs0
[510.011055] Dynamic subtest rcs0: SUCCESS (0.715s)
[510.023997] Starting dynamic subtest: bcs0
[510.681448] Dynamic subtest bcs0: SUCCESS (0.668s)
[510.694250] Starting dynamic subtest: vcs0
[511.927296] Dynamic subtest vcs0: SUCCESS (1.241s)
[511.939266] Starting dynamic subtest: vcs1
[513.911754] Dynamic subtest vcs1: SUCCESS (1.980s)
[513.923305] Starting dynamic subtest: vecs0
[515.959395] Dynamic subtest vecs0: SUCCESS (2.044s)
[515.971038] Starting dynamic subtest: ccs0
[516.633481] Dynamic subtest ccs0: SUCCESS (0.673s)
[516.634972] Subtest render-node-busy-idle: SUCCESS (7.338s)
[516.731322] [130/131] (510s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[517.121681] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[517.944969] [131/131] (509s left) core_debugfs (read-all-entries)
[517.994296] Starting subtest: read-all-entries
[518.076778] Subtest read-all-entries: SUCCESS (0.083s)
[518.164301] 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.