[64.990793] Initializing watchdogs
[64.990859]   /dev/watchdog0
[65.010730] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[65.021739] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[65.025635] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[65.028299] [001/132] (960s left) gem_pxp (verify-pxp-stale-ctx-execution)
[67.623421] Starting subtest: verify-pxp-stale-ctx-execution
[67.625392] Subtest verify-pxp-stale-ctx-execution: SKIP (0.000s)
[67.755723] [002/132] (957s left) kms_color_pipeline (plane-lut1d-lut1d)
[67.970854] Starting subtest: plane-lut1d-lut1d
[68.016288] Starting dynamic subtest: pipe-A-DP-3
[68.415040] Dynamic subtest pipe-A-DP-3: SUCCESS (0.398s)
[68.621832] Starting dynamic subtest: pipe-B-DP-3
[68.962135] Dynamic subtest pipe-B-DP-3: SUCCESS (0.348s)
[69.136031] Starting dynamic subtest: pipe-C-DP-3
[69.477314] Dynamic subtest pipe-C-DP-3: SUCCESS (0.348s)
[69.652169] Starting dynamic subtest: pipe-D-DP-3
[69.993554] Dynamic subtest pipe-D-DP-3: SUCCESS (0.349s)
[70.099270] Subtest plane-lut1d-lut1d: SUCCESS (2.129s)
[70.397039] [003/132] (955s left) template (a)
[70.467960] Starting subtest: A
[70.469163] Subtest A: SUCCESS (0.000s)
[70.659561] [004/132] (955s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[70.840906] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[70.841809] Starting dynamic subtest: pipe-A-valid-mode
[72.683978] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.842s)
[72.685742] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (1.843s)
[73.038541] [005/132] (952s left) gem_mmap_offset (partial-remap)
[73.108926] Starting subtest: partial-remap
[73.109814] Starting dynamic subtest: lmem0
[73.112317] Dynamic subtest lmem0: SUCCESS (0.004s)
[73.121404] Starting dynamic subtest: smem0
[73.123799] Dynamic subtest smem0: SUCCESS (0.004s)
[73.124971] Subtest partial-remap: SUCCESS (0.008s)
[73.300490] [006/132] (952s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[73.550130] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[73.688767] [007/132] (952s left) kms_frontbuffer_tracking (fbc-tiling-y)
[73.871402] Starting subtest: fbc-tiling-y
[73.873076] Subtest fbc-tiling-y: SKIP (0.000s)
[74.065304] [008/132] (951s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[74.244863] Starting subtest: flip-vs-cursor-varying-size
[86.674375] Subtest flip-vs-cursor-varying-size: SUCCESS (12.433s)
[86.972617] [009/132] (939s left) kms_plane_cursor (primary)
[87.148261] Starting subtest: primary
[87.150126] Starting dynamic subtest: pipe-A-DP-3-size-64
[90.247130] Dynamic subtest pipe-A-DP-3-size-64: SUCCESS (3.098s)
[90.306608] Starting dynamic subtest: pipe-A-DP-3-size-128
[93.397641] Dynamic subtest pipe-A-DP-3-size-128: SUCCESS (3.100s)
[93.458446] Starting dynamic subtest: pipe-A-DP-3-size-256
[96.580785] Dynamic subtest pipe-A-DP-3-size-256: SUCCESS (3.133s)
[96.733059] Starting dynamic subtest: pipe-B-DP-3-size-64
[99.935971] Dynamic subtest pipe-B-DP-3-size-64: SUCCESS (3.213s)
[99.976852] Starting dynamic subtest: pipe-B-DP-3-size-128
[103.103368] Dynamic subtest pipe-B-DP-3-size-128: SUCCESS (3.134s)
[103.147834] Starting dynamic subtest: pipe-B-DP-3-size-256
[106.253166] Dynamic subtest pipe-B-DP-3-size-256: SUCCESS (3.117s)
[106.355612] Starting dynamic subtest: pipe-C-DP-3-size-64
[109.510995] Dynamic subtest pipe-C-DP-3-size-64: SUCCESS (3.164s)
[109.550484] Starting dynamic subtest: pipe-C-DP-3-size-128
[112.626762] Dynamic subtest pipe-C-DP-3-size-128: SUCCESS (3.083s)
[112.667611] Starting dynamic subtest: pipe-C-DP-3-size-256
[115.777070] Dynamic subtest pipe-C-DP-3-size-256: SUCCESS (3.117s)
[115.877642] Starting dynamic subtest: pipe-D-DP-3-size-64
[119.034160] Dynamic subtest pipe-D-DP-3-size-64: SUCCESS (3.164s)
[119.073709] Starting dynamic subtest: pipe-D-DP-3-size-128
[122.184168] Dynamic subtest pipe-D-DP-3-size-128: SUCCESS (3.117s)
[122.223787] Starting dynamic subtest: pipe-D-DP-3-size-256
[125.334300] Dynamic subtest pipe-D-DP-3-size-256: SUCCESS (3.117s)
[125.426331] Subtest primary: SUCCESS (38.280s)
[125.732078] [010/132] (900s left) gem_ctx_persistence (saturated-hostile)
[125.808965] Starting subtest: saturated-hostile
[125.809927] Starting dynamic subtest: rcs0
[126.658403] Dynamic subtest rcs0: SUCCESS (0.848s)
[126.668595] Starting dynamic subtest: bcs0
[127.442024] Dynamic subtest bcs0: SUCCESS (0.783s)
[127.450693] Starting dynamic subtest: vcs0
[128.238993] Dynamic subtest vcs0: SUCCESS (0.797s)
[128.247506] Starting dynamic subtest: vcs1
[129.034086] Dynamic subtest vcs1: SUCCESS (0.794s)
[129.057620] Starting dynamic subtest: vecs0
[129.830481] Dynamic subtest vecs0: SUCCESS (0.795s)
[129.839444] Starting dynamic subtest: vecs1
[130.617923] Dynamic subtest vecs1: SUCCESS (0.786s)
[130.627577] Starting dynamic subtest: ccs0
[131.439236] Dynamic subtest ccs0: SUCCESS (0.820s)
[131.440847] Subtest saturated-hostile: SUCCESS (5.631s)
[131.611446] [011/132] (894s left) gem_ctx_shared (q-out-order)
[131.691404] Starting subtest: Q-out-order
[131.692350] Starting dynamic subtest: rcs0
[132.000745] Dynamic subtest rcs0: SUCCESS (0.309s)
[132.010078] Starting dynamic subtest: bcs0
[132.180264] Dynamic subtest bcs0: SUCCESS (0.179s)
[132.189278] Starting dynamic subtest: vcs0
[132.368246] Dynamic subtest vcs0: SUCCESS (0.187s)
[132.377374] Starting dynamic subtest: vcs1
[132.554781] Dynamic subtest vcs1: SUCCESS (0.186s)
[132.564145] Starting dynamic subtest: vecs0
[132.742608] Dynamic subtest vecs0: SUCCESS (0.187s)
[132.751493] Starting dynamic subtest: vecs1
[132.955429] Dynamic subtest vecs1: SUCCESS (0.212s)
[132.964575] Starting dynamic subtest: ccs0
[133.142358] Dynamic subtest ccs0: SUCCESS (0.186s)
[133.143296] Subtest Q-out-order: SUCCESS (1.451s)
[133.475525] [FACT gem_ctx_shared (q-out-order)] new: kernel.kmod_is_loaded.vgem: true
[133.477497] [012/132] (892s left) gem_exec_params (larger-than-life-batch)
[133.565417] Starting subtest: larger-than-life-batch
[143.503712] Subtest larger-than-life-batch: SUCCESS (9.938s)
[144.058658] [013/132] (882s left) gem_mmap_offset (pf-nonblock)
[144.174157] Starting subtest: pf-nonblock
[144.208096] Subtest pf-nonblock: SUCCESS (0.035s)
[144.468727] [014/132] (881s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[144.654504] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[144.655389] Starting dynamic subtest: pipe-A-DP-3
[144.658877] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[144.668138] Starting dynamic subtest: pipe-B-DP-3
[144.671421] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[144.680465] Starting dynamic subtest: pipe-C-DP-3
[144.683904] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[144.692920] Starting dynamic subtest: pipe-D-DP-3
[144.696243] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[144.697934] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[145.089608] [015/132] (881s left) vgem_basic (bad-flag)
[145.148353] Starting subtest: bad-flag
[145.149262] Subtest bad-flag: SUCCESS (0.000s)
[145.274098] [016/132] (881s left) vgem_basic (dmabuf-fence-before)
[145.331895] Starting subtest: dmabuf-fence-before
[145.332942] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[145.488618] [017/132] (881s left) gem_eio (wait-1us)
[145.784784] Starting subtest: wait-1us
[146.391381] Subtest wait-1us: SUCCESS (0.607s)
[146.674240] [018/132] (880s left) kms_pm_rpm (pm-caching)
[149.003177] Starting subtest: pm-caching
[149.005633] Subtest pm-caching: SKIP (0.000s)
[149.359009] [019/132] (877s left) gem_exec_balancer (bonded-pair)
[149.453925] Starting subtest: bonded-pair
[149.456217] Subtest bonded-pair: SKIP (0.000s)
[149.917602] [020/132] (876s left) kms_psr (fbc-psr-suspend)
[150.102912] Subtest fbc-psr-suspend: SKIP (0.000s)
[150.166694] [021/132] (876s left) gem_exec_reloc (basic-wc)
[150.251853] Subtest basic-wc: SKIP (0.000s)
[150.338122] [022/132] (876s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[150.529553] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[150.531241] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[150.724062] [023/132] (876s left) i915_drm_fdinfo (memory-info-purgeable)
[150.795940] Starting subtest: memory-info-purgeable
[150.796966] Starting dynamic subtest: lmem0
[154.117140] Dynamic subtest lmem0: SUCCESS (3.320s)
[154.146236] Starting dynamic subtest: smem0
[158.509070] Dynamic subtest smem0: SUCCESS (4.387s)
[158.512640] Subtest memory-info-purgeable: SUCCESS (7.710s)
[158.648204] [024/132] (868s left) kms_hdr (invalid-hdr)
[158.838037] Starting subtest: invalid-hdr
[158.840644] Subtest invalid-hdr: SKIP (0.000s)
[159.004596] [025/132] (868s left) kms_flip_tiling (flip-change-tiling)
[159.188455] Starting subtest: flip-change-tiling
[159.189392] Starting dynamic subtest: pipe-A-DP-3-4-to-4
[159.441927] Dynamic subtest pipe-A-DP-3-4-to-4: SUCCESS (0.251s)
[159.479861] Starting dynamic subtest: pipe-A-DP-3-4-to-x
[159.658584] Dynamic subtest pipe-A-DP-3-4-to-x: SUCCESS (0.215s)
[159.698784] Starting dynamic subtest: pipe-A-DP-3-4-to-linear
[159.875184] Dynamic subtest pipe-A-DP-3-4-to-linear: SUCCESS (0.215s)
[159.889920] Starting dynamic subtest: pipe-A-DP-3-x-to-4
[160.058579] Dynamic subtest pipe-A-DP-3-x-to-4: SUCCESS (0.181s)
[160.096596] Starting dynamic subtest: pipe-A-DP-3-x-to-x
[160.241724] Dynamic subtest pipe-A-DP-3-x-to-x: SUCCESS (0.181s)
[160.281859] Starting dynamic subtest: pipe-A-DP-3-x-to-linear
[160.458797] Dynamic subtest pipe-A-DP-3-x-to-linear: SUCCESS (0.214s)
[160.497983] Starting dynamic subtest: pipe-A-DP-3-linear-to-4
[160.675250] Dynamic subtest pipe-A-DP-3-linear-to-4: SUCCESS (0.215s)
[160.714768] Starting dynamic subtest: pipe-A-DP-3-linear-to-x
[160.891297] Dynamic subtest pipe-A-DP-3-linear-to-x: SUCCESS (0.214s)
[160.909595] Starting dynamic subtest: pipe-A-DP-3-linear-to-linear
[161.058530] Dynamic subtest pipe-A-DP-3-linear-to-linear: SUCCESS (0.166s)
[161.123258] Starting dynamic subtest: pipe-B-DP-3-4-to-4
[161.446683] Dynamic subtest pipe-B-DP-3-4-to-4: SUCCESS (0.329s)
[161.461172] Starting dynamic subtest: pipe-B-DP-3-4-to-x
[161.588402] Dynamic subtest pipe-B-DP-3-4-to-x: SUCCESS (0.148s)
[161.612134] Starting dynamic subtest: pipe-B-DP-3-4-to-linear
[161.738284] Dynamic subtest pipe-B-DP-3-4-to-linear: SUCCESS (0.149s)
[161.758342] Starting dynamic subtest: pipe-B-DP-3-x-to-4
[161.888235] Dynamic subtest pipe-B-DP-3-x-to-4: SUCCESS (0.149s)
[161.910889] Starting dynamic subtest: pipe-B-DP-3-x-to-x
[162.038373] Dynamic subtest pipe-B-DP-3-x-to-x: SUCCESS (0.149s)
[162.058377] Starting dynamic subtest: pipe-B-DP-3-x-to-linear
[162.188426] Dynamic subtest pipe-B-DP-3-x-to-linear: SUCCESS (0.149s)
[162.216477] Starting dynamic subtest: pipe-B-DP-3-linear-to-4
[162.355073] Dynamic subtest pipe-B-DP-3-linear-to-4: SUCCESS (0.166s)
[162.383342] Starting dynamic subtest: pipe-B-DP-3-linear-to-x
[162.521894] Dynamic subtest pipe-B-DP-3-linear-to-x: SUCCESS (0.166s)
[162.535481] Starting dynamic subtest: pipe-B-DP-3-linear-to-linear
[162.655071] Dynamic subtest pipe-B-DP-3-linear-to-linear: SUCCESS (0.132s)
[162.698629] Starting dynamic subtest: pipe-C-DP-3-4-to-4
[163.034233] Dynamic subtest pipe-C-DP-3-4-to-4: SUCCESS (0.331s)
[163.065193] Starting dynamic subtest: pipe-C-DP-3-4-to-x
[163.187283] Dynamic subtest pipe-C-DP-3-4-to-x: SUCCESS (0.165s)
[163.210997] Starting dynamic subtest: pipe-C-DP-3-4-to-linear
[163.337250] Dynamic subtest pipe-C-DP-3-4-to-linear: SUCCESS (0.149s)
[163.361072] Starting dynamic subtest: pipe-C-DP-3-x-to-4
[163.487132] Dynamic subtest pipe-C-DP-3-x-to-4: SUCCESS (0.149s)
[163.507626] Starting dynamic subtest: pipe-C-DP-3-x-to-x
[163.637212] Dynamic subtest pipe-C-DP-3-x-to-x: SUCCESS (0.149s)
[163.649513] Starting dynamic subtest: pipe-C-DP-3-x-to-linear
[163.770637] Dynamic subtest pipe-C-DP-3-x-to-linear: SUCCESS (0.132s)
[163.784224] Starting dynamic subtest: pipe-C-DP-3-linear-to-4
[163.903948] Dynamic subtest pipe-C-DP-3-linear-to-4: SUCCESS (0.132s)
[163.934325] Starting dynamic subtest: pipe-C-DP-3-linear-to-x
[164.071067] Dynamic subtest pipe-C-DP-3-linear-to-x: SUCCESS (0.166s)
[164.107218] Starting dynamic subtest: pipe-C-DP-3-linear-to-linear
[164.237370] Dynamic subtest pipe-C-DP-3-linear-to-linear: SUCCESS (0.165s)
[164.280952] Starting dynamic subtest: pipe-D-DP-3-4-to-4
[164.607446] Dynamic subtest pipe-D-DP-3-4-to-4: SUCCESS (0.328s)
[164.641211] Starting dynamic subtest: pipe-D-DP-3-4-to-x
[164.765973] Dynamic subtest pipe-D-DP-3-4-to-x: SUCCESS (0.164s)
[164.786134] Starting dynamic subtest: pipe-D-DP-3-4-to-linear
[164.916988] Dynamic subtest pipe-D-DP-3-4-to-linear: SUCCESS (0.149s)
[164.955557] Starting dynamic subtest: pipe-D-DP-3-x-to-4
[165.082653] Dynamic subtest pipe-D-DP-3-x-to-4: SUCCESS (0.164s)
[165.105402] Starting dynamic subtest: pipe-D-DP-3-x-to-x
[165.232627] Dynamic subtest pipe-D-DP-3-x-to-x: SUCCESS (0.149s)
[165.252221] Starting dynamic subtest: pipe-D-DP-3-x-to-linear
[165.382802] Dynamic subtest pipe-D-DP-3-x-to-linear: SUCCESS (0.149s)
[165.396375] Starting dynamic subtest: pipe-D-DP-3-linear-to-4
[165.516161] Dynamic subtest pipe-D-DP-3-linear-to-4: SUCCESS (0.132s)
[165.529377] Starting dynamic subtest: pipe-D-DP-3-linear-to-x
[165.649337] Dynamic subtest pipe-D-DP-3-linear-to-x: SUCCESS (0.132s)
[165.673139] Starting dynamic subtest: pipe-D-DP-3-linear-to-linear
[165.799328] Dynamic subtest pipe-D-DP-3-linear-to-linear: SUCCESS (0.149s)
[165.833598] Subtest flip-change-tiling: SUCCESS (6.644s)
[166.211272] [026/132] (860s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[166.403590] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[166.405229] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[166.610693] [027/132] (860s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[166.811472] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[167.993999] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (1.183s)
[168.226282] [028/132] (859s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[168.309506] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[168.413265] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.103s)
[168.592524] [029/132] (858s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[169.265572] Starting subtest: syncobj-backward-timeline-chain-engines
[169.424550] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.160s)
[169.792418] [030/132] (857s left) gem_exec_balancer (sliced)
[169.881205] Starting subtest: sliced
[169.883482] Subtest sliced: SKIP (0.000s)
[170.299376] [031/132] (857s left) perf (oa-exponents)
[170.726828] Starting subtest: oa-exponents
[170.727619] Starting dynamic subtest: 0-rcs0
[173.039700] Dynamic subtest 0-rcs0: SUCCESS (2.312s)
[173.040667] Subtest oa-exponents: SUCCESS (2.313s)
[173.093405] [032/132] (854s left) gem_userptr_blits (stress-mm)
[173.195443] Starting subtest: stress-mm
[178.564382] Subtest stress-mm: SUCCESS (5.369s)
[178.781937] [033/132] (848s left) gem_mmap_gtt (basic-short)
[178.859166] Subtest basic-short: SKIP (0.000s)
[178.941030] [034/132] (848s left) gen7_exec_parse (bitmasks)
[179.025195] Subtest bitmasks: SKIP (0.000s)
[179.088837] [035/132] (848s left) gem_exec_reloc (basic-cpu-wc)
[179.175607] Subtest basic-cpu-wc: SKIP (0.000s)
[179.289508] [036/132] (848s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[179.493080] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[179.494921] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[179.672302] [037/132] (848s left) kms_plane (plane-position-covered)
[179.864452] Starting subtest: plane-position-covered
[180.293944] Starting dynamic subtest: pipe-A-plane-1
[180.751562] Dynamic subtest pipe-A-plane-1: SUCCESS (0.452s)
[180.765269] Starting dynamic subtest: pipe-A-plane-2
[181.200392] Dynamic subtest pipe-A-plane-2: SUCCESS (0.454s)
[181.212304] Starting dynamic subtest: pipe-A-plane-3
[181.654208] Dynamic subtest pipe-A-plane-3: SUCCESS (0.453s)
[181.666036] Starting dynamic subtest: pipe-A-plane-4
[182.107686] Dynamic subtest pipe-A-plane-4: SUCCESS (0.453s)
[182.120320] Starting dynamic subtest: pipe-A-plane-5
[182.130310] Dynamic subtest pipe-A-plane-5: SUCCESS (0.022s)
[182.487507] Starting dynamic subtest: pipe-B-plane-1
[182.896303] Dynamic subtest pipe-B-plane-1: SUCCESS (0.419s)
[182.907349] Starting dynamic subtest: pipe-B-plane-2
[183.328192] Dynamic subtest pipe-B-plane-2: SUCCESS (0.431s)
[183.338591] Starting dynamic subtest: pipe-B-plane-3
[183.763339] Dynamic subtest pipe-B-plane-3: SUCCESS (0.434s)
[183.774167] Starting dynamic subtest: pipe-B-plane-4
[184.201214] Dynamic subtest pipe-B-plane-4: SUCCESS (0.437s)
[184.211907] Starting dynamic subtest: pipe-B-plane-5
[184.222259] Dynamic subtest pipe-B-plane-5: SUCCESS (0.021s)
[184.223143] Subtest plane-position-covered: SUCCESS (4.357s)
[184.532710] [038/132] (843s left) gem_exec_schedule (noreorder-corked)
[184.749341] Starting subtest: noreorder-corked
[184.750281] Starting dynamic subtest: rcs0
[185.906527] Dynamic subtest rcs0: SUCCESS (1.163s)
[185.917675] Starting dynamic subtest: bcs0
[187.050483] Dynamic subtest bcs0: SUCCESS (1.143s)
[187.062468] Starting dynamic subtest: vcs0
[188.192496] Dynamic subtest vcs0: SUCCESS (1.141s)
[188.204197] Starting dynamic subtest: vcs1
[189.323350] Dynamic subtest vcs1: SUCCESS (1.130s)
[189.333995] Starting dynamic subtest: vecs0
[190.463495] Dynamic subtest vecs0: SUCCESS (1.139s)
[190.475209] Starting dynamic subtest: vecs1
[191.598224] Dynamic subtest vecs1: SUCCESS (1.134s)
[191.609247] Starting dynamic subtest: ccs0
[192.739379] Dynamic subtest ccs0: SUCCESS (1.140s)
[192.740546] Subtest noreorder-corked: SUCCESS (7.996s)
[193.032178] [039/132] (835s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[193.224246] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[193.562813] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (0.339s)
[193.901313] [040/132] (834s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[194.096288] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[194.097177] Starting dynamic subtest: pipe-A-DP-3
[194.105476] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[194.115911] Starting dynamic subtest: pipe-B-DP-3
[194.124299] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[194.134505] Starting dynamic subtest: pipe-C-DP-3
[194.143008] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[194.153106] Starting dynamic subtest: pipe-D-DP-3
[194.164387] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[194.166359] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[194.580944] [041/132] (833s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[195.003175] Starting subtest: cursor-rapid-movement-256x256
[195.006552] Starting dynamic subtest: pipe-A-DP-3
[195.476684] Dynamic subtest pipe-A-DP-3: SUCCESS (0.469s)
[195.522158] Starting dynamic subtest: pipe-D-DP-3
[195.879545] Dynamic subtest pipe-D-DP-3: SUCCESS (0.367s)
[195.880398] Subtest cursor-rapid-movement-256x256: SUCCESS (0.878s)
[196.282504] [042/132] (832s left) sw_sync (sync_multi_consumer_producer)
[196.331024] Starting subtest: sync_multi_consumer_producer
[196.560830] Subtest sync_multi_consumer_producer: SUCCESS (0.223s)
[196.783819] [043/132] (831s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[196.992279] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[196.994148] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[197.195407] [044/132] (831s left) gem_lmem_swapping (massive)
[199.884024] Starting subtest: massive
[199.886624] Starting dynamic subtest: lmem0
[210.365145] Dynamic subtest lmem0: SUCCESS (10.484s)
[210.366060] Subtest massive: SUCCESS (10.485s)
[211.874261] [FACT gem_lmem_swapping (massive)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[211.875262] [FACT gem_lmem_swapping (massive)] deleted: kernel.kmod_is_loaded.i915: true
[211.876962] [045/132] (816s left) perf_pmu (semaphore-busy)
[213.423460] Starting subtest: semaphore-busy
[213.424228] Starting dynamic subtest: rcs0
[215.105620] Dynamic subtest rcs0: SUCCESS (1.681s)
[215.123526] Starting dynamic subtest: bcs0
[216.748114] Dynamic subtest bcs0: SUCCESS (1.637s)
[216.759218] Starting dynamic subtest: vcs0
[218.389115] Dynamic subtest vcs0: SUCCESS (1.637s)
[218.400089] Starting dynamic subtest: vcs1
[220.034674] Dynamic subtest vcs1: SUCCESS (1.642s)
[220.045393] Starting dynamic subtest: vecs0
[221.672983] Dynamic subtest vecs0: SUCCESS (1.635s)
[221.683768] Starting dynamic subtest: vecs1
[223.316114] Dynamic subtest vecs1: SUCCESS (1.640s)
[223.326908] Starting dynamic subtest: ccs0
[224.955068] Dynamic subtest ccs0: SUCCESS (1.635s)
[224.956269] Subtest semaphore-busy: SUCCESS (11.531s)
[225.065708] [FACT perf_pmu (semaphore-busy)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[225.067984] [FACT perf_pmu (semaphore-busy)] new: kernel.kmod_is_loaded.i915: true
[225.071247] [046/132] (803s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[225.259984] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[225.261729] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[225.454555] [047/132] (803s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[225.531057] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[225.598124] [048/132] (803s left) kms_flip (2x-modeset-vs-vblank-race)
[225.786412] Starting subtest: 2x-modeset-vs-vblank-race
[225.801573] Subtest 2x-modeset-vs-vblank-race: SKIP (0.014s)
[225.984551] [049/132] (802s left) kms_flip (nonexisting-fb)
[226.169088] Starting subtest: nonexisting-fb
[226.173539] Starting dynamic subtest: A-DP3
[226.522908] Dynamic subtest A-DP3: SUCCESS (0.348s)
[226.565328] Starting dynamic subtest: B-DP3
[226.823842] Dynamic subtest B-DP3: SUCCESS (0.297s)
[226.851288] Starting dynamic subtest: C-DP3
[227.103386] Dynamic subtest C-DP3: SUCCESS (0.277s)
[227.130649] Starting dynamic subtest: D-DP3
[227.383576] Dynamic subtest D-DP3: SUCCESS (0.278s)
[227.387947] Subtest nonexisting-fb: SUCCESS (1.219s)
[227.811759] [050/132] (801s left) kms_psr (psr-basic)
[228.001387] Subtest psr-basic: SKIP (0.000s)
[228.055813] [051/132] (801s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[228.241393] Starting subtest: cursorB-vs-flipB-atomic
[228.243174] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[228.415482] [052/132] (800s left) kms_cursor_crc (cursor-alpha-transparent)
[228.604184] Starting subtest: cursor-alpha-transparent
[228.605101] Starting dynamic subtest: pipe-A-DP-3
[229.206318] Dynamic subtest pipe-A-DP-3: SUCCESS (0.601s)
[229.226628] Starting dynamic subtest: pipe-D-DP-3
[229.724224] Dynamic subtest pipe-D-DP-3: SUCCESS (0.514s)
[229.725183] Subtest cursor-alpha-transparent: SUCCESS (1.120s)
[230.381704] [053/132] (798s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[230.580468] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[230.748930] [054/132] (798s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[230.845598] Starting subtest: yf-tiled-to-vebox-y-tiled
[230.847510] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[231.128169] [055/132] (798s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[231.323822] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[231.325905] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[231.528624] [056/132] (797s left) kms_addfb_basic (bad-pitch-32)
[231.614492] Starting subtest: bad-pitch-32
[231.615405] Subtest bad-pitch-32: SUCCESS (0.000s)
[231.905663] [057/132] (797s left) kms_flip (flip-vs-rmfb)
[232.092737] Starting subtest: flip-vs-rmfb
[232.097302] Starting dynamic subtest: A-DP3
[239.941821] Dynamic subtest A-DP3: SUCCESS (7.843s)
[239.985400] Starting dynamic subtest: B-DP3
[247.725551] Dynamic subtest B-DP3: SUCCESS (7.778s)
[247.764337] Starting dynamic subtest: C-DP3
[255.509896] Dynamic subtest C-DP3: SUCCESS (7.779s)
[255.548364] Starting dynamic subtest: D-DP3
[263.291638] Dynamic subtest D-DP3: SUCCESS (7.776s)
[263.299252] Subtest flip-vs-rmfb: SUCCESS (31.205s)
[263.724946] [058/132] (765s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[263.916274] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[263.917197] Starting dynamic subtest: pipe-A-DP-3
[263.925497] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[263.936242] Starting dynamic subtest: pipe-B-DP-3
[263.944006] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[263.954906] Starting dynamic subtest: pipe-C-DP-3
[263.963045] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[263.973497] Starting dynamic subtest: pipe-D-DP-3
[263.981732] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[263.983426] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.007s)
[264.379354] [059/132] (765s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[264.458478] Starting subtest: multi-wait-all-for-submit-signaled
[264.459432] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[264.626064] [060/132] (765s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[264.813291] Starting subtest: primary-4-tiled-reflect-x-0
[275.281398] Subtest primary-4-tiled-reflect-x-0: SUCCESS (10.468s)
[275.655886] [061/132] (754s left) gem_close (basic)
[275.736592] Starting subtest: basic
[275.737708] Subtest basic: SUCCESS (0.000s)
[275.941573] [062/132] (754s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[276.134415] Starting subtest: basic-flip-after-cursor-atomic
[277.166187] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.032s)
[277.472132] [063/132] (752s left) syncobj_timeline (multi-wait-for-submit-signaled)
[277.551430] Starting subtest: multi-wait-for-submit-signaled
[277.552338] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[277.710984] [064/132] (752s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[277.907626] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[279.171366] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.263s)
[279.421894] [065/132] (750s left) i915_suspend (basic-s3-without-i915)
[279.468976] Starting subtest: basic-s3-without-i915
[300.959868] Subtest basic-s3-without-i915: SUCCESS (5.718s)
[301.075228] [066/132] (729s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[301.266294] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[301.267207] Starting dynamic subtest: pipe-A-valid-mode
[303.601455] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.333s)
[303.602898] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.336s)
[303.916947] [067/132] (726s left) i915_pm_rpm (system-suspend)
[305.814012] Starting subtest: system-suspend
[326.356930] Subtest system-suspend: SUCCESS (4.758s)
[326.716386] [068/132] (703s left) kms_vblank (query-forked-hang)
[326.906654] Starting subtest: query-forked-hang
[326.907524] Starting dynamic subtest: pipe-A-DP-3
[353.071868] Dynamic subtest pipe-A-DP-3: SUCCESS (26.163s)
[353.087896] Starting dynamic subtest: pipe-D-DP-3
[378.077590] Dynamic subtest pipe-D-DP-3: SUCCESS (25.003s)
[378.078532] Subtest query-forked-hang: SUCCESS (51.173s)
[378.392804] [069/132] (652s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[378.583660] Starting subtest: cursor-vs-flip-atomic
[409.483782] Subtest cursor-vs-flip-atomic: SUCCESS (30.900s)
[409.776275] [070/132] (620s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[409.973711] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[409.975435] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[410.158693] [071/132] (620s left) gem_exec_schedule (submit-early-slice)
[410.260944] Starting subtest: submit-early-slice
[410.261858] Starting dynamic subtest: rcs0
[410.350878] Dynamic subtest rcs0: SUCCESS (0.089s)
[410.365659] Starting dynamic subtest: bcs0
[410.411040] Dynamic subtest bcs0: SUCCESS (0.059s)
[410.425835] Starting dynamic subtest: vcs0
[410.468093] Dynamic subtest vcs0: SUCCESS (0.056s)
[410.483053] Starting dynamic subtest: vcs1
[410.527176] Dynamic subtest vcs1: SUCCESS (0.058s)
[410.540691] Starting dynamic subtest: vecs0
[410.583582] Dynamic subtest vecs0: SUCCESS (0.055s)
[410.598365] Starting dynamic subtest: vecs1
[410.644524] Dynamic subtest vecs1: SUCCESS (0.060s)
[410.659961] Starting dynamic subtest: ccs0
[410.702599] Dynamic subtest ccs0: SUCCESS (0.057s)
[410.703555] Subtest submit-early-slice: SUCCESS (0.442s)
[411.199035] [072/132] (619s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[411.385588] Starting subtest: basic-flip-before-cursor-varying-size
[412.424231] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.039s)
[412.757763] [073/132] (618s left) syncobj_timeline (host-signal-ordered)
[412.836812] Starting subtest: host-signal-ordered
[412.837878] Subtest host-signal-ordered: SUCCESS (0.000s)
[413.043877] [074/132] (617s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[413.246487] Starting subtest: x-tiled-64bpp-rotate-0
[415.161424] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.914s)
[415.394337] [075/132] (615s left) gem_userptr_blits (relocations)
[415.482506] Starting subtest: relocations
[415.484271] Subtest relocations: SKIP (0.001s)
[415.714989] [076/132] (615s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[415.908504] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[415.910212] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[416.114679] [077/132] (615s left) core_getversion (basic)
[416.178599] Starting subtest: basic
[416.180477] Subtest basic: SUCCESS (0.000s)
[416.364452] [078/132] (614s left) perf (enable-disable)
[416.757852] Starting subtest: enable-disable
[416.758701] Starting dynamic subtest: 0-rcs0
[419.011201] Dynamic subtest 0-rcs0: SUCCESS (2.253s)
[419.012221] Subtest enable-disable: SUCCESS (2.254s)
[419.077375] [079/132] (612s left) gem_softpin (allocator-nopin-reserve)
[419.166799] Starting subtest: allocator-nopin-reserve
[419.436529] Subtest allocator-nopin-reserve: SUCCESS (0.271s)
[419.626830] [080/132] (611s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[419.822612] Starting subtest: basic-max-pipe-crc-check
[419.825556] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[419.892522] [081/132] (611s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[420.093518] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[420.157859] [082/132] (611s left) api_intel_allocator (two-level-inception-interruptible)
[420.236909] Starting subtest: two-level-inception-interruptible
[425.659740] Subtest two-level-inception-interruptible: SUCCESS (5.423s)
[425.885822] [083/132] (605s left) kms_flip (wf_vblank-ts-check)
[426.070563] Starting subtest: wf_vblank-ts-check
[426.075383] Starting dynamic subtest: A-DP3
[434.181354] Dynamic subtest A-DP3: SUCCESS (8.105s)
[434.197927] Starting dynamic subtest: B-DP3
[442.236563] Dynamic subtest B-DP3: SUCCESS (8.053s)
[442.252075] Starting dynamic subtest: C-DP3
[450.289386] Dynamic subtest C-DP3: SUCCESS (8.051s)
[450.304808] Starting dynamic subtest: D-DP3
[458.343427] Dynamic subtest D-DP3: SUCCESS (8.052s)
[458.345743] Subtest wf_vblank-ts-check: SUCCESS (32.274s)
[458.692327] [084/132] (572s left) syncobj_timeline (wait-delayed-signal)
[458.770776] Starting subtest: wait-delayed-signal
[458.874000] Subtest wait-delayed-signal: SUCCESS (0.103s)
[459.022133] [085/132] (572s left) gem_cs_tlb (engines)
[459.106821] Starting subtest: engines
[459.107761] Starting dynamic subtest: rcs0
[461.262045] Dynamic subtest rcs0: SUCCESS (2.154s)
[461.276029] Starting dynamic subtest: bcs0
[463.416287] Dynamic subtest bcs0: SUCCESS (2.153s)
[463.429828] Starting dynamic subtest: vcs0
[465.568799] Dynamic subtest vcs0: SUCCESS (2.151s)
[465.582914] Starting dynamic subtest: vcs1
[467.721837] Dynamic subtest vcs1: SUCCESS (2.152s)
[467.735640] Starting dynamic subtest: vecs0
[469.875708] Dynamic subtest vecs0: SUCCESS (2.152s)
[469.889443] Starting dynamic subtest: vecs1
[472.029303] Dynamic subtest vecs1: SUCCESS (2.152s)
[472.042944] Starting dynamic subtest: ccs0
[474.181806] Dynamic subtest ccs0: SUCCESS (2.152s)
[474.182744] Subtest engines: SUCCESS (15.074s)
[474.354924] [086/132] (557s left) gem_tiled_blits (interruptible)
[474.445743] Subtest interruptible: SKIP (0.000s)
[474.520289] [087/132] (557s left) kms_joiner (basic-big-joiner)
[474.709908] Starting subtest: basic-big-joiner
[474.711566] Subtest basic-big-joiner: SKIP (0.000s)
[474.879806] [088/132] (557s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[475.065223] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[475.067497] Starting dynamic subtest: pipe-A-DP-3
[475.076579] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[475.090135] Starting dynamic subtest: pipe-B-DP-3
[475.099438] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[475.112580] Starting dynamic subtest: pipe-C-DP-3
[475.122195] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[475.135674] Starting dynamic subtest: pipe-D-DP-3
[475.146866] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[475.148794] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.007s)
[475.529606] [089/132] (556s left) kms_cursor_crc (cursor-suspend)
[475.787552] Starting subtest: cursor-suspend
[475.789880] Starting dynamic subtest: pipe-A-DP-3
[515.205095] Dynamic subtest pipe-A-DP-3: SUCCESS (8.009s)
[515.234614] Starting dynamic subtest: pipe-D-DP-3
[554.532803] Dynamic subtest pipe-D-DP-3: SUCCESS (7.838s)
[554.533900] Subtest cursor-suspend: SUCCESS (15.854s)
[555.130154] [090/132] (476s left) gem_tiled_blits (basic)
[555.216070] Subtest basic: SKIP (0.000s)
[555.312344] [091/132] (476s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[555.502836] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[555.504563] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[555.715036] [092/132] (476s left) gem_exec_reloc (basic-cpu-gtt-active)
[555.799763] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[555.904683] [093/132] (476s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[556.102761] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[556.104491] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[556.297479] [094/132] (476s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[556.489736] Starting subtest: fbcpsr-rgb565-draw-blt
[556.491484] Subtest fbcpsr-rgb565-draw-blt: SKIP (0.000s)
[556.696744] [095/132] (475s left) kms_cursor_crc (cursor-offscreen-64x21)
[557.038885] Starting subtest: cursor-offscreen-64x21
[557.042533] Starting dynamic subtest: pipe-A-DP-3
[559.588563] Dynamic subtest pipe-A-DP-3: SUCCESS (2.545s)
[559.626464] Starting dynamic subtest: pipe-D-DP-3
[562.104740] Dynamic subtest pipe-D-DP-3: SUCCESS (2.490s)
[562.105870] Subtest cursor-offscreen-64x21: SUCCESS (5.067s)
[562.608204] [096/132] (469s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[562.798715] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[562.800417] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[563.006642] [097/132] (469s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[563.196738] Starting subtest: fbc-rgb565-draw-blt
[565.820014] Subtest fbc-rgb565-draw-blt: SUCCESS (2.624s)
[566.038676] [098/132] (466s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[566.226880] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[566.228569] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[566.424420] [099/132] (466s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[566.612818] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[566.614496] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[566.823145] [100/132] (466s left) api_intel_bb (full-batch)
[566.907375] Starting subtest: full-batch
[566.939782] Subtest full-batch: SUCCESS (0.032s)
[567.125952] [101/132] (465s left) perf (gen12-unprivileged-single-ctx-counters)
[567.385038] Starting subtest: gen12-unprivileged-single-ctx-counters
[567.385959] Starting dynamic subtest: rcs0
[567.483088] Dynamic subtest rcs0: SUCCESS (0.097s)
[567.484008] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.099s)
[567.553678] [102/132] (465s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[567.779776] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.000s)
[567.851070] [103/132] (465s left) kms_psr (psr2-primary-mmap-cpu)
[568.038154] Subtest psr2-primary-mmap-cpu: SKIP (0.000s)
[568.101538] [104/132] (465s left) gem_exec_await (wide-all)
[568.399818] Starting subtest: wide-all
[590.563136] Subtest wide-all: SUCCESS (22.163s)
[590.835260] [105/132] (442s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[591.087024] Starting subtest: fb-8bpc-vs-panel-6bpc
[591.087890] Starting dynamic subtest: pipe-A-DP-3
[591.490110] Dynamic subtest pipe-A-DP-3: SUCCESS (0.401s)
[591.491791] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (0.405s)
[591.787418] [106/132] (441s left) kms_chamelium_frames (dp-crc-single)
[592.062758] Subtest dp-crc-single: SKIP (0.000s)
[592.213857] [107/132] (441s left) gem_exec_whisper (basic-fds-priority-all)
[592.303986] Starting subtest: basic-fds-priority-all
[614.963523] Subtest basic-fds-priority-all: SUCCESS (22.659s)
[615.250967] [108/132] (418s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[615.444701] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[615.446446] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[615.636050] [109/132] (417s left) fbdev (unaligned-read)
[615.706125] Starting subtest: unaligned-read
[615.719817] Subtest unaligned-read: SUCCESS (0.014s)
[615.867752] [110/132] (417s left) gen3_render_tiledy_blits
[616.020528] [111/132] (417s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[616.207022] Starting subtest: cursorA-vs-flipA-toggle
[627.184730] Subtest cursorA-vs-flipA-toggle: SUCCESS (10.977s)
[627.521985] [112/132] (406s left) gem_eio (in-flight-10ms)
[627.833026] Starting subtest: in-flight-10ms
[633.062056] Subtest in-flight-10ms: SUCCESS (5.229s)
[633.354359] [113/132] (400s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[633.546678] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[633.548430] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[633.731981] [114/132] (400s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[635.435250] Starting subtest: modeset-non-lpsp-stress-no-wait
[637.261078] Subtest modeset-non-lpsp-stress-no-wait: SUCCESS (1.826s)
[637.479979] [115/132] (396s left) kms_atomic (plane-immutable-zpos)
[637.668881] Starting subtest: plane-immutable-zpos
[637.669773] Starting dynamic subtest: pipe-A-DP-3
[638.600323] Dynamic subtest pipe-A-DP-3: SUCCESS (0.931s)
[638.601198] Subtest plane-immutable-zpos: SUCCESS (0.933s)
[638.945401] [116/132] (395s left) syncobj_timeline (invalid-transfer-non-existent-point)
[639.028158] Starting subtest: invalid-transfer-non-existent-point
[639.029033] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[639.172526] [117/132] (395s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[639.379833] Starting subtest: 4-tiled-64bpp-rotate-0
[641.321701] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.942s)
[641.561204] [118/132] (392s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[641.748807] Starting subtest: plane-downscale-factor-0-75-with-rotation
[641.749517] Starting dynamic subtest: pipe-A
[642.121841] Dynamic subtest pipe-A: SUCCESS (0.374s)
[642.154798] Starting dynamic subtest: pipe-B
[642.601370] Dynamic subtest pipe-B: SUCCESS (0.477s)
[642.638210] Starting dynamic subtest: pipe-C
[643.079975] Dynamic subtest pipe-C: SUCCESS (0.476s)
[643.102945] Starting dynamic subtest: pipe-D
[643.542091] Dynamic subtest pipe-D: SUCCESS (0.461s)
[643.543096] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (1.795s)
[643.927876] [119/132] (390s left) kms_cdclk (mode-transition-all-outputs)
[644.116886] Starting subtest: mode-transition-all-outputs
[644.199035] Subtest mode-transition-all-outputs: SKIP (0.081s)
[644.454694] [120/132] (390s left) kms_psr (fbc-pr-sprite-plane-move)
[644.644313] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[644.717361] [121/132] (389s left) gem_ctx_persistence (engines-mixed-process)
[644.804802] Starting subtest: engines-mixed-process
[644.805767] Starting dynamic subtest: rcs0
[646.307398] Dynamic subtest rcs0: SUCCESS (1.502s)
[646.326264] Starting dynamic subtest: bcs0
[648.355357] Dynamic subtest bcs0: SUCCESS (2.045s)
[648.372537] Starting dynamic subtest: vcs0
[650.332319] Dynamic subtest vcs0: SUCCESS (1.977s)
[650.349826] Starting dynamic subtest: vcs1
[652.319622] Dynamic subtest vcs1: SUCCESS (1.986s)
[652.336745] Starting dynamic subtest: vecs0
[654.302717] Dynamic subtest vecs0: SUCCESS (1.982s)
[654.322604] Starting dynamic subtest: vecs1
[656.271265] Dynamic subtest vecs1: SUCCESS (1.967s)
[656.288133] Starting dynamic subtest: ccs0
[658.324717] Dynamic subtest ccs0: SUCCESS (2.052s)
[658.325796] Subtest engines-mixed-process: SUCCESS (13.521s)
[658.508226] [122/132] (376s left) kms_draw_crc (draw-method-mmap-gtt)
[658.696076] Starting subtest: draw-method-mmap-gtt
[658.697737] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[658.892896] [123/132] (375s left) syncobj_wait (single-wait-all-submitted)
[658.968075] Starting subtest: single-wait-all-submitted
[659.073128] Subtest single-wait-all-submitted: SUCCESS (0.104s)
[659.256665] [124/132] (375s left) gem_lmem_swapping (verify-ccs)
[662.021537] Starting subtest: verify-ccs
[662.022516] Starting dynamic subtest: lmem0
[707.006639] Dynamic subtest lmem0: SUCCESS (44.985s)
[707.007658] Subtest verify-ccs: SUCCESS (44.986s)
[709.126167] [FACT gem_lmem_swapping (verify-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[709.127119] [FACT gem_lmem_swapping (verify-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[709.129260] [125/132] (325s left) i915_pm_freq_api (freq-suspend)
[710.708178] Starting subtest: freq-suspend
[710.709027] Starting dynamic subtest: gt0
[728.424867] Dynamic subtest gt0: SUCCESS (3.991s)
[728.425621] Subtest freq-suspend: SUCCESS (3.993s)
[728.492898] [FACT i915_pm_freq_api (freq-suspend)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[728.495643] [FACT i915_pm_freq_api (freq-suspend)] new: kernel.kmod_is_loaded.i915: true
[728.499031] [126/132] (306s left) gem_eio (wait-immediate)
[728.735612] Starting subtest: wait-immediate
[729.210017] Subtest wait-immediate: SUCCESS (0.474s)
[729.522881] [127/132] (305s left) gem_vm_create (invalid-create)
[729.607591] Starting subtest: invalid-create
[729.611976] Subtest invalid-create: SUCCESS (0.004s)
[729.824952] [128/132] (305s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[730.026525] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[730.115015] [129/132] (305s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[730.306777] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[730.307695] Starting dynamic subtest: pipe-A
[730.424063] Dynamic subtest pipe-A: SUCCESS (0.117s)
[730.451536] Starting dynamic subtest: pipe-B
[730.637255] Dynamic subtest pipe-B: SUCCESS (0.211s)
[730.665666] Starting dynamic subtest: pipe-C
[730.850275] Dynamic subtest pipe-C: SUCCESS (0.211s)
[730.875280] Starting dynamic subtest: pipe-D
[731.101203] Dynamic subtest pipe-D: SUCCESS (0.249s)
[731.102098] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SUCCESS (0.794s)
[731.447892] [130/132] (303s left) kms_vblank (wait-forked-busy)
[731.637534] Starting subtest: wait-forked-busy
[731.638436] Starting dynamic subtest: pipe-A-DP-3
[734.148778] Dynamic subtest pipe-A-DP-3: SUCCESS (2.507s)
[734.181079] Starting dynamic subtest: pipe-D-DP-3
[736.626590] Dynamic subtest pipe-D-DP-3: SUCCESS (2.469s)
[736.627514] Subtest wait-forked-busy: SUCCESS (4.986s)
[736.917288] [131/132] (298s left) prime_vgem (sync)
[737.012205] Starting subtest: sync
[737.013141] Starting dynamic subtest: rcs0
[737.062247] Dynamic subtest rcs0: SUCCESS (0.049s)
[737.077488] Starting dynamic subtest: bcs0
[737.124012] Dynamic subtest bcs0: SUCCESS (0.060s)
[737.148441] Starting dynamic subtest: vcs0
[737.165765] Dynamic subtest vcs0: SUCCESS (0.040s)
[737.190206] Starting dynamic subtest: vcs1
[737.205294] Dynamic subtest vcs1: SUCCESS (0.038s)
[737.224182] Starting dynamic subtest: vecs0
[737.245321] Dynamic subtest vecs0: SUCCESS (0.039s)
[737.262855] Starting dynamic subtest: vecs1
[737.286335] Dynamic subtest vecs1: SUCCESS (0.040s)
[737.306835] Starting dynamic subtest: ccs0
[737.327730] Dynamic subtest ccs0: SUCCESS (0.040s)
[737.328713] Subtest sync: SUCCESS (0.316s)
[737.573173] [132/132] (297s left) kms_getfb (getfb-repeated-different-handles)
[737.757210] Starting subtest: getfb-repeated-different-handles
[737.758180] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[737.982196] Closing watchdogs
results: parsing output: 0/ for test: gem_pxp
results: parsing output: 1/ for test: kms_color_pipeline
results: parsing output: 2/ for test: template
results: parsing output: 3/ for test: kms_flip_scaled_crc
results: parsing output: 4/ for test: gem_mmap_offset
results: parsing output: 5/ for test: kms_chamelium_hpd
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_cursor_legacy
results: parsing output: 8/ for test: kms_plane_cursor
results: parsing output: 9/ for test: gem_ctx_persistence
results: parsing output: 10/ for test: gem_ctx_shared
results: parsing output: 11/ for test: gem_exec_params
results: parsing output: 12/ for test: gem_mmap_offset
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: vgem_basic
results: parsing output: 15/ for test: vgem_basic
results: parsing output: 16/ for test: gem_eio
results: parsing output: 17/ for test: kms_pm_rpm
results: parsing output: 18/ for test: gem_exec_balancer
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: gem_exec_reloc
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: i915_drm_fdinfo
results: parsing output: 23/ for test: kms_hdr
results: parsing output: 24/ for test: kms_flip_tiling
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: gem_exec_fence
results: parsing output: 29/ for test: gem_exec_balancer
results: parsing output: 30/ for test: perf
results: parsing output: 31/ for test: gem_userptr_blits
results: parsing output: 32/ for test: gem_mmap_gtt
results: parsing output: 33/ for test: gen7_exec_parse
results: parsing output: 34/ for test: gem_exec_reloc
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: kms_plane
results: parsing output: 37/ for test: gem_exec_schedule
results: parsing output: 38/ for test: kms_cursor_legacy
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: kms_cursor_crc
results: parsing output: 41/ for test: sw_sync
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: gem_lmem_swapping
results: parsing output: 44/ for test: perf_pmu
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_pipe_b_c_ivb
results: parsing output: 47/ for test: kms_flip
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: kms_cursor_legacy
results: parsing output: 51/ for test: kms_cursor_crc
results: parsing output: 52/ for test: kms_addfb_basic
results: parsing output: 53/ for test: gem_render_copy
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: kms_addfb_basic
results: parsing output: 56/ for test: kms_flip
results: parsing output: 57/ for test: kms_ccs
results: parsing output: 58/ for test: syncobj_wait
results: parsing output: 59/ for test: kms_rotation_crc
results: parsing output: 60/ for test: gem_close
results: parsing output: 61/ for test: kms_cursor_legacy
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: i915_suspend
results: parsing output: 65/ for test: kms_flip_scaled_crc
results: parsing output: 66/ for test: i915_pm_rpm
results: parsing output: 67/ for test: kms_vblank
results: parsing output: 68/ for test: kms_cursor_legacy
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_exec_schedule
results: parsing output: 71/ for test: kms_cursor_legacy
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: gem_userptr_blits
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: core_getversion
results: parsing output: 77/ for test: perf
results: parsing output: 78/ for test: gem_softpin
results: parsing output: 79/ for test: kms_multipipe_modeset
results: parsing output: 80/ for test: kms_psr2_sf
results: parsing output: 81/ for test: api_intel_allocator
results: parsing output: 82/ for test: kms_flip
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: gem_cs_tlb
results: parsing output: 85/ for test: gem_tiled_blits
results: parsing output: 86/ for test: kms_joiner
results: parsing output: 87/ for test: kms_ccs
results: parsing output: 88/ for test: kms_cursor_crc
results: parsing output: 89/ for test: gem_tiled_blits
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_exec_reloc
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_cursor_crc
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: api_intel_bb
results: parsing output: 100/ for test: perf
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: gem_exec_await
results: parsing output: 104/ for test: kms_dither
results: parsing output: 105/ for test: kms_chamelium_frames
results: parsing output: 106/ for test: gem_exec_whisper
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: fbdev
results: parsing output: 109/ for test: gen3_render_tiledy_blits
results: parsing output: 110/ for test: kms_cursor_legacy
results: parsing output: 111/ for test: gem_eio
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_pm_rpm
results: parsing output: 114/ for test: kms_atomic
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_plane_scaling
results: parsing output: 118/ for test: kms_cdclk
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: gem_ctx_persistence
results: parsing output: 121/ for test: kms_draw_crc
results: parsing output: 122/ for test: syncobj_wait
results: parsing output: 123/ for test: gem_lmem_swapping
results: parsing output: 124/ for test: i915_pm_freq_api
results: parsing output: 125/ for test: gem_eio
results: parsing output: 126/ for test: gem_vm_create
results: parsing output: 127/ for test: kms_psr2_sf
results: parsing output: 128/ for test: kms_plane_scaling
results: parsing output: 129/ for test: kms_vblank
results: parsing output: 130/ for test: prime_vgem
results: parsing output: 131/ for test: kms_getfb
Done.