[62.714751] Initializing watchdogs
[62.714833]   /dev/watchdog0
[62.745489] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[62.760899] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[62.765827] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.768847] [001/133] (960s left) kms_cursor_crc (cursor-offscreen-256x85)
[64.518593] Starting subtest: cursor-offscreen-256x85
[64.535949] Starting dynamic subtest: pipe-A-HDMI-A-3
[67.085147] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.549s)
[67.119954] Starting dynamic subtest: pipe-D-HDMI-A-3
[69.524812] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.411s)
[69.525680] Subtest cursor-offscreen-256x85: SUCCESS (5.005s)
[69.858620] [002/133] (953s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[71.347808] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[71.350286] Starting dynamic subtest: pipe-A-HDMI-A-3
[71.382031] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.004s)
[71.390978] Starting dynamic subtest: pipe-B-HDMI-A-3
[71.413670] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.004s)
[71.422256] Starting dynamic subtest: pipe-C-HDMI-A-3
[71.450344] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.004s)
[71.458486] Starting dynamic subtest: pipe-D-HDMI-A-3
[71.484418] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.004s)
[71.486272] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.022s)
[71.655538] [003/133] (951s left) sysfs_timeslice_duration (duration)
[71.848960] Starting subtest: duration
[71.849928] Starting dynamic subtest: vecs0
[85.004238] Dynamic subtest vecs0: SUCCESS (13.153s)
[85.013983] Starting dynamic subtest: vcs0
[98.144662] Dynamic subtest vcs0: SUCCESS (13.138s)
[98.153984] Starting dynamic subtest: bcs0
[111.305590] Dynamic subtest bcs0: SUCCESS (13.160s)
[111.315150] Starting dynamic subtest: rcs0
[124.446446] Dynamic subtest rcs0: SUCCESS (13.140s)
[124.455430] Starting dynamic subtest: vcs1
[137.582469] Dynamic subtest vcs1: SUCCESS (13.136s)
[137.583514] Subtest duration: SUCCESS (65.734s)
[137.695270] [004/133] (885s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[139.182068] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[139.183094] Starting dynamic subtest: pipe-A-HDMI-A-3
[139.186990] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[139.195143] Starting dynamic subtest: pipe-B-HDMI-A-3
[139.199122] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[139.207112] Starting dynamic subtest: pipe-C-HDMI-A-3
[139.211206] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[139.219089] Starting dynamic subtest: pipe-D-HDMI-A-3
[139.223161] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[139.225259] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SKIP (0.006s)
[139.446409] [005/133] (884s left) drm_buddy (drm_buddy)
[139.490640] Starting subtest: drm_buddy
[139.492348] Subtest drm_buddy: SKIP (0.001s)
[139.572819] [006/133] (884s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[141.081779] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[141.679931] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.598s)
[141.979682] [007/133] (881s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[143.465872] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[143.467929] Starting dynamic subtest: pipe-A-HDMI-A-3
[143.478529] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[143.486576] Starting dynamic subtest: pipe-B-HDMI-A-3
[143.496199] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[143.504198] Starting dynamic subtest: pipe-C-HDMI-A-3
[143.517964] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[143.525832] Starting dynamic subtest: pipe-D-HDMI-A-3
[143.534728] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[143.536197] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SKIP (0.006s)
[143.721710] [008/133] (880s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[145.207841] Starting subtest: bad-pixel-format-yf-tiled-ccs
[145.209875] Starting dynamic subtest: pipe-A-HDMI-A-3
[145.219060] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[145.227293] Starting dynamic subtest: pipe-B-HDMI-A-3
[145.236979] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[145.245113] Starting dynamic subtest: pipe-C-HDMI-A-3
[145.254470] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[145.262322] Starting dynamic subtest: pipe-D-HDMI-A-3
[145.272121] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[145.274047] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.006s)
[145.468657] [009/133] (878s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[145.513877] Starting subtest: multi-wait-available-unsubmitted-submitted
[145.515835] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.001s)
[145.631483] [010/133] (878s left) perf_pmu (event-wait)
[145.679887] Starting subtest: event-wait
[145.680816] Starting dynamic subtest: rcs0
[145.682612] Dynamic subtest rcs0: SKIP (0.000s)
[145.684330] Subtest event-wait: SKIP (0.000s)
[145.783978] [011/133] (878s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[147.276493] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[147.278561] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[147.441437] [012/133] (876s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[148.940334] Starting subtest: psr-rgb565-draw-mmap-gtt
[148.942109] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[149.155008] [013/133] (875s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[150.642502] Subtest psr2-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[150.711976] [014/133] (873s left) kms_psr (fbc-psr2-dpms)
[152.198846] Subtest fbc-psr2-dpms: SKIP (0.000s)
[152.379456] [015/133] (872s left) gem_exec_balancer (parallel-ordering)
[152.819811] Starting subtest: parallel-ordering
[154.966530] Subtest parallel-ordering: SUCCESS (2.147s)
[155.104601] [016/133] (869s left) kms_joiner (basic-big-joiner)
[156.592714] Starting subtest: basic-big-joiner
[156.594950] Subtest basic-big-joiner: SKIP (0.000s)
[156.720735] [017/133] (867s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[158.222829] Starting subtest: flip-vs-cursor-crc-atomic
[158.797097] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.575s)
[158.973698] [018/133] (865s left) gem_wait (wait)
[159.035626] Starting subtest: wait
[159.036523] Starting dynamic subtest: all-engines
[160.129206] Dynamic subtest all-engines: SUCCESS (1.093s)
[160.140438] Starting dynamic subtest: rcs0
[161.186726] Dynamic subtest rcs0: SUCCESS (1.056s)
[161.199234] Starting dynamic subtest: bcs0
[162.246665] Dynamic subtest bcs0: SUCCESS (1.058s)
[162.259199] Starting dynamic subtest: vcs0
[163.304694] Dynamic subtest vcs0: SUCCESS (1.057s)
[163.317215] Starting dynamic subtest: vcs1
[164.363813] Dynamic subtest vcs1: SUCCESS (1.058s)
[164.376736] Starting dynamic subtest: vecs0
[165.423764] Dynamic subtest vecs0: SUCCESS (1.058s)
[165.425893] Subtest wait: SUCCESS (6.388s)
[165.712815] [019/133] (858s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[167.204503] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[167.206157] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[167.384766] [020/133] (857s left) kms_flip (2x-flip-vs-expired-vblank)
[168.870902] Starting subtest: 2x-flip-vs-expired-vblank
[168.890458] Subtest 2x-flip-vs-expired-vblank: SKIP (0.019s)
[169.049162] [021/133] (855s left) kms_lease (page-flip-implicit-plane)
[170.535827] Starting subtest: page-flip-implicit-plane
[170.537603] Starting dynamic subtest: pipe-A-HDMI-A-3
[170.972322] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.435s)
[170.981936] Starting dynamic subtest: pipe-B-HDMI-A-3
[171.238230] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.264s)
[171.247993] Starting dynamic subtest: pipe-C-HDMI-A-3
[171.523978] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.284s)
[171.533613] Starting dynamic subtest: pipe-D-HDMI-A-3
[171.802112] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.277s)
[171.802943] Subtest page-flip-implicit-plane: SUCCESS (1.267s)
[171.980868] [022/133] (852s left) gem_exec_params (rsvd2-dirt)
[172.033262] Starting subtest: rsvd2-dirt
[172.035554] Subtest rsvd2-dirt: SKIP (0.000s)
[172.162938] [023/133] (852s left) api_intel_bb (blit-reloc-purge-cache)
[172.207539] Starting subtest: blit-reloc-purge-cache
[172.209510] Subtest blit-reloc-purge-cache: SKIP (0.001s)
[172.420822] [024/133] (852s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[173.910305] Starting subtest: fbc-shrfb-scaledprimary
[177.556774] Subtest fbc-shrfb-scaledprimary: SUCCESS (3.645s)
[177.773872] [025/133] (847s left) i915_pm_rpm (gem-idle)
[182.006400] Starting subtest: gem-idle
[188.044167] Subtest gem-idle: SUCCESS (6.041s)
[188.911103] [026/133] (836s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[190.421386] Starting subtest: x-tiled-8bpp-rotate-0
[192.140066] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.714s)
[192.335708] [027/133] (833s left) gem_exec_schedule (preempt-contexts)
[192.396419] Starting subtest: preempt-contexts
[192.397338] Starting dynamic subtest: rcs0
[192.485784] Dynamic subtest rcs0: SUCCESS (0.089s)
[192.494461] Starting dynamic subtest: bcs0
[192.557990] Dynamic subtest bcs0: SUCCESS (0.072s)
[192.566981] Starting dynamic subtest: vcs0
[192.629844] Dynamic subtest vcs0: SUCCESS (0.071s)
[192.638426] Starting dynamic subtest: vcs1
[192.700227] Dynamic subtest vcs1: SUCCESS (0.070s)
[192.708831] Starting dynamic subtest: vecs0
[192.771109] Dynamic subtest vecs0: SUCCESS (0.070s)
[192.772172] Subtest preempt-contexts: SUCCESS (0.375s)
[193.252681] [028/133] (832s left) gem_exec_flush (basic-uc-rw-default)
[193.309335] Subtest basic-uc-rw-default: SKIP (0.000s)
[193.413191] [029/133] (832s left) kms_color_pipeline (plane-lut1d)
[194.902427] Starting subtest: plane-lut1d
[195.119561] Starting dynamic subtest: pipe-A-plane-0
[195.369257] Dynamic subtest pipe-A-plane-0: SUCCESS (0.250s)
[195.404561] Starting dynamic subtest: pipe-A-plane-1
[195.569212] Dynamic subtest pipe-A-plane-1: SUCCESS (0.198s)
[195.601604] Starting dynamic subtest: pipe-A-plane-2
[195.769239] Dynamic subtest pipe-A-plane-2: SUCCESS (0.198s)
[196.067132] Starting dynamic subtest: pipe-B-plane-0
[196.237030] Dynamic subtest pipe-B-plane-0: SUCCESS (0.199s)
[196.267912] Starting dynamic subtest: pipe-B-plane-1
[196.438153] Dynamic subtest pipe-B-plane-1: SUCCESS (0.198s)
[196.465161] Starting dynamic subtest: pipe-B-plane-2
[196.636741] Dynamic subtest pipe-B-plane-2: SUCCESS (0.198s)
[196.950234] Starting dynamic subtest: pipe-C-plane-0
[197.134194] Dynamic subtest pipe-C-plane-0: SUCCESS (0.216s)
[197.166644] Starting dynamic subtest: pipe-C-plane-1
[197.350844] Dynamic subtest pipe-C-plane-1: SUCCESS (0.215s)
[197.376131] Starting dynamic subtest: pipe-C-plane-2
[197.550815] Dynamic subtest pipe-C-plane-2: SUCCESS (0.198s)
[197.868447] Starting dynamic subtest: pipe-D-plane-0
[198.056597] Dynamic subtest pipe-D-plane-0: SUCCESS (0.216s)
[198.081374] Starting dynamic subtest: pipe-D-plane-1
[198.256694] Dynamic subtest pipe-D-plane-1: SUCCESS (0.198s)
[198.278069] Starting dynamic subtest: pipe-D-plane-2
[198.456726] Dynamic subtest pipe-D-plane-2: SUCCESS (0.198s)
[198.511282] Subtest plane-lut1d: SUCCESS (3.609s)
[198.690786] [030/133] (826s left) gem_exec_schedule (deep)
[198.869514] Starting subtest: deep
[198.870512] Starting dynamic subtest: rcs0
[214.777238] Dynamic subtest rcs0: SUCCESS (15.904s)
[214.786424] Starting dynamic subtest: bcs0
[230.982475] Dynamic subtest bcs0: SUCCESS (16.205s)
[230.992340] Starting dynamic subtest: vcs0
[247.052102] Dynamic subtest vcs0: SUCCESS (16.068s)
[247.062996] Starting dynamic subtest: vcs1
[263.111818] Dynamic subtest vcs1: SUCCESS (16.060s)
[263.120983] Starting dynamic subtest: vecs0
[279.068640] Dynamic subtest vecs0: SUCCESS (15.956s)
[279.070961] Subtest deep: SUCCESS (80.197s)
[279.885289] [FACT gem_exec_schedule (deep)] new: kernel.kmod_is_loaded.vgem: true
[279.887780] [031/133] (745s left) kms_cursor_crc (cursor-suspend)
[281.435534] Starting subtest: cursor-suspend
[281.437638] Starting dynamic subtest: pipe-A-HDMI-A-3
[335.150999] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (20.613s)
[335.162773] Starting dynamic subtest: pipe-D-HDMI-A-3
[389.169214] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (20.209s)
[389.173636] Subtest cursor-suspend: SUCCESS (40.826s)
[394.835011] [032/133] (635s left) perf (gen8-unprivileged-single-ctx-counters)
[394.974687] Starting subtest: gen8-unprivileged-single-ctx-counters
[394.976616] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[395.054219] [033/133] (635s left) api_intel_bb (intel-bb-blit-y)
[395.099309] Starting subtest: intel-bb-blit-y
[396.581051] Subtest intel-bb-blit-y: SUCCESS (1.482s)
[396.739463] [034/133] (634s left) prime_mmap (test_refcounting)
[396.790212] Starting subtest: test_refcounting
[396.791030] Starting dynamic subtest: test_refcounting-smem
[396.856879] Dynamic subtest test_refcounting-smem: SUCCESS (0.066s)
[396.875515] Starting dynamic subtest: test_refcounting-lmem0
[396.924438] Dynamic subtest test_refcounting-lmem0: SUCCESS (0.066s)
[396.925978] Subtest test_refcounting: SUCCESS (0.134s)
[397.058039] [035/133] (633s left) kms_atomic_transition (modeset-transition)
[398.559882] Starting subtest: modeset-transition
[398.561014] Starting dynamic subtest: 1x-outputs
[400.406762] Dynamic subtest 1x-outputs: SUCCESS (1.847s)
[400.407584] Subtest modeset-transition: SUCCESS (1.848s)
[400.580510] [036/133] (630s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[402.238298] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[402.310340] Starting dynamic subtest: pipe-A
[403.040249] Dynamic subtest pipe-A: SUCCESS (0.821s)
[403.051878] Starting dynamic subtest: pipe-B
[403.697392] Dynamic subtest pipe-B: SUCCESS (0.756s)
[403.781123] Starting dynamic subtest: pipe-C
[404.498469] Dynamic subtest pipe-C: SUCCESS (0.757s)
[404.509778] Starting dynamic subtest: pipe-D
[405.236452] Dynamic subtest pipe-D: SUCCESS (0.773s)
[405.308239] Subtest plane-downscale-factor-0-5-with-modifiers: SUCCESS (3.112s)
[405.594411] [037/133] (625s left) kms_frontbuffer_tracking (fbc-suspend)
[407.181593] Starting subtest: fbc-suspend
[462.750989] Subtest fbc-suspend: SUCCESS (23.122s)
[465.941756] [038/133] (568s left) gem_pxp (display-protected-crc)
[468.579981] Starting subtest: display-protected-crc
[468.582544] Subtest display-protected-crc: SKIP (0.000s)
[468.692702] [039/133] (565s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[470.184507] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[470.186243] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[470.390733] [040/133] (564s left) gem_userptr_blits (dmabuf-unsync)
[470.445098] Subtest dmabuf-unsync: SKIP (0.000s)
[470.643571] [041/133] (563s left) gem_eio (context-create)
[470.836323] Starting subtest: context-create
[471.122348] Subtest context-create: SUCCESS (0.286s)
[472.711673] [042/133] (561s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[474.209913] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[474.211665] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[474.383031] [043/133] (560s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[475.875367] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[475.877128] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[476.042854] [044/133] (558s left) kms_selftest (drm_dp_mst_helper)
[476.089672] Starting subtest: drm_dp_mst_helper
[476.163356] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[476.198074] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.066s)
[476.222775] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[476.315243] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.114s)
[476.350267] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[476.404758] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.087s)
[476.405893] Subtest drm_dp_mst_helper: SUCCESS (0.315s)
[476.614695] [045/133] (558s left) gem_spin_batch (resubmit-new)
[476.670230] Starting subtest: resubmit-new
[476.671146] Starting dynamic subtest: rcs0
[476.694589] Dynamic subtest rcs0: SUCCESS (0.024s)
[476.707049] Starting dynamic subtest: bcs0
[476.707974] Dynamic subtest bcs0: SUCCESS (0.005s)
[476.720624] Starting dynamic subtest: vcs0
[476.721668] Dynamic subtest vcs0: SUCCESS (0.005s)
[476.733615] Starting dynamic subtest: vcs1
[476.734619] Dynamic subtest vcs1: SUCCESS (0.005s)
[476.746172] Starting dynamic subtest: vecs0
[476.747269] Dynamic subtest vecs0: SUCCESS (0.005s)
[476.748410] Subtest resubmit-new: SUCCESS (0.048s)
[477.081768] [046/133] (558s left) testdisplay
[483.420571] [047/133] (551s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[484.912181] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[484.994752] [048/133] (550s left) i915_selftest (live)
[485.995602] Starting subtest: live
[485.996488] Starting dynamic subtest: sanitycheck
[487.452838] Dynamic subtest sanitycheck: SUCCESS (1.457s)
[487.462586] Starting dynamic subtest: uncore
[488.946985] Dynamic subtest uncore: SUCCESS (1.493s)
[488.956921] Starting dynamic subtest: workarounds
[492.353899] Dynamic subtest workarounds: SUCCESS (3.406s)
[492.363623] Starting dynamic subtest: gt_engines
[494.386863] Dynamic subtest gt_engines: SUCCESS (2.032s)
[494.396149] Starting dynamic subtest: gt_timelines
[561.039821] Dynamic subtest gt_timelines: SUCCESS (66.646s)
[561.049283] Starting dynamic subtest: gt_contexts
[562.535839] Dynamic subtest gt_contexts: SUCCESS (1.495s)
[562.545171] Starting dynamic subtest: gt_lrc
[568.793048] Dynamic subtest gt_lrc: SUCCESS (6.256s)
[568.802400] Starting dynamic subtest: gt_mocs
[571.182903] Dynamic subtest gt_mocs: SUCCESS (2.389s)
[571.192860] Starting dynamic subtest: gt_pm
[575.204787] Dynamic subtest gt_pm: SUCCESS (4.021s)
[575.214549] Starting dynamic subtest: gt_heartbeat
[576.689797] Dynamic subtest gt_heartbeat: SUCCESS (1.484s)
[576.699941] Starting dynamic subtest: gt_tlb
[590.633960] Dynamic subtest gt_tlb: SUCCESS (13.943s)
[590.643234] Starting dynamic subtest: requests
[601.262154] Dynamic subtest requests: SUCCESS (10.627s)
[601.271484] Starting dynamic subtest: migrate
[605.933956] Dynamic subtest migrate: SUCCESS (4.670s)
[605.943385] Starting dynamic subtest: active
[607.405706] Dynamic subtest active: SUCCESS (1.470s)
[607.415668] Starting dynamic subtest: objects
[609.798717] Dynamic subtest objects: SUCCESS (2.392s)
[609.808398] Starting dynamic subtest: mman
[613.379769] Dynamic subtest mman: SUCCESS (3.580s)
[613.389500] Starting dynamic subtest: dmabuf
[614.918832] Dynamic subtest dmabuf: SUCCESS (1.538s)
[614.928413] Starting dynamic subtest: vma
[616.411974] Dynamic subtest vma: SUCCESS (1.492s)
[616.422074] Starting dynamic subtest: coherency
[626.563806] Dynamic subtest coherency: SUCCESS (10.150s)
[626.573066] Starting dynamic subtest: gtt
[635.683368] Dynamic subtest gtt: SUCCESS (9.118s)
[635.692740] Starting dynamic subtest: gem
[637.308833] Dynamic subtest gem: SUCCESS (1.624s)
[637.319057] Starting dynamic subtest: evict
[648.916144] Dynamic subtest evict: SUCCESS (11.606s)
[648.925635] Starting dynamic subtest: hugepages
[666.256282] Dynamic subtest hugepages: SUCCESS (17.339s)
[666.265727] Starting dynamic subtest: gem_contexts
[694.608058] Dynamic subtest gem_contexts: SUCCESS (28.351s)
[694.617323] Starting dynamic subtest: client
[696.126925] Dynamic subtest client: SUCCESS (1.517s)
[696.136480] Starting dynamic subtest: gem_migrate
[698.842811] Dynamic subtest gem_migrate: SUCCESS (2.714s)
[698.852638] Starting dynamic subtest: reset
[700.337823] Dynamic subtest reset: SUCCESS (1.493s)
[700.347370] Starting dynamic subtest: memory_region
[703.391846] Dynamic subtest memory_region: SUCCESS (3.053s)
[703.401258] Starting dynamic subtest: hangcheck
[730.748693] Dynamic subtest hangcheck: SUCCESS (27.360s)
[730.759889] Starting dynamic subtest: execlists
[732.211981] Dynamic subtest execlists: SUCCESS (1.458s)
[732.221956] Starting dynamic subtest: ring_submission
[733.680955] Dynamic subtest ring_submission: SUCCESS (1.467s)
[733.690921] Starting dynamic subtest: perf
[735.277628] Dynamic subtest perf: SUCCESS (1.595s)
[735.287159] Starting dynamic subtest: slpc
[741.224803] Dynamic subtest slpc: SUCCESS (5.946s)
[741.234705] Starting dynamic subtest: guc
[744.748943] Dynamic subtest guc: SUCCESS (3.523s)
[744.758211] Starting dynamic subtest: guc_multi_lrc
[746.211800] Dynamic subtest guc_multi_lrc: SUCCESS (1.461s)
[746.221361] Starting dynamic subtest: guc_hang
[748.486855] Dynamic subtest guc_hang: SUCCESS (2.274s)
[748.496773] Starting dynamic subtest: late_gt_pm
[749.987012] Dynamic subtest late_gt_pm: SUCCESS (1.498s)
[749.987956] Subtest live: SUCCESS (263.989s)
[750.036915] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[750.038265] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[750.040854] [049/133] (285s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[753.465545] Subtest writes-after-reads-uncached: SKIP (0.000s)
[753.552099] [FACT gem_partial_pwrite_pread (writes-after-reads-uncached)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[753.555575] [FACT gem_partial_pwrite_pread (writes-after-reads-uncached)] new: kernel.kmod_is_loaded.i915: true
[753.559068] [050/133] (281s left) kms_getfb (getfb-handle-not-fb)
[755.049459] Starting subtest: getfb-handle-not-fb
[755.050350] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[755.226733] [051/133] (280s left) kms_psr (fbc-psr-sprite-plane-onoff)
[756.714259] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.000s)
[756.791080] [052/133] (278s left) i915_hangman (gt-error-state-capture)
[756.852166] Starting subtest: gt-error-state-capture
[756.852991] Starting dynamic subtest: rcs0
[766.397474] Dynamic subtest rcs0: SUCCESS (9.545s)
[766.415590] Starting dynamic subtest: bcs0
[776.387071] Dynamic subtest bcs0: SUCCESS (9.988s)
[776.400782] Starting dynamic subtest: vcs0
[786.394432] Dynamic subtest vcs0: SUCCESS (10.006s)
[786.414950] Starting dynamic subtest: vcs1
[796.369391] Dynamic subtest vcs1: SUCCESS (9.973s)
[796.382599] Starting dynamic subtest: vecs0
[806.348426] Dynamic subtest vecs0: SUCCESS (9.978s)
[806.349453] Subtest gt-error-state-capture: SUCCESS (49.498s)
[806.546467] [053/133] (229s left) perf (invalid-open-flags)
[806.710309] Starting subtest: invalid-open-flags
[806.711199] Subtest invalid-open-flags: SUCCESS (0.000s)
[806.806636] [054/133] (228s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[808.297977] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[808.299808] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[808.493964] [055/133] (227s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[809.990742] Starting subtest: async-flip-with-page-flip-events-linear
[810.230762] Starting dynamic subtest: pipe-A-HDMI-A-3
[812.550170] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.315s)
[812.772945] Starting dynamic subtest: pipe-B-HDMI-A-3
[814.833825] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (2.067s)
[815.039489] Starting dynamic subtest: pipe-C-HDMI-A-3
[817.096842] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (2.063s)
[817.309916] Starting dynamic subtest: pipe-D-HDMI-A-3
[819.375406] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.071s)
[819.376537] Subtest async-flip-with-page-flip-events-linear: SUCCESS (9.383s)
[819.738311] [056/133] (216s left) sw_sync (alloc_fence)
[819.783302] Starting subtest: alloc_fence
[819.784196] Subtest alloc_fence: SUCCESS (0.000s)
[819.872735] [057/133] (216s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[821.360354] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[821.361301] Starting dynamic subtest: pipe-A-valid-mode
[822.596185] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.234s)
[822.597096] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SUCCESS (1.236s)
[822.789140] [058/133] (213s left) gem_ctx_persistence (heartbeat-close)
[822.840565] Starting subtest: heartbeat-close
[822.842535] Subtest heartbeat-close: SKIP (0.000s)
[822.957889] [059/133] (213s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[824.466967] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[824.468801] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[824.618182] [060/133] (211s left) kms_flip (2x-flip-vs-modeset)
[826.107448] Starting subtest: 2x-flip-vs-modeset
[826.126317] Subtest 2x-flip-vs-modeset: SKIP (0.019s)
[826.286048] [061/133] (210s left) sw_sync (alloc_timeline)
[826.330737] Starting subtest: alloc_timeline
[826.331753] Subtest alloc_timeline: SUCCESS (0.000s)
[826.422959] [062/133] (209s left) gem_exec_fence (syncobj-timeline-chain-engines)
[826.970353] Starting subtest: syncobj-timeline-chain-engines
[827.112409] Subtest syncobj-timeline-chain-engines: SUCCESS (0.146s)
[827.448083] [063/133] (209s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[828.935478] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[828.972415] Starting dynamic subtest: pipe-A-plane-0
[829.506281] Dynamic subtest pipe-A-plane-0: SUCCESS (0.533s)
[829.522579] Starting dynamic subtest: pipe-A-plane-3
[829.838542] Dynamic subtest pipe-A-plane-3: SUCCESS (0.328s)
[829.869621] Starting dynamic subtest: pipe-A-plane-5
[830.155488] Dynamic subtest pipe-A-plane-5: SUCCESS (0.314s)
[830.324924] Starting dynamic subtest: pipe-B-plane-0
[830.714172] Dynamic subtest pipe-B-plane-0: SUCCESS (0.399s)
[830.755775] Starting dynamic subtest: pipe-B-plane-3
[831.030521] Dynamic subtest pipe-B-plane-3: SUCCESS (0.311s)
[831.078476] Starting dynamic subtest: pipe-B-plane-5
[831.363562] Dynamic subtest pipe-B-plane-5: SUCCESS (0.328s)
[831.435743] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.501s)
[831.622923] [064/133] (204s left) perf_pmu (all-busy-check-all)
[831.674322] Starting subtest: all-busy-check-all
[832.258716] Subtest all-busy-check-all: SUCCESS (0.584s)
[832.376178] [065/133] (204s left) kms_chamelium_frames (hdmi-crc-single)
[833.912221] Subtest hdmi-crc-single: SKIP (0.000s)
[834.037283] [066/133] (202s left) kms_draw_crc (draw-method-mmap-wc)
[835.526856] Starting subtest: draw-method-mmap-wc
[835.529099] Subtest draw-method-mmap-wc: SKIP (0.000s)
[835.702952] [067/133] (201s left) kms_content_protection (atomic)
[837.247416] Starting subtest: atomic
[837.256040] Subtest atomic: SKIP (0.006s)
[837.462048] [068/133] (199s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[838.949516] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[838.950444] Starting dynamic subtest: pipe-A-HDMI-A-3
[838.959169] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[838.972159] Starting dynamic subtest: pipe-B-HDMI-A-3
[838.980696] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[838.993476] Starting dynamic subtest: pipe-C-HDMI-A-3
[839.003056] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[839.015924] Starting dynamic subtest: pipe-D-HDMI-A-3
[839.025264] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[839.027137] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.011s)
[839.222646] [069/133] (197s left) kms_psr (pr-primary-render)
[840.710256] Subtest pr-primary-render: SKIP (0.000s)
[840.898971] [070/133] (196s left) gem_exec_flush (basic-uc-ro-default)
[840.949792] Subtest basic-uc-ro-default: SKIP (0.000s)
[841.054420] [071/133] (196s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[842.542345] Starting subtest: fb-8bpc-vs-panel-8bpc
[842.544846] Subtest fb-8bpc-vs-panel-8bpc: SKIP (0.001s)
[842.690379] [072/133] (194s left) gem_madvise (dontneed-after-mmap)
[842.734794] Starting subtest: dontneed-after-mmap
[842.739636] Subtest dontneed-after-mmap: SUCCESS (0.004s)
[842.911353] [073/133] (194s left) kms_plane_alpha_blend (constant-alpha-mid)
[844.399435] Starting subtest: constant-alpha-mid
[844.663925] Starting dynamic subtest: pipe-A-HDMI-A-3
[845.358336] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.694s)
[845.373099] Starting dynamic subtest: pipe-D-HDMI-A-3
[846.049216] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.689s)
[846.050044] Subtest constant-alpha-mid: SUCCESS (1.652s)
[846.252551] [074/133] (191s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[846.298481] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[846.378898] [075/133] (191s left) kms_flip (2x-flip-vs-wf_vblank)
[847.868188] Starting subtest: 2x-flip-vs-wf_vblank
[847.887032] Subtest 2x-flip-vs-wf_vblank: SKIP (0.019s)
[848.027619] [076/133] (189s left) kms_cursor_crc (cursor-sliding-128x42)
[849.718242] Starting subtest: cursor-sliding-128x42
[849.724763] Starting dynamic subtest: pipe-A-HDMI-A-3
[854.155256] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (4.429s)
[854.195108] Starting dynamic subtest: pipe-D-HDMI-A-3
[858.494182] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (4.312s)
[858.495096] Subtest cursor-sliding-128x42: SUCCESS (8.777s)
[858.874677] [077/133] (178s left) kms_psr (psr2-suspend)
[860.361469] Subtest psr2-suspend: SKIP (0.000s)
[860.450051] [078/133] (177s left) gem_mmap_offset (open-flood)
[860.496472] Starting subtest: open-flood
[881.982401] Subtest open-flood: SUCCESS (21.487s)
[882.142214] [079/133] (155s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[883.636249] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[883.638053] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[883.838729] [080/133] (154s left) gem_exec_nop (basic-sequential)
[883.900265] Starting subtest: basic-sequential
[887.636380] Subtest basic-sequential: SUCCESS (3.735s)
[887.892618] [081/133] (150s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[889.379187] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[889.380996] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[889.492321] [082/133] (148s left) gem_mmap_gtt (basic-small-bo-tiledy)
[889.544017] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[889.616455] [083/133] (148s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[891.122356] Starting subtest: y-tiled-64bpp-rotate-90
[891.196574] Subtest y-tiled-64bpp-rotate-90: SKIP (0.072s)
[891.362076] [084/133] (147s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[892.853500] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[892.855199] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[892.997779] [085/133] (145s left) gem_exec_alignment (single)
[893.050957] Starting subtest: single
[893.058533] Subtest single: SUCCESS (0.008s)
[893.232791] [086/133] (145s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[894.725735] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[894.727385] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[894.900102] [087/133] (143s left) syncobj_timeline (etime-single-wait-submitted)
[894.946664] Starting subtest: etime-single-wait-submitted
[895.052505] Subtest etime-single-wait-submitted: SUCCESS (0.104s)
[895.230979] [088/133] (143s left) i915_drm_fdinfo (virtual-busy-all)
[895.279538] Starting subtest: virtual-busy-all
[895.281163] Subtest virtual-busy-all: SKIP (0.000s)
[895.400634] [089/133] (143s left) gem_ctx_exec (basic)
[895.448168] Starting subtest: basic
[895.453078] Subtest basic: SUCCESS (0.006s)
[895.629848] [090/133] (143s left) gem_busy (parallel)
[895.824603] Starting subtest: parallel
[895.825562] Starting dynamic subtest: rcs0
[895.939884] Dynamic subtest rcs0: SUCCESS (0.114s)
[895.958183] Starting dynamic subtest: bcs0
[895.998569] Dynamic subtest bcs0: SUCCESS (0.057s)
[896.018830] Starting dynamic subtest: vcs0
[896.057851] Dynamic subtest vcs0: SUCCESS (0.058s)
[896.090850] Starting dynamic subtest: vcs1
[896.130594] Dynamic subtest vcs1: SUCCESS (0.071s)
[896.156158] Starting dynamic subtest: vecs0
[896.197737] Dynamic subtest vecs0: SUCCESS (0.065s)
[896.198881] Subtest parallel: SUCCESS (0.374s)
[896.467169] [091/133] (142s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[896.611892] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[896.627948] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[896.795721] [092/133] (142s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[898.348833] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[898.351248] Starting dynamic subtest: pipe-A-valid-mode
[899.580281] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.229s)
[899.581172] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SUCCESS (1.232s)
[899.764120] [093/133] (139s left) kms_vblank (ts-continuation-dpms-rpm)
[901.252247] Starting subtest: ts-continuation-dpms-rpm
[901.253256] Starting dynamic subtest: pipe-A-HDMI-A-3
[903.710726] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.456s)
[903.726919] Starting dynamic subtest: pipe-D-HDMI-A-3
[905.755134] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.040s)
[905.756105] Subtest ts-continuation-dpms-rpm: SUCCESS (4.504s)
[905.939919] [094/133] (133s left) sw_sync (timeline_closed_signaled)
[905.985270] Starting subtest: timeline_closed_signaled
[905.986147] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[906.075514] [095/133] (133s left) gem_lmem_swapping (verify)
[910.342999] Starting subtest: verify
[910.343922] Starting dynamic subtest: lmem0
[951.311219] Dynamic subtest lmem0: SUCCESS (40.966s)
[951.312273] Subtest verify: SUCCESS (40.967s)
[952.740761] [FACT gem_lmem_swapping (verify)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[952.742079] [FACT gem_lmem_swapping (verify)] deleted: kernel.kmod_is_loaded.i915: true
[952.744587] [096/133] ( 86s left) syncobj_wait (invalid-signal-zero-handles)
[956.171285] Starting subtest: invalid-signal-zero-handles
[956.172112] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[956.257922] [FACT syncobj_wait (invalid-signal-zero-handles)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[956.261460] [FACT syncobj_wait (invalid-signal-zero-handles)] new: kernel.kmod_is_loaded.i915: true
[956.264812] [097/133] ( 83s left) kms_pm_rpm (i2c)
[960.412092] Starting subtest: i2c
[965.053718] Subtest i2c: SUCCESS (4.643s)
[965.914715] [098/133] ( 73s left) vgem_basic (setversion)
[965.985521] Starting subtest: setversion
[965.987369] Subtest setversion: SUCCESS (0.000s)
[966.099256] [099/133] ( 73s left) gem_exec_reloc (basic-write-gtt)
[966.155757] Subtest basic-write-gtt: SKIP (0.000s)
[966.266182] [100/133] ( 73s left) kms_scaling_modes (scaling-mode-center)
[967.753316] Starting subtest: scaling-mode-center
[967.758353] Subtest scaling-mode-center: SKIP (0.002s)
[967.888319] [101/133] ( 71s left) perf_pmu (frequency)
[967.956206] Starting subtest: frequency
[967.960922] Starting dynamic subtest: gt0
[970.203414] Dynamic subtest gt0: FAIL (2.174s)
[970.239658] Starting dynamic subtest: idle-gt0
[970.646239] Dynamic subtest idle-gt0: SUCCESS (0.504s)
[970.647193] Subtest frequency: FAIL (2.690s)
[970.786603] [102/133] ( 69s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[972.293819] Starting subtest: 4-tiled-32bpp-rotate-180
[972.295478] Subtest 4-tiled-32bpp-rotate-180: SKIP (0.000s)
[972.459823] [103/133] ( 67s left) kms_hdr (bpc-switch-dpms)
[973.950397] Starting subtest: bpc-switch-dpms
[973.952974] Subtest bpc-switch-dpms: SKIP (0.001s)
[974.104657] [104/133] ( 66s left) syncobj_timeline (wait-any-interrupted)
[974.155518] Starting subtest: wait-any-interrupted
[974.263078] Subtest wait-any-interrupted: SUCCESS (0.103s)
[974.436753] [105/133] ( 65s left) gem_exec_parallel (contexts)
[974.494837] Starting subtest: contexts
[974.495944] Starting dynamic subtest: rcs0
[978.817518] Dynamic subtest rcs0: SUCCESS (4.318s)
[978.829594] Starting dynamic subtest: bcs0
[983.422993] Dynamic subtest bcs0: SUCCESS (4.604s)
[983.435290] Starting dynamic subtest: vcs0
[987.589230] Dynamic subtest vcs0: SUCCESS (4.165s)
[987.601457] Starting dynamic subtest: vcs1
[991.800223] Dynamic subtest vcs1: SUCCESS (4.209s)
[991.812661] Starting dynamic subtest: vecs0
[996.091568] Dynamic subtest vecs0: SUCCESS (4.290s)
[996.092825] Subtest contexts: SUCCESS (21.593s)
[996.357062] [106/133] ( 43s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[998.927616] Starting subtest: verify-pxp-key-change-after-suspend-resume
[998.930195] Subtest verify-pxp-key-change-after-suspend-resume: SKIP (0.000s)
[999.048821] [107/133] ( 41s left) gem_create (create-ext-placement-each)
[999.212625] Starting subtest: create-ext-placement-each
[999.213840] Subtest create-ext-placement-each: SUCCESS (0.000s)
[999.393638] [108/133] ( 41s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[1000.881391] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[1000.882246] Starting dynamic subtest: pipe-A-HDMI-A-3
[1000.890479] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[1000.903032] Starting dynamic subtest: pipe-B-HDMI-A-3
[1000.911501] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[1000.923903] Starting dynamic subtest: pipe-C-HDMI-A-3
[1000.932565] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[1000.944655] Starting dynamic subtest: pipe-D-HDMI-A-3
[1000.953309] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[1000.954973] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SKIP (0.011s)
[1001.151134] [109/133] ( 39s left) gem_close_race (basic-process)
[1001.226684] Starting subtest: basic-process
[1001.281511] Subtest basic-process: SUCCESS (0.055s)
[1001.646726] [110/133] ( 39s left) gem_exec_schedule (u-independent)
[1001.707507] Starting subtest: u-independent
[1001.708433] Starting dynamic subtest: rcs0
[1001.962475] Dynamic subtest rcs0: SUCCESS (0.256s)
[1001.977440] Starting dynamic subtest: bcs0
[1002.179182] Dynamic subtest bcs0: SUCCESS (0.215s)
[1002.193226] Starting dynamic subtest: vcs0
[1002.382187] Dynamic subtest vcs0: SUCCESS (0.201s)
[1002.397027] Starting dynamic subtest: vcs1
[1002.583234] Dynamic subtest vcs1: SUCCESS (0.199s)
[1002.603230] Starting dynamic subtest: vecs0
[1002.801571] Dynamic subtest vecs0: SUCCESS (0.216s)
[1002.805500] Subtest u-independent: SUCCESS (1.097s)
[1003.189334] [111/133] ( 37s left) gen9_exec_parse (batch-without-end)
[1003.240861] Subtest batch-without-end: SKIP (0.000s)
[1003.330708] [112/133] ( 37s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[1007.460383] Starting subtest: dpms-mode-unset-lpsp
[1008.405001] Subtest dpms-mode-unset-lpsp: SKIP (0.952s)
[1009.396573] [113/133] ( 31s left) kms_chamelium_hpd (vga-hpd)
[1010.932161] Subtest vga-hpd: SKIP (0.000s)
[1011.057999] [114/133] ( 29s left) gem_lmem_swapping (heavy-multi)
[1015.369766] Starting subtest: heavy-multi
[1015.372520] Starting dynamic subtest: lmem0
[1021.348344] Dynamic subtest lmem0: SUCCESS (5.973s)
[1021.349338] Subtest heavy-multi: SUCCESS (5.975s)
[1022.652355] [FACT gem_lmem_swapping (heavy-multi)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[1022.653464] [FACT gem_lmem_swapping (heavy-multi)] deleted: kernel.kmod_is_loaded.i915: true
[1022.656260] [115/133] ( 18s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[1027.529960] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[1027.728100] [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
[1027.731546] [FACT kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)] new: kernel.kmod_is_loaded.i915: true
[1027.739330] [116/133] ( 13s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[1029.232835] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[1029.234541] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[1029.397142] [117/133] ( 11s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[1030.893187] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[1033.946845] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (3.053s)
[1034.182981] [118/133] (  7s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[1035.696044] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[1035.697846] Subtest psr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[1035.867221] [119/133] (  5s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[1037.361724] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[1037.363310] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[1037.563858] [120/133] (  4s left) gem_exec_balancer (noheartbeat)
[1038.006654] Starting subtest: noheartbeat
[1038.008502] Subtest noheartbeat: SKIP (0.000s)
[1038.115979] [121/133] (  3s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[1038.172533] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[1038.278910] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.102s)
[1038.413695] [122/133] (  3s left) kms_big_fb (linear-addfb)
[1039.920848] Starting subtest: linear-addfb
[1039.921856] Subtest linear-addfb: SUCCESS (0.000s)
[1040.121728] [123/133] (  1s left) perf_pmu (busy)
[1040.172849] Starting subtest: busy
[1040.173767] Starting dynamic subtest: rcs0
[1040.776616] Dynamic subtest rcs0: SUCCESS (0.602s)
[1040.792926] Starting dynamic subtest: bcs0
[1041.341537] Dynamic subtest bcs0: SUCCESS (0.559s)
[1041.357906] Starting dynamic subtest: vcs0
[1041.905556] Dynamic subtest vcs0: SUCCESS (0.558s)
[1041.922261] Starting dynamic subtest: vcs1
[1042.471459] Dynamic subtest vcs1: SUCCESS (0.560s)
[1042.487988] Starting dynamic subtest: vecs0
[1043.034157] Dynamic subtest vecs0: SUCCESS (0.558s)
[1043.037915] Subtest busy: SUCCESS (2.863s)
[1043.140107] Overall timeout time exceeded, stopping.
[1043.193551] 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: no output, setting notrun
results: parsing output: 124/ for test: gem_ctx_param
results: no output, setting notrun
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 126/ for test: kms_cursor_legacy
results: no output, setting notrun
results: parsing output: 127/ for test: kms_flip
results: no output, setting notrun
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.