[57.221690] Initializing watchdogs
[57.221809]   /dev/watchdog0
[57.236988] [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.241343] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.243612] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.246925] [001/155] (960s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[57.520741] Starting subtest: cursor-rapid-movement-256x256
[57.535385] Starting dynamic subtest: pipe-A-eDP-1
[58.137341] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.610s)
[58.170686] Starting dynamic subtest: pipe-D-eDP-1
[59.380238] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.231s)
[59.382502] Subtest cursor-rapid-movement-256x256: SUCCESS (1.882s)
[60.221626] [002/155] (957s left) kms_plane (pixel-format-linear-modifier)
[60.322983] Starting subtest: pixel-format-linear-modifier
[60.350041] Starting dynamic subtest: pipe-A-plane-0
[60.910798] Dynamic subtest pipe-A-plane-0: SUCCESS (0.566s)
[60.919309] Starting dynamic subtest: pipe-A-plane-3
[61.351027] Dynamic subtest pipe-A-plane-3: SUCCESS (0.444s)
[61.359332] Starting dynamic subtest: pipe-A-plane-5
[61.560246] Dynamic subtest pipe-A-plane-5: SUCCESS (0.211s)
[62.689959] Starting dynamic subtest: pipe-B-plane-0
[63.257804] Dynamic subtest pipe-B-plane-0: SUCCESS (0.578s)
[63.270662] Starting dynamic subtest: pipe-B-plane-3
[63.664952] Dynamic subtest pipe-B-plane-3: SUCCESS (0.411s)
[63.674058] Starting dynamic subtest: pipe-B-plane-5
[63.874571] Dynamic subtest pipe-B-plane-5: SUCCESS (0.211s)
[64.181458] Subtest pixel-format-linear-modifier: SUCCESS (3.888s)
[65.047578] [003/155] (952s left) gem_eio (wait-1us)
[65.273346] Starting subtest: wait-1us
[65.597959] Subtest wait-1us: SUCCESS (0.329s)
[65.728750] [004/155] (952s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-render)
[65.829924] Starting subtest: hdr-rgb101010-draw-render
[65.834510] Subtest hdr-rgb101010-draw-render: SKIP (0.000s)
[65.933331] [005/155] (951s left) i915_drm_fdinfo (virtual-busy)
[65.969165] Starting subtest: virtual-busy
[65.973049] Subtest virtual-busy: SKIP (0.000s)
[66.030671] [006/155] (951s left) perf_pmu (semaphore-busy)
[66.067806] Starting subtest: semaphore-busy
[66.069353] Starting dynamic subtest: rcs0
[67.706885] Dynamic subtest rcs0: SUCCESS (1.644s)
[67.715211] Starting dynamic subtest: bcs0
[69.338894] Dynamic subtest bcs0: SUCCESS (1.634s)
[69.348872] Starting dynamic subtest: vcs0
[73.982160] Dynamic subtest vcs0: SUCCESS (4.591s)
[73.991841] Starting dynamic subtest: vcs1
[79.886033] Dynamic subtest vcs1: SUCCESS (5.917s)
[79.897072] Starting dynamic subtest: vecs0
[85.902801] Dynamic subtest vecs0: SUCCESS (6.018s)
[85.913474] Starting dynamic subtest: ccs0
[88.926347] Dynamic subtest ccs0: SUCCESS (3.073s)
[88.928979] Subtest semaphore-busy: SUCCESS (22.885s)
[89.052458] [007/155] (928s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-shrfb-pgflip-blt)
[89.165153] Starting subtest: fbcpsrhdr-2p-primscrn-shrfb-pgflip-blt
[89.169183] Subtest fbcpsrhdr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[89.258895] [008/155] (928s left) gem_exec_params (secure-non-root)
[89.322761] Starting subtest: secure-non-root
[89.327292] Subtest secure-non-root: SKIP (0.000s)
[89.424320] [009/155] (928s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-pwrite)
[89.525448] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-pwrite
[89.529573] Subtest fbchdr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[89.639839] [010/155] (928s left) gem_ccs (ctrl-surf-copy-new-ctx)
[89.707750] Starting subtest: ctrl-surf-copy-new-ctx
[89.712210] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[89.826931] [011/155] (928s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[89.921066] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[97.007242] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.093s)
[97.129162] [012/155] (921s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[97.236204] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area
[97.238482] Starting dynamic subtest: pipe-A-eDP-1
[97.320951] Dynamic subtest pipe-A-eDP-1: SKIP (0.089s)
[97.331021] Starting dynamic subtest: pipe-B-eDP-1
[98.539494] Dynamic subtest pipe-B-eDP-1: SKIP (1.217s)
[98.544433] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.308s)
[99.827905] [013/155] (918s left) kms_atomic (crtc-invalid-params)
[99.921516] Starting subtest: crtc-invalid-params
[99.924060] Starting dynamic subtest: pipe-A-eDP-1
[100.279139] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.355s)
[100.281167] Subtest crtc-invalid-params: SUCCESS (0.356s)
[101.168373] [014/155] (917s left) gem_exec_schedule (in-order)
[101.246130] Starting subtest: in-order
[101.248508] Starting dynamic subtest: rcs0
[101.340011] Dynamic subtest rcs0: SUCCESS (0.100s)
[101.347988] Starting dynamic subtest: vcs0
[101.426008] Dynamic subtest vcs0: SUCCESS (0.086s)
[101.435689] Starting dynamic subtest: vcs1
[101.513756] Dynamic subtest vcs1: SUCCESS (0.087s)
[101.524761] Starting dynamic subtest: vecs0
[101.605737] Dynamic subtest vecs0: SUCCESS (0.091s)
[101.617626] Starting dynamic subtest: ccs0
[101.708228] Dynamic subtest ccs0: SUCCESS (0.102s)
[101.710870] Subtest in-order: SUCCESS (0.469s)
[103.414717] [015/155] (914s left) sriov_basic (enable-vfs-bind-unbind-each)
[103.468294] Starting subtest: enable-vfs-bind-unbind-each
[103.470570] Starting dynamic subtest: numvfs-1
[103.475089] Dynamic subtest numvfs-1: SKIP (0.001s)
[103.485096] Starting dynamic subtest: numvfs-2
[103.489276] Dynamic subtest numvfs-2: SKIP (0.001s)
[103.497067] Starting dynamic subtest: numvfs-3
[103.501285] Dynamic subtest numvfs-3: SKIP (0.001s)
[103.509202] Starting dynamic subtest: numvfs-4
[103.513376] Dynamic subtest numvfs-4: SKIP (0.001s)
[103.521460] Starting dynamic subtest: numvfs-5
[103.525770] Dynamic subtest numvfs-5: SKIP (0.001s)
[103.534443] Starting dynamic subtest: numvfs-6
[103.538828] Dynamic subtest numvfs-6: SKIP (0.001s)
[103.546613] Starting dynamic subtest: numvfs-7
[103.550973] Dynamic subtest numvfs-7: SKIP (0.001s)
[103.558959] Starting dynamic subtest: numvfs-random
[103.563354] Dynamic subtest numvfs-random: SKIP (0.001s)
[103.567765] Subtest enable-vfs-bind-unbind-each: SKIP (0.007s)
[103.601774] [016/155] (914s left) sw_sync (sync_multi_timeline_wait)
[103.633813] Starting subtest: sync_multi_timeline_wait
[103.636340] Subtest sync_multi_timeline_wait: SUCCESS (0.001s)
[103.711699] [017/155] (914s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[103.806961] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[103.811239] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[103.879527] [018/155] (914s left) syncobj_timeline (invalid-transfer-non-existent-point)
[103.936959] Starting subtest: invalid-transfer-non-existent-point
[103.939243] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[104.029370] [019/155] (914s left) gem_mmap (big-bo)
[104.087641] Subtest big-bo: SKIP (0.000s)
[104.140071] [020/155] (914s left) gem_ctx_param (invalid-set-no-zeromap)
[104.192028] Starting subtest: invalid-set-no-zeromap
[104.194437] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[104.266598] [021/155] (914s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[104.338425] Starting subtest: yf-tiled-to-vebox-y-tiled
[104.342574] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[104.514808] [022/155] (914s left) i915_pm_rpm (gem-mmap-type)
[106.543846] Starting subtest: gem-mmap-type
[106.546283] Starting dynamic subtest: wb-smem0
[110.088736] Dynamic subtest wb-smem0: SUCCESS (3.546s)
[110.105090] Starting dynamic subtest: wc-smem0
[112.960511] Dynamic subtest wc-smem0: SUCCESS (2.873s)
[112.971048] Starting dynamic subtest: uc-smem0
[115.832746] Dynamic subtest uc-smem0: SUCCESS (2.871s)
[115.835114] Subtest gem-mmap-type: SUCCESS (9.292s)
[115.949645] [023/155] (902s left) kms_scaling_modes (scaling-mode-full-aspect)
[116.038555] Starting subtest: scaling-mode-full-aspect
[116.040973] Starting dynamic subtest: pipe-A-eDP-1
[116.129789] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.094s)
[116.138450] Starting dynamic subtest: pipe-B-eDP-1
[117.530643] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.398s)
[117.541872] Starting dynamic subtest: pipe-C-eDP-1
[118.748925] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.217s)
[118.757596] Starting dynamic subtest: pipe-D-eDP-1
[119.879880] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.130s)
[119.882143] Subtest scaling-mode-full-aspect: SUCCESS (3.844s)
[121.041457] [024/155] (897s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[121.138947] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[121.143275] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[121.235508] [025/155] (897s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[121.363405] Starting subtest: cursor-vs-flip-varying-size
[152.612519] Subtest cursor-vs-flip-varying-size: SUCCESS (31.246s)
[153.472933] [026/155] (865s left) kms_frontbuffer_tracking (fbcpsrhdr-suspend)
[153.567649] Starting subtest: fbcpsrhdr-suspend
[153.572059] Subtest fbcpsrhdr-suspend: SKIP (0.000s)
[153.663172] [027/155] (865s left) i915_query (test-query-geometry-subslices)
[153.716887] Starting subtest: test-query-geometry-subslices
[153.719211] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[153.815740] [028/155] (864s left) gem_create (create-massive)
[153.866385] Starting subtest: create-massive
[153.868843] Subtest create-massive: SUCCESS (0.000s)
[154.050371] [029/155] (864s left) gem_eio (wait-10ms)
[154.267777] Starting subtest: wait-10ms
[154.625752] Subtest wait-10ms: SUCCESS (0.359s)
[154.776128] [030/155] (864s left) kms_chamelium_color (ctm-green-to-red)
[154.862331] Subtest ctm-green-to-red: SKIP (0.000s)
[154.905903] [031/155] (864s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[155.002477] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[155.006049] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[155.090737] [032/155] (863s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[155.182102] Starting subtest: fbcpsr-suspend
[196.328397] Subtest fbcpsr-suspend: SUCCESS (11.003s)
[203.522611] [033/155] (822s left) sysfs_timeslice_duration (timeout)
[203.595145] Starting subtest: timeout
[203.597907] Starting dynamic subtest: vecs0
[213.470287] Dynamic subtest vecs0: SUCCESS (10.030s)
[213.482220] Starting dynamic subtest: ccs0
[214.789448] Dynamic subtest ccs0: SUCCESS (1.327s)
[214.799242] Starting dynamic subtest: vcs0
[224.478221] Dynamic subtest vcs0: SUCCESS (9.727s)
[224.491171] Starting dynamic subtest: bcs0
[225.102123] Dynamic subtest bcs0: SUCCESS (0.625s)
[225.111070] Starting dynamic subtest: rcs0
[226.342093] Dynamic subtest rcs0: SUCCESS (1.242s)
[226.351521] Starting dynamic subtest: vcs1
[235.496267] Dynamic subtest vcs1: SUCCESS (9.159s)
[235.499364] Subtest timeout: SUCCESS (32.120s)
[235.574842] [034/155] (790s left) kms_flip (2x-flip-vs-rmfb)
[235.671712] Starting subtest: 2x-flip-vs-rmfb
[235.683828] Subtest 2x-flip-vs-rmfb: SKIP (0.012s)
[235.777852] [035/155] (790s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[235.892137] Starting subtest: 2x-flip-vs-cursor-atomic
[235.896707] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[236.037875] [036/155] (790s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[236.138107] Starting subtest: y-tiled-16bpp-rotate-180
[236.142489] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[236.244883] [037/155] (789s left) gem_gtt_cpu_tlb
[236.352137] [038/155] (789s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[236.447633] Starting subtest: x-tiled-32bpp-rotate-180
[238.030108] Subtest x-tiled-32bpp-rotate-180: FAIL (1.447s)
[238.066793] [039/155] (788s left) gem_sync (basic-each)
[238.129247] Starting subtest: basic-each
[240.322557] Subtest basic-each: SUCCESS (2.198s)
[240.517739] [040/155] (785s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[240.616495] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[240.620951] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[241.736298] [041/155] (784s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[241.841026] Starting subtest: invalid-modeset-force-ultra-joiner
[241.845497] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[241.906066] [042/155] (784s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[241.962644] Starting subtest: multi-wait-available-submitted-signaled
[241.965097] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s)
[242.066814] [043/155] (784s left) kms_plane_multiple (tiling-yf)
[242.159473] Starting subtest: tiling-yf
[242.163488] Subtest tiling-yf: SKIP (0.000s)
[242.230544] [044/155] (784s left) gem_mmap_gtt (hang-user)
[242.282308] Subtest hang-user: SKIP (0.000s)
[242.342538] [045/155] (784s left) kms_content_protection (lic-type-1)
[242.477555] Starting subtest: lic-type-1
[242.481973] Subtest lic-type-1: SKIP (0.000s)
[242.588853] [046/155] (784s left) gem_userptr_blits (vma-merge)
[242.665102] Starting subtest: vma-merge
[242.707207] Subtest vma-merge: SUCCESS (0.042s)
[242.837957] [047/155] (783s left) kms_psr (fbc-psr-sprite-render)
[242.922836] Starting subtest: fbc-psr-sprite-render
[242.924776] Starting dynamic subtest: eDP-1
[242.928129] Dynamic subtest eDP-1: SKIP (0.000s)
[242.931447] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[242.992439] [048/155] (783s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[243.086644] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[243.090172] Subtest hdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[243.178115] [049/155] (783s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[243.562190] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[244.350282] [050/155] (782s left) gem_softpin (noreloc)
[244.420123] Starting subtest: noreloc
[249.863486] Subtest noreloc: SUCCESS (5.388s)
[249.944808] [051/155] (776s left) kms_pm_dc (dc5-dpms)
[251.053446] Starting subtest: dc5-dpms
[253.156822] Subtest dc5-dpms: SUCCESS (2.102s)
[253.234650] [052/155] (773s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[253.331416] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[257.049282] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.723s)
[258.237756] [053/155] (768s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[258.293219] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[258.361942] [054/155] (768s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs)
[258.464289] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs
[258.466617] Starting dynamic subtest: pipe-A-eDP-1
[258.488634] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[258.499041] Starting dynamic subtest: pipe-B-eDP-1
[258.520788] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[258.530178] Starting dynamic subtest: pipe-C-eDP-1
[258.550937] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[258.560195] Starting dynamic subtest: pipe-D-eDP-1
[258.581090] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[258.585020] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[260.809639] [055/155] (766s left) testdisplay
[261.133054] [056/155] (765s left) api_intel_bb (simple-bb-ctx)
[261.187347] Starting subtest: simple-bb-ctx
[261.194187] Subtest simple-bb-ctx: SUCCESS (0.008s)
[261.318208] [057/155] (765s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[261.411670] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu
[261.415542] Subtest psrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[261.508684] [058/155] (765s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[261.614558] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[262.729615] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.115s)
[262.870190] [059/155] (764s left) kms_async_flips (async-flip-dpms)
[262.958063] Starting subtest: async-flip-dpms
[263.333827] Starting dynamic subtest: pipe-A-eDP-1
[267.302126] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.967s)
[267.684334] Starting dynamic subtest: pipe-B-eDP-1
[270.478056] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.804s)
[270.868430] Starting dynamic subtest: pipe-C-eDP-1
[273.740420] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.880s)
[274.115062] Starting dynamic subtest: pipe-D-eDP-1
[277.012178] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.906s)
[277.014288] Subtest async-flip-dpms: SUCCESS (14.058s)
[278.191919] [060/155] (748s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[278.305164] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[278.309508] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[278.389883] [061/155] (748s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[278.492536] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[278.496773] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[278.607784] [062/155] (748s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc)
[278.703088] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc
[278.707173] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[278.797121] [063/155] (748s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[278.886942] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-mmap-wc
[278.891351] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[278.983332] [064/155] (748s left) gem_exec_balancer (hang)
[279.250598] Starting subtest: hang
[280.956082] Subtest hang: SUCCESS (1.710s)
[281.076959] [065/155] (746s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[281.179867] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[285.700611] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.528s)
[286.903741] [066/155] (740s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[286.995466] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[286.999670] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[287.068650] [067/155] (740s left) gen3_render_linear_blits
[287.187483] [068/155] (740s left) syncobj_timeline (wait-all-delayed-signal)
[287.228550] Starting subtest: wait-all-delayed-signal
[287.329762] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[287.420277] [069/155] (740s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[287.515744] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[287.528913] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.011s)
[287.605524] [070/155] (739s left) gem_exec_balancer (sequential)
[287.656664] Starting subtest: sequential
[290.772130] Subtest sequential: SUCCESS (3.116s)
[291.062812] [071/155] (736s left) api_intel_allocator (two-level-inception-interruptible)
[291.111639] Starting subtest: two-level-inception-interruptible
[296.518201] Subtest two-level-inception-interruptible: SUCCESS (5.409s)
[296.651350] [072/155] (730s left) kms_getfb (getfb2-into-addfb2)
[296.769311] Starting subtest: getfb2-into-addfb2
[296.771630] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[296.878658] [073/155] (730s left) gem_spin_batch (resubmit-all)
[296.964187] Starting subtest: resubmit-all
[296.966617] Starting dynamic subtest: rcs0
[296.978635] Dynamic subtest rcs0: SUCCESS (0.014s)
[296.990301] Starting dynamic subtest: bcs0
[296.992901] Dynamic subtest bcs0: SUCCESS (0.003s)
[297.002491] Starting dynamic subtest: vcs0
[297.004581] Dynamic subtest vcs0: SUCCESS (0.003s)
[297.013909] Starting dynamic subtest: vcs1
[297.015994] Dynamic subtest vcs1: SUCCESS (0.002s)
[297.025865] Starting dynamic subtest: vecs0
[297.028015] Dynamic subtest vecs0: SUCCESS (0.002s)
[297.037473] Starting dynamic subtest: ccs0
[297.039680] Dynamic subtest ccs0: SUCCESS (0.002s)
[297.041927] Subtest resubmit-all: SUCCESS (0.031s)
[298.515655] [074/155] (729s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[298.620520] Starting subtest: pr-plane-move-sf-dmg-area
[298.624580] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[298.703403] [075/155] (729s left) perf_pmu (busy-idle)
[298.746477] Starting subtest: busy-idle
[298.748852] Starting dynamic subtest: rcs0
[299.464302] Dynamic subtest rcs0: SUCCESS (0.720s)
[299.476634] Starting dynamic subtest: bcs0
[300.140432] Dynamic subtest bcs0: SUCCESS (0.674s)
[300.153355] Starting dynamic subtest: vcs0
[301.474714] Dynamic subtest vcs0: SUCCESS (1.330s)
[301.487404] Starting dynamic subtest: vcs1
[303.457770] Dynamic subtest vcs1: SUCCESS (1.980s)
[303.469247] Starting dynamic subtest: vecs0
[305.506398] Dynamic subtest vecs0: SUCCESS (2.046s)
[305.519282] Starting dynamic subtest: ccs0
[306.177105] Dynamic subtest ccs0: SUCCESS (0.669s)
[306.179895] Subtest busy-idle: SUCCESS (7.434s)
[306.297346] [076/155] (721s left) gen9_exec_parse (batch-without-end)
[306.355557] Subtest batch-without-end: SKIP (0.000s)
[306.423768] [077/155] (721s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[306.539960] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[306.544243] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[306.648418] [078/155] (721s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-render)
[306.747444] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-render
[306.751551] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[306.858164] [079/155] (721s left) gem_flink_basic (bad-open)
[306.906098] Starting subtest: bad-open
[306.908585] Subtest bad-open: SUCCESS (0.000s)
[307.013541] [080/155] (720s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[307.114189] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-mmap-wc
[307.118274] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[307.195171] [081/155] (720s left) kms_vblank (ts-continuation-idle-hang)
[307.289878] Starting subtest: ts-continuation-idle-hang
[307.291733] Starting dynamic subtest: pipe-A-eDP-1
[334.308074] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.016s)
[334.325529] Starting dynamic subtest: pipe-D-eDP-1
[359.193844] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.886s)
[359.196310] Subtest ts-continuation-idle-hang: SUCCESS (51.906s)
[360.046411] [082/155] (668s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[360.148333] Starting subtest: psr-1p-primscrn-spr-indfb-move
[367.598847] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.457s)
[367.733281] [083/155] (660s left) kms_psr (pr-primary-blt)
[367.826697] Starting subtest: pr-primary-blt
[367.830893] Subtest pr-primary-blt: SKIP (0.000s)
[367.909233] [084/155] (660s left) drm_read (short-buffer-wakeup)
[368.048117] Starting subtest: short-buffer-wakeup
[400.258491] Subtest short-buffer-wakeup: SUCCESS (32.217s)
[400.392241] [085/155] (627s left) gem_exec_whisper (basic-fds-priority-all)
[400.465400] Starting subtest: basic-fds-priority-all
[423.440328] Subtest basic-fds-priority-all: SUCCESS (22.977s)
[423.638870] [086/155] (604s left) gem_pxp (create-regular-context-2)
[423.769104] Starting subtest: create-regular-context-2
[423.771563] Subtest create-regular-context-2: SUCCESS (0.002s)
[423.876028] [087/155] (604s left) gem_tiled_blits (basic)
[423.938976] Subtest basic: SKIP (0.000s)
[424.008160] [088/155] (604s left) kms_psr (fbc-psr2-primary-page-flip)
[424.099407] Starting subtest: fbc-psr2-primary-page-flip
[424.101739] Starting dynamic subtest: eDP-1
[424.106014] Dynamic subtest eDP-1: SKIP (0.000s)
[424.110314] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[424.171260] [089/155] (604s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[424.227822] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[424.334364] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.106s)
[424.425350] [090/155] (603s left) kms_frontbuffer_tracking (hdr-2p-rte)
[424.532445] Starting subtest: hdr-2p-rte
[424.536422] Subtest hdr-2p-rte: SKIP (0.000s)
[424.631318] [091/155] (603s left) i915_drm_fdinfo (virtual-idle)
[424.671692] Starting subtest: virtual-idle
[427.731639] Subtest virtual-idle: SUCCESS (3.056s)
[427.804921] [092/155] (600s left) gem_ctx_sseu (invalid-args)
[427.867598] Subtest invalid-args: SKIP (0.000s)
[427.929804] [093/155] (600s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[427.986393] Starting subtest: verify-pxp-execution-after-suspend-resume
[435.020873] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.032s)
[442.171432] [094/155] (593s left) kms_plane_alpha_blend (alpha-7efc)
[442.268028] Starting subtest: alpha-7efc
[442.570735] Starting dynamic subtest: pipe-A-eDP-1
[443.185000] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.611s)
[443.211575] Starting dynamic subtest: pipe-D-eDP-1
[444.498604] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.292s)
[444.500856] Subtest alpha-7efc: SUCCESS (2.230s)
[445.354949] [095/155] (590s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-shrfb-msflip-blt)
[445.461021] Starting subtest: fbcpsrhdr-2p-scndscrn-shrfb-msflip-blt
[445.465452] Subtest fbcpsrhdr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[445.568141] [096/155] (590s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[445.662466] Starting subtest: primary-yf-tiled-reflect-x-270
[445.666809] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[445.734578] [097/155] (589s left) kms_chamelium_edid (hdmi-mode-timings)
[446.119732] Subtest hdmi-mode-timings: SKIP (0.000s)
[446.967431] [098/155] (588s left) kms_properties (get_properties-sanity-atomic)
[447.058453] Starting subtest: get_properties-sanity-atomic
[447.060593] Subtest get_properties-sanity-atomic: SUCCESS (0.003s)
[447.146321] [099/155] (588s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[447.253568] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[447.257942] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[447.340658] [100/155] (588s left) gem_lmem_swapping (verify-ccs)
[447.383986] Subtest verify-ccs: SKIP (0.000s)
[447.430505] [101/155] (588s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-mmap-wc)
[447.539165] Starting subtest: fbchdr-rgb101010-draw-mmap-wc
[447.543085] Subtest fbchdr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[447.653087] [102/155] (588s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[447.746872] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[447.750884] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[447.842589] [103/155] (588s left) kms_frontbuffer_tracking (hdr-2p-primscrn-indfb-msflip-blt)
[447.940344] Starting subtest: hdr-2p-primscrn-indfb-msflip-blt
[447.943833] Subtest hdr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[448.041004] [104/155] (587s left) kms_draw_crc (draw-method-pwrite)
[448.124772] Starting subtest: draw-method-pwrite
[448.126466] Starting dynamic subtest: xrgb8888-untiled
[448.702429] Dynamic subtest xrgb8888-untiled: SUCCESS (0.578s)
[448.713061] Starting dynamic subtest: rgb565-untiled
[449.157399] Dynamic subtest rgb565-untiled: SUCCESS (0.455s)
[449.168254] Starting dynamic subtest: xrgb2101010-untiled
[449.722847] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.566s)
[449.733673] Starting dynamic subtest: xbgr16161616f-untiled
[450.545272] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.822s)
[450.555681] Starting dynamic subtest: xrgb8888-xtiled
[452.378677] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.832s)
[452.393126] Starting dynamic subtest: rgb565-xtiled
[453.502006] Dynamic subtest rgb565-xtiled: SUCCESS (1.122s)
[453.512491] Starting dynamic subtest: xrgb2101010-xtiled
[455.324844] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.821s)
[455.337951] Starting dynamic subtest: xbgr16161616f-xtiled
[458.745116] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.421s)
[458.758583] Starting dynamic subtest: xrgb8888-4tiled
[459.878204] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.133s)
[459.888780] Starting dynamic subtest: rgb565-4tiled
[460.456241] Dynamic subtest rgb565-4tiled: SUCCESS (0.577s)
[460.467433] Starting dynamic subtest: xrgb2101010-4tiled
[461.611717] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.153s)
[461.627396] Starting dynamic subtest: xbgr16161616f-4tiled
[464.655593] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (3.044s)
[464.657897] Subtest draw-method-pwrite: SUCCESS (16.535s)
[464.762486] [105/155] (571s left) gem_exec_schedule (u-fairslice-all)
[464.836489] Starting subtest: u-fairslice-all
[466.939343] Subtest u-fairslice-all: SUCCESS (2.062s)
[467.188564] [106/155] (568s left) gem_lmem_swapping (heavy-verify-random-ccs)
[467.233605] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[467.279551] [107/155] (568s left) kms_cursor_crc (cursor-alpha-transparent)
[467.372481] Starting subtest: cursor-alpha-transparent
[467.374640] Starting dynamic subtest: pipe-A-eDP-1
[467.991837] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.618s)
[468.003181] Starting dynamic subtest: pipe-D-eDP-1
[469.269684] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.277s)
[469.271876] Subtest cursor-alpha-transparent: SUCCESS (1.898s)
[470.177087] [108/155] (565s left) kms_cursor_edge_walk (256x256-left-edge)
[470.268870] Starting subtest: 256x256-left-edge
[470.271130] Starting dynamic subtest: pipe-A-eDP-1
[473.727479] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.457s)
[473.737950] Starting dynamic subtest: pipe-D-eDP-1
[476.864545] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.138s)
[476.866869] Subtest 256x256-left-edge: SUCCESS (6.598s)
[477.672284] [109/155] (558s left) gem_exec_reloc (basic-write-gtt-noreloc)
[477.737990] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[477.818210] [110/155] (558s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[477.923407] Starting subtest: psr-indfb-scaledprimary
[483.703064] Subtest psr-indfb-scaledprimary: SUCCESS (5.784s)
[483.845837] [111/155] (552s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-indfb-fliptrack-mmap-gtt)
[483.943088] Starting subtest: fbcpsrhdr-2p-indfb-fliptrack-mmap-gtt
[483.947594] Subtest fbcpsrhdr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[484.036326] [112/155] (552s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[484.090296] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[484.092679] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[484.212301] [113/155] (552s left) gem_userptr_blits (input-checking)
[484.267060] Starting subtest: input-checking
[484.269169] Subtest input-checking: SUCCESS (0.000s)
[484.374588] [114/155] (552s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[484.467615] Starting subtest: plane-upscale-factor-0-25-with-rotation
[484.469912] Starting dynamic subtest: pipe-A
[484.691334] Dynamic subtest pipe-A: SUCCESS (0.226s)
[484.701277] Starting dynamic subtest: pipe-B
[485.964707] Dynamic subtest pipe-B: SUCCESS (1.272s)
[485.975528] Starting dynamic subtest: pipe-C
[487.289970] Dynamic subtest pipe-C: SUCCESS (1.324s)
[487.300129] Starting dynamic subtest: pipe-D
[488.622510] Dynamic subtest pipe-D: SUCCESS (1.331s)
[488.624820] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.158s)
[489.808092] [115/155] (546s left) kms_rmfb (close-fd)
[489.895570] Starting subtest: close-fd
[489.897573] Starting dynamic subtest: pipe-A-eDP-1
[490.003550] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.107s)
[490.016357] Starting dynamic subtest: pipe-B-eDP-1
[491.169537] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.164s)
[491.182083] Starting dynamic subtest: pipe-C-eDP-1
[492.387457] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.217s)
[492.399795] Starting dynamic subtest: pipe-D-eDP-1
[493.539303] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.151s)
[493.541632] Subtest close-fd: SUCCESS (3.644s)
[494.766824] [116/155] (541s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[494.864278] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc
[494.868875] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[494.961543] [117/155] (541s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[495.054582] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[495.056849] Starting dynamic subtest: pipe-A-eDP-1
[495.079147] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[495.091519] Starting dynamic subtest: pipe-B-eDP-1
[495.112619] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[495.122607] Starting dynamic subtest: pipe-C-eDP-1
[495.144093] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[495.153876] Starting dynamic subtest: pipe-D-eDP-1
[495.175924] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[495.180395] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[497.324744] [118/155] (539s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[497.420310] Starting subtest: compare-crc-sanitycheck-nv12
[497.422206] Starting dynamic subtest: pipe-A-eDP-1
[498.142275] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.723s)
[498.153706] Starting dynamic subtest: pipe-B-eDP-1
[499.433761] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.289s)
[499.445255] Starting dynamic subtest: pipe-C-eDP-1
[500.690178] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.254s)
[500.700737] Starting dynamic subtest: pipe-D-eDP-1
[501.930644] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.239s)
[501.933135] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.511s)
[502.768489] [119/155] (533s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[502.878176] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[509.506705] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.636s)
[509.674177] [120/155] (526s left) gem_ctx_persistence (heartbeat-close)
[509.730180] Starting subtest: heartbeat-close
[509.734562] Subtest heartbeat-close: SKIP (0.000s)
[509.827116] [121/155] (526s left) kms_sequence (queue-busy)
[509.921492] Starting subtest: queue-busy
[509.923705] Starting dynamic subtest: pipe-A-eDP-1
[511.849178] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.926s)
[511.859591] Starting dynamic subtest: pipe-B-eDP-1
[514.466016] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.616s)
[514.476535] Starting dynamic subtest: pipe-C-eDP-1
[517.087989] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.620s)
[517.098410] Starting dynamic subtest: pipe-D-eDP-1
[519.723647] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.635s)
[519.725968] Subtest queue-busy: SUCCESS (9.803s)
[520.599636] [122/155] (516s left) kms_cursor_legacy (torture-bo)
[520.713877] Starting subtest: torture-bo
[520.716076] Starting dynamic subtest: pipe-A
[527.217787] Dynamic subtest pipe-A: SUCCESS (6.448s)
[527.232215] Starting dynamic subtest: pipe-B
[533.122992] Dynamic subtest pipe-B: SUCCESS (5.956s)
[533.134867] Starting dynamic subtest: pipe-C
[539.610565] Dynamic subtest pipe-C: SUCCESS (6.485s)
[539.627036] Starting dynamic subtest: pipe-D
[547.074677] Dynamic subtest pipe-D: SUCCESS (7.461s)
[547.091420] Starting dynamic subtest: all-pipes
[553.529749] Dynamic subtest all-pipes: SUCCESS (6.452s)
[553.532636] Subtest torture-bo: SUCCESS (32.816s)
[553.700113] [123/155] (483s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[553.803501] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[553.805678] Starting dynamic subtest: pipe-A-eDP-1
[554.303826] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.471s)
[554.316230] Starting dynamic subtest: pipe-B-eDP-1
[555.794961] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.490s)
[555.807505] Starting dynamic subtest: pipe-C-eDP-1
[557.251817] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.455s)
[557.262515] Starting dynamic subtest: pipe-D-eDP-1
[558.659578] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.410s)
[558.661558] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.831s)
[559.831831] [124/155] (476s left) kms_plane (plane-position-hole)
[559.925538] Starting subtest: plane-position-hole
[560.466212] Starting dynamic subtest: pipe-A-plane-1
[561.712969] Dynamic subtest pipe-A-plane-1: SUCCESS (1.248s)
[561.724400] Starting dynamic subtest: pipe-A-plane-2
[563.035821] Dynamic subtest pipe-A-plane-2: SUCCESS (1.320s)
[563.046112] Starting dynamic subtest: pipe-A-plane-3
[564.274989] Dynamic subtest pipe-A-plane-3: SUCCESS (1.240s)
[564.286123] Starting dynamic subtest: pipe-A-plane-4
[565.483890] Dynamic subtest pipe-A-plane-4: SUCCESS (1.206s)
[565.495987] Starting dynamic subtest: pipe-A-plane-5
[565.508677] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[566.675405] Starting dynamic subtest: pipe-B-plane-1
[567.975962] Dynamic subtest pipe-B-plane-1: SUCCESS (1.309s)
[567.987210] Starting dynamic subtest: pipe-B-plane-2
[569.308039] Dynamic subtest pipe-B-plane-2: SUCCESS (1.331s)
[569.319458] Starting dynamic subtest: pipe-B-plane-3
[570.632158] Dynamic subtest pipe-B-plane-3: SUCCESS (1.325s)
[570.643651] Starting dynamic subtest: pipe-B-plane-4
[571.935733] Dynamic subtest pipe-B-plane-4: SUCCESS (1.303s)
[571.947340] Starting dynamic subtest: pipe-B-plane-5
[571.963107] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s)
[571.965469] Subtest plane-position-hole: SUCCESS (12.039s)
[572.740784] [125/155] (464s left) kms_psr (fbc-pr-sprite-blt)
[572.828437] Starting subtest: fbc-pr-sprite-blt
[572.832872] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[572.899116] [126/155] (463s left) gem_exec_params (invalid-batch-start-offset)
[572.948932] Starting subtest: invalid-batch-start-offset
[572.954423] Subtest invalid-batch-start-offset: SUCCESS (0.002s)
[573.057010] [127/155] (463s left) prime_self_import (basic-with_one_bo)
[573.092047] Starting subtest: basic-with_one_bo
[573.112181] Subtest basic-with_one_bo: SUCCESS (0.023s)
[573.243330] [128/155] (463s left) kms_frontbuffer_tracking (psrhdr-2p-pri-indfb-multidraw)
[573.338919] Starting subtest: psrhdr-2p-pri-indfb-multidraw
[573.342980] Subtest psrhdr-2p-pri-indfb-multidraw: SKIP (0.000s)
[573.456783] [129/155] (463s left) gem_exec_params (cliprects_ptr-dirt)
[573.509154] Starting subtest: cliprects_ptr-dirt
[573.511552] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[573.629700] [130/155] (463s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[573.730200] Starting subtest: yf-tiled-64bpp-rotate-270
[573.733984] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[573.823138] [131/155] (463s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[573.930248] Starting subtest: short-flip-before-cursor-atomic-transitions
[574.888406] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.958s)
[575.789237] [132/155] (461s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[575.854110] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[575.909746] [133/155] (461s left) gem_exec_fence (syncobj-import)
[576.420582] Starting subtest: syncobj-import
[576.426420] Subtest syncobj-import: SUCCESS (0.005s)
[577.522064] [FACT gem_exec_fence (syncobj-import)] new: kernel.kmod_is_loaded.vgem: true
[577.525581] [134/155] (459s left) gem_tiled_partial_pwrite_pread (reads)
[577.577237] Subtest reads: SKIP (0.000s)
[577.645021] [135/155] (459s left) gem_exec_suspend (basic-s4-devices)
[577.701693] Starting subtest: basic-S4-devices
[577.703511] Starting dynamic subtest: smem
[589.474864] Dynamic subtest smem: SUCCESS (11.775s)
[589.477575] Subtest basic-S4-devices: SUCCESS (11.777s)
[597.693451] [136/155] (447s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[597.764470] Starting subtest: stress-mm-invalidate-close-overlap
[599.965327] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s)
[600.054036] [137/155] (445s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[600.157509] Starting subtest: 4-tiled-32bpp-rotate-0
[601.571483] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.414s)
[601.707883] [138/155] (443s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[601.811562] Starting subtest: fbc-rgb101010-draw-mmap-wc
[604.280624] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (2.475s)
[605.489119] [139/155] (439s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-mmap-gtt)
[605.592968] Starting subtest: fbcpsrhdr-rgb101010-draw-mmap-gtt
[605.597354] Subtest fbcpsrhdr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[605.697284] [140/155] (439s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-pwrite)
[605.808256] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-pwrite
[605.812453] Subtest hdr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[605.901015] [141/155] (439s left) perf (missing-sample-flags)
[606.032215] Starting subtest: missing-sample-flags
[606.034065] Subtest missing-sample-flags: SUCCESS (0.000s)
[606.077127] [142/155] (439s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[606.139416] Starting subtest: y-tiled-ccs-to-y-tiled
[606.143724] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[606.321991] [143/155] (439s left) kms_cursor_crc (cursor-size-change)
[606.420660] Starting subtest: cursor-size-change
[606.422627] Starting dynamic subtest: pipe-A-eDP-1
[607.228362] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.806s)
[607.239861] Starting dynamic subtest: pipe-D-eDP-1
[608.769646] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.540s)
[608.771604] Subtest cursor-size-change: SUCCESS (2.350s)
[609.666209] [144/155] (436s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[609.789450] Starting subtest: flip-vs-cursor-busy-crc-legacy
[610.506249] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.715s)
[611.384426] [145/155] (434s left) gem_exec_reloc (basic-write-cpu-noreloc)
[611.436772] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[611.520725] [146/155] (434s left) kms_color (ctm-blue-to-red)
[611.607630] Starting subtest: ctm-blue-to-red
[611.609472] Starting dynamic subtest: pipe-A-eDP-1
[612.305772] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.697s)
[612.317306] Starting dynamic subtest: pipe-B-eDP-1
[613.666205] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.362s)
[613.678715] Starting dynamic subtest: pipe-C-eDP-1
[615.073099] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.406s)
[615.085273] Starting dynamic subtest: pipe-D-eDP-1
[616.484407] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.410s)
[616.487021] Subtest ctm-blue-to-red: SUCCESS (4.878s)
[617.312459] [147/155] (428s left) kms_psr (psr2-primary-blt)
[617.417278] Starting subtest: psr2-primary-blt
[617.419702] Starting dynamic subtest: eDP-1
[619.217436] Dynamic subtest eDP-1: SUCCESS (1.800s)
[619.219710] Subtest psr2-primary-blt: SUCCESS (1.801s)
[620.090635] [148/155] (425s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-msflip-blt)
[620.187567] Starting subtest: psrhdr-2p-scndscrn-shrfb-msflip-blt
[620.191899] Subtest psrhdr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[620.285598] [149/155] (425s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[620.367680] Starting subtest: plane-primary-toggle-with-vblank-wait
[620.370072] Starting dynamic subtest: pipe-A-eDP-1
[620.540949] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.175s)
[620.853063] Starting dynamic subtest: pipe-B-eDP-1
[621.785213] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.944s)
[622.083619] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.715s)
[622.946340] [150/155] (422s left) kms_big_fb (linear-8bpp-rotate-0)
[623.036049] Starting subtest: linear-8bpp-rotate-0
[624.272823] Subtest linear-8bpp-rotate-0: SUCCESS (1.236s)
[624.396782] [151/155] (421s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-blt)
[624.506976] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-blt
[624.510580] Subtest fbchdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[624.620333] [152/155] (421s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[624.723161] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[624.726750] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[624.812660] [153/155] (421s left) kms_atomic_interruptible (universal-setplane-cursor)
[624.903615] Starting subtest: universal-setplane-cursor
[624.905491] Starting dynamic subtest: pipe-A-eDP-1
[632.346067] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.442s)
[632.348516] Subtest universal-setplane-cursor: SUCCESS (7.443s)
[633.187012] [154/155] (412s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[633.291407] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[642.689628] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.403s)
[642.806881] [155/155] (403s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-blt)
[642.911822] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-blt
[642.916062] Subtest fbchdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[643.022913] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_crc
results: parsing output: 1/ for test: kms_plane
results: parsing output: 2/ for test: gem_eio
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: i915_drm_fdinfo
results: parsing output: 5/ for test: perf_pmu
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: gem_exec_params
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_ccs
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_psr2_sf
results: parsing output: 12/ for test: kms_atomic
results: parsing output: 13/ for test: gem_exec_schedule
results: parsing output: 14/ for test: sriov_basic
results: parsing output: 15/ for test: sw_sync
results: parsing output: 16/ for test: kms_flip_scaled_crc
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: gem_mmap
results: parsing output: 19/ for test: gem_ctx_param
results: parsing output: 20/ for test: gem_render_copy
results: parsing output: 21/ for test: i915_pm_rpm
results: parsing output: 22/ for test: kms_scaling_modes
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_cursor_legacy
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: i915_query
results: parsing output: 27/ for test: gem_create
results: parsing output: 28/ for test: gem_eio
results: parsing output: 29/ for test: kms_chamelium_color
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: sysfs_timeslice_duration
results: parsing output: 33/ for test: kms_flip
results: parsing output: 34/ for test: kms_cursor_legacy
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: gem_gtt_cpu_tlb
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: gem_sync
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: kms_joiner
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: kms_plane_multiple
results: parsing output: 43/ for test: gem_mmap_gtt
results: parsing output: 44/ for test: kms_content_protection
results: parsing output: 45/ for test: gem_userptr_blits
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_chamelium_hpd
results: parsing output: 49/ for test: gem_softpin
results: parsing output: 50/ for test: kms_pm_dc
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: gem_fenced_exec_thrash
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: testdisplay
results: parsing output: 55/ for test: api_intel_bb
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_big_fb
results: parsing output: 58/ for test: kms_async_flips
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_exec_balancer
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_flip_scaled_crc
results: parsing output: 66/ for test: gen3_render_linear_blits
results: parsing output: 67/ for test: syncobj_timeline
results: parsing output: 68/ for test: kms_flip
results: parsing output: 69/ for test: gem_exec_balancer
results: parsing output: 70/ for test: api_intel_allocator
results: parsing output: 71/ for test: kms_getfb
results: parsing output: 72/ for test: gem_spin_batch
results: parsing output: 73/ for test: kms_psr2_sf
results: parsing output: 74/ for test: perf_pmu
results: parsing output: 75/ for test: gen9_exec_parse
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_flink_basic
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_vblank
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_psr
results: parsing output: 83/ for test: drm_read
results: parsing output: 84/ for test: gem_exec_whisper
results: parsing output: 85/ for test: gem_pxp
results: parsing output: 86/ for test: gem_tiled_blits
results: parsing output: 87/ for test: kms_psr
results: parsing output: 88/ for test: syncobj_timeline
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: i915_drm_fdinfo
results: parsing output: 91/ for test: gem_ctx_sseu
results: parsing output: 92/ for test: gem_pxp
results: parsing output: 93/ for test: kms_plane_alpha_blend
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_rotation_crc
results: parsing output: 96/ for test: kms_chamelium_edid
results: parsing output: 97/ for test: kms_properties
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: gem_lmem_swapping
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_draw_crc
results: parsing output: 104/ for test: gem_exec_schedule
results: parsing output: 105/ for test: gem_lmem_swapping
results: parsing output: 106/ for test: kms_cursor_crc
results: parsing output: 107/ for test: kms_cursor_edge_walk
results: parsing output: 108/ for test: gem_exec_reloc
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: syncobj_timeline
results: parsing output: 112/ for test: gem_userptr_blits
results: parsing output: 113/ for test: kms_plane_scaling
results: parsing output: 114/ for test: kms_rmfb
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_ccs
results: parsing output: 117/ for test: kms_pipe_crc_basic
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: gem_ctx_persistence
results: parsing output: 120/ for test: kms_sequence
results: parsing output: 121/ for test: kms_cursor_legacy
results: parsing output: 122/ for test: kms_ccs
results: parsing output: 123/ for test: kms_plane
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: gem_exec_params
results: parsing output: 126/ for test: prime_self_import
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: gem_exec_params
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: kms_cursor_legacy
results: parsing output: 131/ for test: gem_exec_reloc
results: parsing output: 132/ for test: gem_exec_fence
results: parsing output: 133/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 134/ for test: gem_exec_suspend
results: parsing output: 135/ for test: gem_userptr_blits
results: parsing output: 136/ for test: kms_big_fb
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: kms_frontbuffer_tracking
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: perf
results: parsing output: 141/ for test: gem_render_copy
results: parsing output: 142/ for test: kms_cursor_crc
results: parsing output: 143/ for test: kms_cursor_legacy
results: parsing output: 144/ for test: gem_exec_reloc
results: parsing output: 145/ for test: kms_color
results: parsing output: 146/ for test: kms_psr
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: kms_atomic_transition
results: parsing output: 149/ for test: kms_big_fb
results: parsing output: 150/ for test: kms_frontbuffer_tracking
results: parsing output: 151/ for test: kms_frontbuffer_tracking
results: parsing output: 152/ for test: kms_atomic_interruptible
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: kms_frontbuffer_tracking
Done.