[60.895191] Initializing watchdogs
[60.895274]   /dev/watchdog0
[60.925525] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[60.940728] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[60.945638] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.948542] [001/133] (960s left) kms_cursor_crc (cursor-offscreen-256x85)
[62.697076] Starting subtest: cursor-offscreen-256x85
[62.715485] Starting dynamic subtest: pipe-A-HDMI-A-3
[65.270696] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.561s)
[65.305461] Starting dynamic subtest: pipe-D-HDMI-A-3
[67.674828] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.378s)
[67.675827] Subtest cursor-offscreen-256x85: SUCCESS (4.985s)
[68.307333] [002/133] (953s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[69.792376] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[69.794451] Starting dynamic subtest: pipe-A-HDMI-A-3
[69.816388] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.003s)
[69.823752] Starting dynamic subtest: pipe-B-HDMI-A-3
[69.846194] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.003s)
[69.853495] Starting dynamic subtest: pipe-C-HDMI-A-3
[69.877088] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.003s)
[69.884663] Starting dynamic subtest: pipe-D-HDMI-A-3
[69.909698] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.003s)
[69.911173] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.016s)
[70.053703] [003/133] (951s left) sysfs_timeslice_duration (duration)
[70.106425] Starting subtest: duration
[70.107263] Starting dynamic subtest: vecs0
[83.244195] Dynamic subtest vecs0: SUCCESS (13.140s)
[83.253978] Starting dynamic subtest: vcs0
[96.383366] Dynamic subtest vcs0: SUCCESS (13.139s)
[96.391540] Starting dynamic subtest: bcs0
[109.518394] Dynamic subtest bcs0: SUCCESS (13.135s)
[109.527210] Starting dynamic subtest: rcs0
[122.655467] Dynamic subtest rcs0: SUCCESS (13.137s)
[122.664159] Starting dynamic subtest: vcs1
[135.788428] Dynamic subtest vcs1: SUCCESS (13.133s)
[135.789448] Subtest duration: SUCCESS (65.687s)
[135.907332] [004/133] (885s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[137.393235] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[137.394370] Starting dynamic subtest: pipe-A-HDMI-A-3
[137.403518] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[137.411114] Starting dynamic subtest: pipe-B-HDMI-A-3
[137.414916] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[137.422358] Starting dynamic subtest: pipe-C-HDMI-A-3
[137.426034] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[137.433424] Starting dynamic subtest: pipe-D-HDMI-A-3
[137.437136] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[137.438954] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SKIP (0.006s)
[137.646725] [005/133] (884s left) drm_buddy (drm_buddy)
[137.690168] Starting subtest: drm_buddy
[137.691846] Subtest drm_buddy: SKIP (0.001s)
[137.816764] [006/133] (883s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[139.326231] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[139.920301] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.594s)
[140.183805] [007/133] (881s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[141.669570] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[141.671351] Starting dynamic subtest: pipe-A-HDMI-A-3
[141.680205] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[141.688110] Starting dynamic subtest: pipe-B-HDMI-A-3
[141.696964] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[141.704693] Starting dynamic subtest: pipe-C-HDMI-A-3
[141.713816] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[141.721174] Starting dynamic subtest: pipe-D-HDMI-A-3
[141.730751] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[141.732440] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SKIP (0.006s)
[141.928437] [008/133] (880s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[143.413425] Starting subtest: bad-pixel-format-yf-tiled-ccs
[143.415169] Starting dynamic subtest: pipe-A-HDMI-A-3
[143.423232] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[143.431050] Starting dynamic subtest: pipe-B-HDMI-A-3
[143.439204] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[143.446946] Starting dynamic subtest: pipe-C-HDMI-A-3
[143.455047] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[143.462448] Starting dynamic subtest: pipe-D-HDMI-A-3
[143.470907] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[143.472594] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.006s)
[143.679505] [009/133] (878s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[143.724584] Starting subtest: multi-wait-available-unsubmitted-submitted
[143.726883] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.001s)
[143.841156] [010/133] (878s left) perf_pmu (event-wait)
[143.890494] Starting subtest: event-wait
[143.891388] Starting dynamic subtest: rcs0
[143.893242] Dynamic subtest rcs0: SKIP (0.000s)
[143.895045] Subtest event-wait: SKIP (0.000s)
[143.995689] [011/133] (878s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[145.486567] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[145.488245] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[145.647714] [012/133] (876s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[147.148032] Starting subtest: psr-rgb565-draw-mmap-gtt
[147.149944] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[147.321802] [013/133] (875s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[148.814107] Subtest psr2-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[148.886726] [014/133] (873s left) kms_psr (fbc-psr2-dpms)
[150.373967] Subtest fbc-psr2-dpms: SKIP (0.000s)
[150.456413] [015/133] (872s left) gem_exec_balancer (parallel-ordering)
[150.880711] Starting subtest: parallel-ordering
[153.032930] Subtest parallel-ordering: SUCCESS (2.152s)
[153.233085] [016/133] (869s left) kms_joiner (basic-big-joiner)
[154.721902] Starting subtest: basic-big-joiner
[154.723688] Subtest basic-big-joiner: SKIP (0.000s)
[154.936094] [017/133] (867s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[156.423100] Starting subtest: flip-vs-cursor-crc-atomic
[157.006763] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.584s)
[157.177462] [018/133] (865s left) gem_wait (wait)
[157.238248] Starting subtest: wait
[157.239137] Starting dynamic subtest: all-engines
[158.341442] Dynamic subtest all-engines: SUCCESS (1.103s)
[158.352415] Starting dynamic subtest: rcs0
[159.396950] Dynamic subtest rcs0: SUCCESS (1.055s)
[159.407118] Starting dynamic subtest: bcs0
[160.449928] Dynamic subtest bcs0: SUCCESS (1.053s)
[160.460195] Starting dynamic subtest: vcs0
[161.505028] Dynamic subtest vcs0: SUCCESS (1.055s)
[161.515326] Starting dynamic subtest: vcs1
[162.558990] Dynamic subtest vcs1: SUCCESS (1.053s)
[162.569259] Starting dynamic subtest: vecs0
[163.613904] Dynamic subtest vecs0: SUCCESS (1.055s)
[163.614967] Subtest wait: SUCCESS (6.376s)
[163.885183] [019/133] (858s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[165.376844] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[165.381210] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[165.585983] [020/133] (857s left) kms_flip (2x-flip-vs-expired-vblank)
[167.079489] Starting subtest: 2x-flip-vs-expired-vblank
[167.099627] Subtest 2x-flip-vs-expired-vblank: SKIP (0.019s)
[167.222432] [021/133] (855s left) kms_lease (page-flip-implicit-plane)
[168.721185] Starting subtest: page-flip-implicit-plane
[168.722134] Starting dynamic subtest: pipe-A-HDMI-A-3
[169.160827] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.439s)
[169.170816] Starting dynamic subtest: pipe-B-HDMI-A-3
[169.427873] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.265s)
[169.437042] Starting dynamic subtest: pipe-C-HDMI-A-3
[169.680619] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.252s)
[169.689753] Starting dynamic subtest: pipe-D-HDMI-A-3
[169.941496] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.258s)
[169.942273] Subtest page-flip-implicit-plane: SUCCESS (1.221s)
[170.157341] [022/133] (852s left) gem_exec_params (rsvd2-dirt)
[170.207851] Starting subtest: rsvd2-dirt
[170.209601] Subtest rsvd2-dirt: SKIP (0.000s)
[170.343319] [023/133] (852s left) api_intel_bb (blit-reloc-purge-cache)
[170.387032] Starting subtest: blit-reloc-purge-cache
[170.388985] Subtest blit-reloc-purge-cache: SKIP (0.001s)
[170.576718] [024/133] (852s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[172.066885] Starting subtest: fbc-shrfb-scaledprimary
[175.696862] Subtest fbc-shrfb-scaledprimary: SUCCESS (3.630s)
[175.910408] [025/133] (847s left) i915_pm_rpm (gem-idle)
[180.026496] Starting subtest: gem-idle
[186.086680] Subtest gem-idle: SUCCESS (6.060s)
[186.952681] [026/133] (836s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[188.462104] Starting subtest: x-tiled-8bpp-rotate-0
[190.147589] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.682s)
[190.313486] [027/133] (833s left) gem_exec_schedule (preempt-contexts)
[190.374783] Starting subtest: preempt-contexts
[190.375640] Starting dynamic subtest: rcs0
[190.460402] Dynamic subtest rcs0: SUCCESS (0.086s)
[190.468587] Starting dynamic subtest: bcs0
[190.527927] Dynamic subtest bcs0: SUCCESS (0.067s)
[190.536207] Starting dynamic subtest: vcs0
[190.597561] Dynamic subtest vcs0: SUCCESS (0.069s)
[190.605736] Starting dynamic subtest: vcs1
[190.667498] Dynamic subtest vcs1: SUCCESS (0.069s)
[190.675780] Starting dynamic subtest: vecs0
[190.739401] Dynamic subtest vecs0: SUCCESS (0.072s)
[190.740363] Subtest preempt-contexts: SUCCESS (0.365s)
[191.156388] [028/133] (832s left) gem_exec_flush (basic-uc-rw-default)
[191.206776] Subtest basic-uc-rw-default: SKIP (0.000s)
[191.296347] [029/133] (832s left) kms_color_pipeline (plane-lut1d)
[192.782359] Starting subtest: plane-lut1d
[192.977738] Starting dynamic subtest: pipe-A-plane-0
[193.244618] Dynamic subtest pipe-A-plane-0: SUCCESS (0.266s)
[193.277871] Starting dynamic subtest: pipe-A-plane-1
[193.444612] Dynamic subtest pipe-A-plane-1: SUCCESS (0.198s)
[193.474922] Starting dynamic subtest: pipe-A-plane-2
[193.644654] Dynamic subtest pipe-A-plane-2: SUCCESS (0.198s)
[193.939908] Starting dynamic subtest: pipe-B-plane-0
[194.111354] Dynamic subtest pipe-B-plane-0: SUCCESS (0.199s)
[194.140525] Starting dynamic subtest: pipe-B-plane-1
[194.311762] Dynamic subtest pipe-B-plane-1: SUCCESS (0.198s)
[194.340620] Starting dynamic subtest: pipe-B-plane-2
[194.511587] Dynamic subtest pipe-B-plane-2: SUCCESS (0.198s)
[194.820670] Starting dynamic subtest: pipe-C-plane-0
[195.009434] Dynamic subtest pipe-C-plane-0: SUCCESS (0.216s)
[195.039685] Starting dynamic subtest: pipe-C-plane-1
[195.224306] Dynamic subtest pipe-C-plane-1: SUCCESS (0.214s)
[195.232902] Starting dynamic subtest: pipe-C-plane-2
[195.391142] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s)
[195.694168] Starting dynamic subtest: pipe-D-plane-0
[195.882151] Dynamic subtest pipe-D-plane-0: SUCCESS (0.216s)
[195.904368] Starting dynamic subtest: pipe-D-plane-1
[196.082199] Dynamic subtest pipe-D-plane-1: SUCCESS (0.198s)
[196.094651] Starting dynamic subtest: pipe-D-plane-2
[196.265522] Dynamic subtest pipe-D-plane-2: SUCCESS (0.181s)
[196.321438] Subtest plane-lut1d: SUCCESS (3.539s)
[196.498784] [030/133] (827s left) gem_exec_schedule (deep)
[196.674866] Starting subtest: deep
[196.675837] Starting dynamic subtest: rcs0
[212.656028] Dynamic subtest rcs0: SUCCESS (15.978s)
[212.664937] Starting dynamic subtest: bcs0
[228.877567] Dynamic subtest bcs0: SUCCESS (16.220s)
[228.889275] Starting dynamic subtest: vcs0
[244.921436] Dynamic subtest vcs0: SUCCESS (16.042s)
[244.935766] Starting dynamic subtest: vcs1
[260.955748] Dynamic subtest vcs1: SUCCESS (16.033s)
[260.965346] Starting dynamic subtest: vecs0
[277.148611] Dynamic subtest vecs0: SUCCESS (16.190s)
[277.149451] Subtest deep: SUCCESS (80.470s)
[277.966874] [FACT gem_exec_schedule (deep)] new: kernel.kmod_is_loaded.vgem: true
[277.969043] [031/133] (745s left) kms_cursor_crc (cursor-suspend)
[279.516615] Starting subtest: cursor-suspend
[279.518533] Starting dynamic subtest: pipe-A-HDMI-A-3
[332.920295] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (20.682s)
[332.931796] Starting dynamic subtest: pipe-D-HDMI-A-3
[385.909020] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (20.211s)
[385.909957] Subtest cursor-suspend: SUCCESS (40.897s)
[391.553988] [032/133] (637s left) perf (gen8-unprivileged-single-ctx-counters)
[391.684773] Starting subtest: gen8-unprivileged-single-ctx-counters
[391.686408] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[391.763267] [033/133] (637s left) api_intel_bb (intel-bb-blit-y)
[391.806986] Starting subtest: intel-bb-blit-y
[393.444872] Subtest intel-bb-blit-y: SUCCESS (1.634s)
[393.602765] [034/133] (635s left) prime_mmap (test_refcounting)
[393.646455] Starting subtest: test_refcounting
[393.647306] Starting dynamic subtest: test_refcounting-smem
[393.709336] Dynamic subtest test_refcounting-smem: SUCCESS (0.063s)
[393.719983] Starting dynamic subtest: test_refcounting-lmem0
[393.772104] Dynamic subtest test_refcounting-lmem0: SUCCESS (0.062s)
[393.773098] Subtest test_refcounting: SUCCESS (0.126s)
[393.904919] [035/133] (635s left) kms_atomic_transition (modeset-transition)
[395.392298] Starting subtest: modeset-transition
[395.393246] Starting dynamic subtest: 1x-outputs
[397.369938] Dynamic subtest 1x-outputs: SUCCESS (1.974s)
[397.371048] Subtest modeset-transition: SUCCESS (1.975s)
[397.588946] [036/133] (631s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[399.074778] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[399.075639] Starting dynamic subtest: pipe-A
[399.915075] Dynamic subtest pipe-A: SUCCESS (0.840s)
[399.928087] Starting dynamic subtest: pipe-B
[400.672502] Dynamic subtest pipe-B: SUCCESS (0.757s)
[400.685771] Starting dynamic subtest: pipe-C
[401.431816] Dynamic subtest pipe-C: SUCCESS (0.758s)
[401.450890] Starting dynamic subtest: pipe-D
[402.206428] Dynamic subtest pipe-D: SUCCESS (0.774s)
[402.207302] Subtest plane-downscale-factor-0-5-with-modifiers: SUCCESS (3.132s)
[402.398387] [037/133] (626s left) kms_frontbuffer_tracking (fbc-suspend)
[403.890564] Starting subtest: fbc-suspend
[459.560996] Subtest fbc-suspend: SUCCESS (23.219s)
[462.854755] [038/133] (569s left) gem_pxp (display-protected-crc)
[465.430911] Starting subtest: display-protected-crc
[465.432827] Subtest display-protected-crc: SKIP (0.000s)
[465.552389] [039/133] (566s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[467.044198] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[467.046123] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[467.229842] [040/133] (565s left) gem_userptr_blits (dmabuf-unsync)
[467.282594] Subtest dmabuf-unsync: SKIP (0.000s)
[467.490782] [041/133] (565s left) gem_eio (context-create)
[467.678836] Starting subtest: context-create
[467.960004] Subtest context-create: SUCCESS (0.281s)
[469.535569] [042/133] (563s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[471.034607] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[471.036611] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[471.235563] [043/133] (561s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[472.730383] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[472.732095] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[472.899205] [044/133] (559s left) kms_selftest (drm_dp_mst_helper)
[472.947176] Starting subtest: drm_dp_mst_helper
[473.020200] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[473.075625] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.079s)
[473.095879] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[473.187052] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.110s)
[473.207372] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[473.260646] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.071s)
[473.261887] Subtest drm_dp_mst_helper: SUCCESS (0.313s)
[473.474635] [045/133] (559s left) gem_spin_batch (resubmit-new)
[473.530194] Starting subtest: resubmit-new
[473.531163] Starting dynamic subtest: rcs0
[473.554170] Dynamic subtest rcs0: SUCCESS (0.024s)
[473.567547] Starting dynamic subtest: bcs0
[473.568350] Dynamic subtest bcs0: SUCCESS (0.006s)
[473.580456] Starting dynamic subtest: vcs0
[473.581548] Dynamic subtest vcs0: SUCCESS (0.005s)
[473.592972] Starting dynamic subtest: vcs1
[473.594102] Dynamic subtest vcs1: SUCCESS (0.005s)
[473.605290] Starting dynamic subtest: vecs0
[473.606312] Dynamic subtest vecs0: SUCCESS (0.005s)
[473.607412] Subtest resubmit-new: SUCCESS (0.048s)
[473.850624] [046/133] (559s left) testdisplay
[480.153637] [047/133] (552s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[481.643635] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[481.713863] [048/133] (551s left) i915_selftest (live)
[482.658397] Starting subtest: live
[482.659290] Starting dynamic subtest: sanitycheck
[484.131644] Dynamic subtest sanitycheck: SUCCESS (1.473s)
[484.140924] Starting dynamic subtest: uncore
[485.553508] Dynamic subtest uncore: SUCCESS (1.420s)
[485.562864] Starting dynamic subtest: workarounds
[489.000774] Dynamic subtest workarounds: SUCCESS (3.444s)
[489.009823] Starting dynamic subtest: gt_engines
[490.982660] Dynamic subtest gt_engines: SUCCESS (1.981s)
[490.991959] Starting dynamic subtest: gt_timelines
[557.623626] Dynamic subtest gt_timelines: SUCCESS (66.642s)
[557.633736] Starting dynamic subtest: gt_contexts
[559.072649] Dynamic subtest gt_contexts: SUCCESS (1.448s)
[559.081727] Starting dynamic subtest: gt_lrc
[565.189732] Dynamic subtest gt_lrc: SUCCESS (6.116s)
[565.198752] Starting dynamic subtest: gt_mocs
[567.554450] Dynamic subtest gt_mocs: SUCCESS (2.363s)
[567.563924] Starting dynamic subtest: gt_pm
[571.576571] Dynamic subtest gt_pm: SUCCESS (4.021s)
[571.585957] Starting dynamic subtest: gt_heartbeat
[572.995770] Dynamic subtest gt_heartbeat: SUCCESS (1.418s)
[573.004775] Starting dynamic subtest: gt_tlb
[586.844717] Dynamic subtest gt_tlb: SUCCESS (13.848s)
[586.853929] Starting dynamic subtest: requests
[597.554887] Dynamic subtest requests: SUCCESS (10.709s)
[597.564376] Starting dynamic subtest: migrate
[602.111584] Dynamic subtest migrate: SUCCESS (4.555s)
[602.120774] Starting dynamic subtest: active
[603.569550] Dynamic subtest active: SUCCESS (1.456s)
[603.579154] Starting dynamic subtest: objects
[605.956566] Dynamic subtest objects: SUCCESS (2.386s)
[605.965795] Starting dynamic subtest: mman
[609.489811] Dynamic subtest mman: SUCCESS (3.532s)
[609.499036] Starting dynamic subtest: dmabuf
[611.001686] Dynamic subtest dmabuf: SUCCESS (1.510s)
[611.010719] Starting dynamic subtest: vma
[612.412563] Dynamic subtest vma: SUCCESS (1.409s)
[612.421626] Starting dynamic subtest: coherency
[622.446510] Dynamic subtest coherency: SUCCESS (10.032s)
[622.455609] Starting dynamic subtest: gtt
[631.487895] Dynamic subtest gtt: SUCCESS (9.040s)
[631.497590] Starting dynamic subtest: gem
[633.061569] Dynamic subtest gem: SUCCESS (1.572s)
[633.071230] Starting dynamic subtest: evict
[644.574634] Dynamic subtest evict: SUCCESS (11.511s)
[644.583857] Starting dynamic subtest: hugepages
[661.820159] Dynamic subtest hugepages: SUCCESS (17.244s)
[661.829028] Starting dynamic subtest: gem_contexts
[690.017654] Dynamic subtest gem_contexts: SUCCESS (28.196s)
[690.026867] Starting dynamic subtest: client
[691.508697] Dynamic subtest client: SUCCESS (1.489s)
[691.517919] Starting dynamic subtest: gem_migrate
[694.159529] Dynamic subtest gem_migrate: SUCCESS (2.649s)
[694.169111] Starting dynamic subtest: reset
[695.621444] Dynamic subtest reset: SUCCESS (1.460s)
[695.631152] Starting dynamic subtest: memory_region
[698.653543] Dynamic subtest memory_region: SUCCESS (3.031s)
[698.662917] Starting dynamic subtest: hangcheck
[726.636708] Dynamic subtest hangcheck: SUCCESS (27.981s)
[726.646077] Starting dynamic subtest: execlists
[728.069689] Dynamic subtest execlists: SUCCESS (1.431s)
[728.079251] Starting dynamic subtest: ring_submission
[729.495544] Dynamic subtest ring_submission: SUCCESS (1.424s)
[729.505543] Starting dynamic subtest: perf
[731.038412] Dynamic subtest perf: SUCCESS (1.541s)
[731.047869] Starting dynamic subtest: slpc
[736.978540] Dynamic subtest slpc: SUCCESS (5.938s)
[736.989145] Starting dynamic subtest: guc
[740.456645] Dynamic subtest guc: SUCCESS (3.476s)
[740.465792] Starting dynamic subtest: guc_multi_lrc
[741.912643] Dynamic subtest guc_multi_lrc: SUCCESS (1.454s)
[741.922448] Starting dynamic subtest: guc_hang
[744.137557] Dynamic subtest guc_hang: SUCCESS (2.223s)
[744.146648] Starting dynamic subtest: late_gt_pm
[745.616487] Dynamic subtest late_gt_pm: SUCCESS (1.478s)
[745.617435] Subtest live: SUCCESS (262.960s)
[745.659795] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[745.660910] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[745.663682] [049/133] (287s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[749.045744] Subtest writes-after-reads-uncached: SKIP (0.000s)
[749.142019] [FACT gem_partial_pwrite_pread (writes-after-reads-uncached)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[749.145606] [FACT gem_partial_pwrite_pread (writes-after-reads-uncached)] new: kernel.kmod_is_loaded.i915: true
[749.149126] [050/133] (284s left) kms_getfb (getfb-handle-not-fb)
[750.638175] Starting subtest: getfb-handle-not-fb
[750.639027] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[750.834149] [051/133] (282s left) kms_psr (fbc-psr-sprite-plane-onoff)
[752.320031] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.000s)
[752.502517] [052/133] (281s left) i915_hangman (gt-error-state-capture)
[752.562961] Starting subtest: gt-error-state-capture
[752.565192] Starting dynamic subtest: rcs0
[761.978107] Dynamic subtest rcs0: SUCCESS (9.414s)
[761.997664] Starting dynamic subtest: bcs0
[771.979034] Dynamic subtest bcs0: SUCCESS (9.999s)
[771.992377] Starting dynamic subtest: vcs0
[781.977116] Dynamic subtest vcs0: SUCCESS (9.997s)
[781.995478] Starting dynamic subtest: vcs1
[790.926006] Dynamic subtest vcs1: SUCCESS (8.947s)
[790.939188] Starting dynamic subtest: vecs0
[800.981092] Dynamic subtest vecs0: SUCCESS (10.054s)
[800.982104] Subtest gt-error-state-capture: SUCCESS (48.418s)
[801.185395] [053/133] (232s left) perf (invalid-open-flags)
[801.311172] Starting subtest: invalid-open-flags
[801.312092] Subtest invalid-open-flags: SUCCESS (0.000s)
[801.396991] [054/133] (232s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[802.896591] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[802.898149] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[803.074834] [055/133] (230s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[804.561111] Starting subtest: async-flip-with-page-flip-events-linear
[804.831050] Starting dynamic subtest: pipe-A-HDMI-A-3
[807.155176] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.320s)
[807.363164] Starting dynamic subtest: pipe-B-HDMI-A-3
[809.419611] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (2.063s)
[809.625621] Starting dynamic subtest: pipe-C-HDMI-A-3
[811.684113] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (2.067s)
[811.862782] Starting dynamic subtest: pipe-D-HDMI-A-3
[813.916213] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.060s)
[813.917562] Subtest async-flip-with-page-flip-events-linear: SUCCESS (9.354s)
[814.280591] [056/133] (219s left) sw_sync (alloc_fence)
[814.325197] Starting subtest: alloc_fence
[814.326133] Subtest alloc_fence: SUCCESS (0.000s)
[814.428768] [057/133] (219s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[815.914015] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[815.915190] Starting dynamic subtest: pipe-A-valid-mode
[817.165237] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.250s)
[817.166019] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SUCCESS (1.253s)
[817.353006] [058/133] (216s left) gem_ctx_persistence (heartbeat-close)
[817.405308] Starting subtest: heartbeat-close
[817.407371] Subtest heartbeat-close: SKIP (0.000s)
[817.527054] [059/133] (216s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[819.031684] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[819.033637] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[819.250367] [060/133] (215s left) kms_flip (2x-flip-vs-modeset)
[820.737119] Starting subtest: 2x-flip-vs-modeset
[820.755674] Subtest 2x-flip-vs-modeset: SKIP (0.019s)
[820.916703] [061/133] (213s left) sw_sync (alloc_timeline)
[820.960938] Starting subtest: alloc_timeline
[820.961987] Subtest alloc_timeline: SUCCESS (0.000s)
[821.051043] [062/133] (213s left) gem_exec_fence (syncobj-timeline-chain-engines)
[821.572014] Starting subtest: syncobj-timeline-chain-engines
[821.708329] Subtest syncobj-timeline-chain-engines: SUCCESS (0.136s)
[822.011947] [063/133] (212s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[823.516208] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[823.551371] Starting dynamic subtest: pipe-A-plane-0
[824.084276] Dynamic subtest pipe-A-plane-0: SUCCESS (0.533s)
[824.114594] Starting dynamic subtest: pipe-A-plane-3
[824.401396] Dynamic subtest pipe-A-plane-3: SUCCESS (0.313s)
[824.422690] Starting dynamic subtest: pipe-A-plane-5
[824.701182] Dynamic subtest pipe-A-plane-5: SUCCESS (0.295s)
[824.882781] Starting dynamic subtest: pipe-B-plane-0
[825.238515] Dynamic subtest pipe-B-plane-0: SUCCESS (0.366s)
[825.274756] Starting dynamic subtest: pipe-B-plane-3
[825.588050] Dynamic subtest pipe-B-plane-3: SUCCESS (0.347s)
[825.604588] Starting dynamic subtest: pipe-B-plane-5
[825.938638] Dynamic subtest pipe-B-plane-5: SUCCESS (0.348s)
[826.012545] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.497s)
[826.178481] [064/133] (208s left) perf_pmu (all-busy-check-all)
[826.229251] Starting subtest: all-busy-check-all
[826.801484] Subtest all-busy-check-all: SUCCESS (0.572s)
[826.940010] [065/133] (207s left) kms_chamelium_frames (hdmi-crc-single)
[828.468385] Subtest hdmi-crc-single: SKIP (0.000s)
[828.588179] [066/133] (206s left) kms_draw_crc (draw-method-mmap-wc)
[830.074324] Starting subtest: draw-method-mmap-wc
[830.075967] Subtest draw-method-mmap-wc: SKIP (0.000s)
[830.263757] [067/133] (204s left) kms_content_protection (atomic)
[831.811964] Starting subtest: atomic
[831.820702] Subtest atomic: SKIP (0.005s)
[832.026693] [068/133] (202s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[833.513330] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[833.514372] Starting dynamic subtest: pipe-A-HDMI-A-3
[833.524068] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[833.536956] Starting dynamic subtest: pipe-B-HDMI-A-3
[833.546702] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[833.559450] Starting dynamic subtest: pipe-C-HDMI-A-3
[833.569353] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[833.582078] Starting dynamic subtest: pipe-D-HDMI-A-3
[833.592207] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[833.594187] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.011s)
[833.778980] [069/133] (201s left) kms_psr (pr-primary-render)
[835.266076] Subtest pr-primary-render: SKIP (0.000s)
[835.351475] [070/133] (199s left) gem_exec_flush (basic-uc-ro-default)
[835.401941] Subtest basic-uc-ro-default: SKIP (0.000s)
[835.501289] [071/133] (199s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[836.987188] Starting subtest: fb-8bpc-vs-panel-8bpc
[836.989867] Subtest fb-8bpc-vs-panel-8bpc: SKIP (0.001s)
[837.133512] [072/133] (198s left) gem_madvise (dontneed-after-mmap)
[837.181119] Starting subtest: dontneed-after-mmap
[837.186106] Subtest dontneed-after-mmap: SUCCESS (0.004s)
[837.373275] [073/133] (198s left) kms_plane_alpha_blend (constant-alpha-mid)
[838.858101] Starting subtest: constant-alpha-mid
[839.123917] Starting dynamic subtest: pipe-A-HDMI-A-3
[839.810771] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.686s)
[839.824671] Starting dynamic subtest: pipe-D-HDMI-A-3
[840.514696] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.701s)
[840.515646] Subtest constant-alpha-mid: SUCCESS (1.658s)
[840.708808] [074/133] (194s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[840.755475] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[840.836508] [075/133] (194s left) kms_flip (2x-flip-vs-wf_vblank)
[842.321971] Starting subtest: 2x-flip-vs-wf_vblank
[842.340893] Subtest 2x-flip-vs-wf_vblank: SKIP (0.019s)
[842.467486] [076/133] (193s left) kms_cursor_crc (cursor-sliding-128x42)
[844.157364] Starting subtest: cursor-sliding-128x42
[844.164558] Starting dynamic subtest: pipe-A-HDMI-A-3
[848.612378] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (4.447s)
[848.650619] Starting dynamic subtest: pipe-D-HDMI-A-3
[852.946863] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (4.309s)
[852.947759] Subtest cursor-sliding-128x42: SUCCESS (8.790s)
[853.330856] [077/133] (182s left) kms_psr (psr2-suspend)
[854.816867] Subtest psr2-suspend: SKIP (0.000s)
[854.891832] [078/133] (180s left) gem_mmap_offset (open-flood)
[854.936284] Starting subtest: open-flood
[876.422999] Subtest open-flood: SUCCESS (21.486s)
[876.588025] [079/133] (159s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[878.079943] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[878.081832] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[878.262225] [080/133] (157s left) gem_exec_nop (basic-sequential)
[878.358567] Starting subtest: basic-sequential
[882.059590] Subtest basic-sequential: SUCCESS (3.732s)
[882.335233] [081/133] (153s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[883.819952] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[883.821792] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[883.939809] [082/133] (152s left) gem_mmap_gtt (basic-small-bo-tiledy)
[883.993060] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[884.074003] [083/133] (152s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[885.579608] Starting subtest: y-tiled-64bpp-rotate-90
[885.652268] Subtest y-tiled-64bpp-rotate-90: SKIP (0.072s)
[885.852789] [084/133] (150s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[887.342878] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[887.344769] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[887.529899] [085/133] (148s left) gem_exec_alignment (single)
[887.584153] Starting subtest: single
[887.589976] Subtest single: SUCCESS (0.007s)
[887.805536] [086/133] (148s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[889.294566] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[889.296226] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[889.486497] [087/133] (147s left) syncobj_timeline (etime-single-wait-submitted)
[889.532563] Starting subtest: etime-single-wait-submitted
[889.643205] Subtest etime-single-wait-submitted: SUCCESS (0.106s)
[889.788796] [088/133] (146s left) i915_drm_fdinfo (virtual-busy-all)
[889.839053] Starting subtest: virtual-busy-all
[889.841108] Subtest virtual-busy-all: SKIP (0.000s)
[889.946291] [089/133] (146s left) gem_ctx_exec (basic)
[889.992246] Starting subtest: basic
[889.997620] Subtest basic: SUCCESS (0.005s)
[890.206645] [090/133] (146s left) gem_busy (parallel)
[890.401183] Starting subtest: parallel
[890.402111] Starting dynamic subtest: rcs0
[890.501673] Dynamic subtest rcs0: SUCCESS (0.100s)
[890.528422] Starting dynamic subtest: bcs0
[890.569529] Dynamic subtest bcs0: SUCCESS (0.066s)
[890.597519] Starting dynamic subtest: vcs0
[890.638597] Dynamic subtest vcs0: SUCCESS (0.067s)
[890.667954] Starting dynamic subtest: vcs1
[890.706559] Dynamic subtest vcs1: SUCCESS (0.066s)
[890.733736] Starting dynamic subtest: vecs0
[890.772883] Dynamic subtest vecs0: SUCCESS (0.064s)
[890.774004] Subtest parallel: SUCCESS (0.373s)
[891.088143] [091/133] (145s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[891.136537] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[891.137434] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[891.246224] [092/133] (145s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[892.731893] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[892.734038] Starting dynamic subtest: pipe-A-valid-mode
[893.965330] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.231s)
[893.966155] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SUCCESS (1.234s)
[894.153392] [093/133] (142s left) kms_vblank (ts-continuation-dpms-rpm)
[895.639045] Starting subtest: ts-continuation-dpms-rpm
[895.640271] Starting dynamic subtest: pipe-A-HDMI-A-3
[898.102352] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.462s)
[898.119140] Starting dynamic subtest: pipe-D-HDMI-A-3
[900.121397] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.014s)
[900.122190] Subtest ts-continuation-dpms-rpm: SUCCESS (4.483s)
[900.310206] [094/133] (136s left) sw_sync (timeline_closed_signaled)
[900.354042] Starting subtest: timeline_closed_signaled
[900.354901] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[900.448260] [095/133] (136s left) gem_lmem_swapping (verify)
[904.690273] Starting subtest: verify
[904.693252] Starting dynamic subtest: lmem0
[945.654713] Dynamic subtest lmem0: SUCCESS (40.959s)
[945.655842] Subtest verify: SUCCESS (40.961s)
[946.962442] [FACT gem_lmem_swapping (verify)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[946.963553] [FACT gem_lmem_swapping (verify)] deleted: kernel.kmod_is_loaded.i915: true
[946.966143] [096/133] ( 90s left) syncobj_wait (invalid-signal-zero-handles)
[950.353072] Starting subtest: invalid-signal-zero-handles
[950.353928] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[950.433877] [FACT syncobj_wait (invalid-signal-zero-handles)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[950.437529] [FACT syncobj_wait (invalid-signal-zero-handles)] new: kernel.kmod_is_loaded.i915: true
[950.441019] [097/133] ( 86s left) kms_pm_rpm (i2c)
[953.972796] Starting subtest: i2c
[957.636166] Subtest i2c: SUCCESS (3.668s)
[958.505621] [098/133] ( 79s left) vgem_basic (setversion)
[958.584764] Starting subtest: setversion
[958.586557] Subtest setversion: SUCCESS (0.000s)
[958.707404] [099/133] ( 78s left) gem_exec_reloc (basic-write-gtt)
[958.762913] Subtest basic-write-gtt: SKIP (0.000s)
[958.864739] [100/133] ( 78s left) kms_scaling_modes (scaling-mode-center)
[960.350017] Starting subtest: scaling-mode-center
[960.354837] Subtest scaling-mode-center: SKIP (0.002s)
[960.493683] [101/133] ( 77s left) perf_pmu (frequency)
[960.551155] Starting subtest: frequency
[960.555199] Starting dynamic subtest: gt0
[962.806607] Dynamic subtest gt0: FAIL (2.164s)
[962.845425] Starting dynamic subtest: idle-gt0
[963.233922] Dynamic subtest idle-gt0: SUCCESS (0.505s)
[963.241478] Subtest frequency: FAIL (2.684s)
[963.354551] [102/133] ( 74s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[964.859160] Starting subtest: 4-tiled-32bpp-rotate-180
[964.860905] Subtest 4-tiled-32bpp-rotate-180: SKIP (0.000s)
[965.021550] [103/133] ( 72s left) kms_hdr (bpc-switch-dpms)
[966.512050] Starting subtest: bpc-switch-dpms
[966.514753] Subtest bpc-switch-dpms: SKIP (0.001s)
[966.623182] [104/133] ( 71s left) syncobj_timeline (wait-any-interrupted)
[966.674171] Starting subtest: wait-any-interrupted
[966.787282] Subtest wait-any-interrupted: SUCCESS (0.109s)
[966.982306] [105/133] ( 71s left) gem_exec_parallel (contexts)
[967.039216] Starting subtest: contexts
[967.040120] Starting dynamic subtest: rcs0
[971.327114] Dynamic subtest rcs0: SUCCESS (4.284s)
[971.338854] Starting dynamic subtest: bcs0
[975.421839] Dynamic subtest bcs0: SUCCESS (4.093s)
[975.433948] Starting dynamic subtest: vcs0
[979.694534] Dynamic subtest vcs0: SUCCESS (4.271s)
[979.706297] Starting dynamic subtest: vcs1
[983.447687] Dynamic subtest vcs1: SUCCESS (3.751s)
[983.459584] Starting dynamic subtest: vecs0
[987.742539] Dynamic subtest vecs0: SUCCESS (4.293s)
[987.743796] Subtest contexts: SUCCESS (20.700s)
[988.065077] [106/133] ( 50s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[990.636604] Starting subtest: verify-pxp-key-change-after-suspend-resume
[990.639141] Subtest verify-pxp-key-change-after-suspend-resume: SKIP (0.000s)
[990.767377] [107/133] ( 47s left) gem_create (create-ext-placement-each)
[990.950195] Starting subtest: create-ext-placement-each
[990.951470] Subtest create-ext-placement-each: SUCCESS (0.001s)
[991.095290] [108/133] ( 47s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[992.581285] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[992.582295] Starting dynamic subtest: pipe-A-HDMI-A-3
[992.592135] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[992.604320] Starting dynamic subtest: pipe-B-HDMI-A-3
[992.613747] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[992.625605] Starting dynamic subtest: pipe-C-HDMI-A-3
[992.635640] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[992.647383] Starting dynamic subtest: pipe-D-HDMI-A-3
[992.657338] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[992.659381] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SKIP (0.011s)
[992.880039] [109/133] ( 45s left) gem_close_race (basic-process)
[992.954217] Starting subtest: basic-process
[993.008325] Subtest basic-process: SUCCESS (0.054s)
[993.314585] [110/133] ( 45s left) gem_exec_schedule (u-independent)
[993.373589] Starting subtest: u-independent
[993.374600] Starting dynamic subtest: rcs0
[993.623008] Dynamic subtest rcs0: SUCCESS (0.249s)
[993.644600] Starting dynamic subtest: bcs0
[993.841040] Dynamic subtest bcs0: SUCCESS (0.216s)
[993.865116] Starting dynamic subtest: vcs0
[994.066008] Dynamic subtest vcs0: SUCCESS (0.223s)
[994.089802] Starting dynamic subtest: vcs1
[994.288318] Dynamic subtest vcs1: SUCCESS (0.220s)
[994.320126] Starting dynamic subtest: vecs0
[994.521191] Dynamic subtest vecs0: SUCCESS (0.230s)
[994.525017] Subtest u-independent: SUCCESS (1.149s)
[994.917348] [111/133] ( 43s left) gen9_exec_parse (batch-without-end)
[994.968091] Subtest batch-without-end: SKIP (0.000s)
[995.059245] [112/133] ( 43s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[998.982279] Starting subtest: dpms-mode-unset-lpsp
[999.854148] Subtest dpms-mode-unset-lpsp: SKIP (0.873s)
[1000.911138] [113/133] ( 37s left) kms_chamelium_hpd (vga-hpd)
[1002.440074] Subtest vga-hpd: SKIP (0.000s)
[1002.561685] [114/133] ( 36s left) gem_lmem_swapping (heavy-multi)
[1006.849706] Starting subtest: heavy-multi
[1006.850964] Starting dynamic subtest: lmem0
[1013.301168] Dynamic subtest lmem0: SUCCESS (6.447s)
[1013.302202] Subtest heavy-multi: SUCCESS (6.449s)
[1014.680000] [FACT gem_lmem_swapping (heavy-multi)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[1014.681150] [FACT gem_lmem_swapping (heavy-multi)] deleted: kernel.kmod_is_loaded.i915: true
[1014.683591] [115/133] ( 24s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[1019.500399] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[1019.599942] [FACT kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[1019.603973] [FACT kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)] new: kernel.kmod_is_loaded.i915: true
[1019.608062] [116/133] ( 19s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[1021.108017] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[1021.109605] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[1021.287642] [117/133] ( 17s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[1022.779698] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[1025.754990] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (2.975s)
[1025.966072] [118/133] ( 13s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[1027.456696] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[1027.458530] Subtest psr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[1027.637667] [119/133] ( 11s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[1029.128766] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[1029.130855] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[1029.332926] [120/133] ( 10s left) gem_exec_balancer (noheartbeat)
[1029.761088] Starting subtest: noheartbeat
[1029.762937] Subtest noheartbeat: SKIP (0.000s)
[1029.873082] [121/133] (  9s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[1029.918916] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[1030.027404] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.104s)
[1030.143479] [122/133] (  9s left) kms_big_fb (linear-addfb)
[1031.647986] Starting subtest: linear-addfb
[1031.648914] Subtest linear-addfb: SUCCESS (0.000s)
[1031.833916] [123/133] (  7s left) perf_pmu (busy)
[1031.883344] Starting subtest: busy
[1031.884219] Starting dynamic subtest: rcs0
[1032.485684] Dynamic subtest rcs0: SUCCESS (0.601s)
[1032.501375] Starting dynamic subtest: bcs0
[1033.049759] Dynamic subtest bcs0: SUCCESS (0.562s)
[1033.065943] Starting dynamic subtest: vcs0
[1033.610668] Dynamic subtest vcs0: SUCCESS (0.559s)
[1033.626395] Starting dynamic subtest: vcs1
[1034.171773] Dynamic subtest vcs1: SUCCESS (0.559s)
[1034.187672] Starting dynamic subtest: vecs0
[1034.735442] Dynamic subtest vecs0: SUCCESS (0.560s)
[1034.744044] Subtest busy: SUCCESS (2.855s)
[1034.907936] [124/133] (  4s left) kms_force_connector_basic (force-load-detect)
[1035.039443] Starting subtest: force-load-detect
[1035.041087] Subtest force-load-detect: SKIP (0.000s)
[1036.000404] [125/133] (  3s left) gem_ctx_param (invalid-get-ringsize)
[1036.046952] Starting subtest: invalid-get-ringsize
[1036.047878] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[1036.247131] [126/133] (  3s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[1037.736610] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[1037.738627] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[1037.921436] [127/133] (  2s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[1039.409005] Starting subtest: cursorB-vs-flipA-varying-size
[1039.412292] Subtest cursorB-vs-flipA-varying-size: SKIP (0.003s)
[1039.533611] [128/133] (  0s left) kms_flip (2x-blocking-wf_vblank)
[1041.029607] Starting subtest: 2x-blocking-wf_vblank
[1041.048183] Subtest 2x-blocking-wf_vblank: SKIP (0.019s)
[1041.127608] Overall timeout time exceeded, stopping.
[1041.203139] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_crc
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: sysfs_timeslice_duration
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: drm_buddy
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: kms_ccs
results: parsing output: 8/ for test: syncobj_timeline
results: parsing output: 9/ for test: perf_pmu
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_psr2_sf
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: gem_exec_balancer
results: parsing output: 15/ for test: kms_joiner
results: parsing output: 16/ for test: kms_cursor_legacy
results: parsing output: 17/ for test: gem_wait
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_flip
results: parsing output: 20/ for test: kms_lease
results: parsing output: 21/ for test: gem_exec_params
results: parsing output: 22/ for test: api_intel_bb
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: i915_pm_rpm
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: gem_exec_schedule
results: parsing output: 27/ for test: gem_exec_flush
results: parsing output: 28/ for test: kms_color_pipeline
results: parsing output: 29/ for test: gem_exec_schedule
results: parsing output: 30/ for test: kms_cursor_crc
results: parsing output: 31/ for test: perf
results: parsing output: 32/ for test: api_intel_bb
results: parsing output: 33/ for test: prime_mmap
results: parsing output: 34/ for test: kms_atomic_transition
results: parsing output: 35/ for test: kms_plane_scaling
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_pxp
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_userptr_blits
results: parsing output: 40/ for test: gem_eio
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_selftest
results: parsing output: 44/ for test: gem_spin_batch
results: parsing output: 45/ for test: testdisplay
results: parsing output: 46/ for test: kms_psr2_sf
results: parsing output: 47/ for test: i915_selftest
results: parsing output: 48/ for test: gem_partial_pwrite_pread
results: parsing output: 49/ for test: kms_getfb
results: parsing output: 50/ for test: kms_psr
results: parsing output: 51/ for test: i915_hangman
results: parsing output: 52/ for test: perf
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_async_flips
results: parsing output: 55/ for test: sw_sync
results: parsing output: 56/ for test: kms_flip_scaled_crc
results: parsing output: 57/ for test: gem_ctx_persistence
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: kms_flip
results: parsing output: 60/ for test: sw_sync
results: parsing output: 61/ for test: gem_exec_fence
results: parsing output: 62/ for test: kms_plane
results: parsing output: 63/ for test: perf_pmu
results: parsing output: 64/ for test: kms_chamelium_frames
results: parsing output: 65/ for test: kms_draw_crc
results: parsing output: 66/ for test: kms_content_protection
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: gem_exec_flush
results: parsing output: 70/ for test: kms_dither
results: parsing output: 71/ for test: gem_madvise
results: parsing output: 72/ for test: kms_plane_alpha_blend
results: parsing output: 73/ for test: kms_pipe_b_c_ivb
results: parsing output: 74/ for test: kms_flip
results: parsing output: 75/ for test: kms_cursor_crc
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: gem_mmap_offset
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_exec_nop
results: parsing output: 80/ for test: kms_flip_scaled_crc
results: parsing output: 81/ for test: gem_mmap_gtt
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: gem_exec_alignment
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: syncobj_timeline
results: parsing output: 87/ for test: i915_drm_fdinfo
results: parsing output: 88/ for test: gem_ctx_exec
results: parsing output: 89/ for test: gem_busy
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: kms_flip_scaled_crc
results: parsing output: 92/ for test: kms_vblank
results: parsing output: 93/ for test: sw_sync
results: parsing output: 94/ for test: gem_lmem_swapping
results: parsing output: 95/ for test: syncobj_wait
results: parsing output: 96/ for test: kms_pm_rpm
results: parsing output: 97/ for test: vgem_basic
results: parsing output: 98/ for test: gem_exec_reloc
results: parsing output: 99/ for test: kms_scaling_modes
results: parsing output: 100/ for test: perf_pmu
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: kms_hdr
results: parsing output: 103/ for test: syncobj_timeline
results: parsing output: 104/ for test: gem_exec_parallel
results: parsing output: 105/ for test: gem_pxp
results: parsing output: 106/ for test: gem_create
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: gem_close_race
results: parsing output: 109/ for test: gem_exec_schedule
results: parsing output: 110/ for test: gen9_exec_parse
results: parsing output: 111/ for test: kms_pm_rpm
results: parsing output: 112/ for test: kms_chamelium_hpd
results: parsing output: 113/ for test: gem_lmem_swapping
results: parsing output: 114/ for test: kms_psr2_sf
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: gem_exec_balancer
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: perf_pmu
results: parsing output: 123/ for test: kms_force_connector_basic
results: parsing output: 124/ for test: gem_ctx_param
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_cursor_legacy
results: parsing output: 127/ for test: kms_flip
results: parsing output: 128/ for test: kms_plane_scaling
results: no output, setting notrun
results: parsing output: 129/ for test: gem_exec_whisper
results: no output, setting notrun
results: parsing output: 130/ for test: kms_plane_lowres
results: no output, setting notrun
results: parsing output: 131/ for test: gem_render_copy
results: no output, setting notrun
results: parsing output: 132/ for test: prime_vgem
results: no output, setting notrun
Done.