[58.624770] Initializing watchdogs
[58.624817]   /dev/watchdog0
[58.639227] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[58.643113] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.645289] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.648474] [001/133] (960s left) kms_cursor_crc (cursor-offscreen-256x85)
[58.901969] Starting subtest: cursor-offscreen-256x85
[58.956731] Subtest cursor-offscreen-256x85: SKIP (0.050s)
[59.114625] [002/133] (960s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[59.184434] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[59.187069] Starting dynamic subtest: pipe-A-eDP-1
[59.246033] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[59.258281] Starting dynamic subtest: pipe-B-eDP-1
[59.318253] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[59.326813] Starting dynamic subtest: pipe-C-eDP-1
[59.385575] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[59.395901] Starting dynamic subtest: pipe-D-eDP-1
[59.450288] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[59.453754] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.007s)
[61.429968] [003/133] (957s left) sysfs_timeslice_duration (duration)
[61.485517] Starting subtest: duration
[61.487967] Starting dynamic subtest: vecs0
[75.769841] Dynamic subtest vecs0: SUCCESS (14.281s)
[75.780062] Starting dynamic subtest: ccs0
[88.916352] Dynamic subtest ccs0: SUCCESS (13.147s)
[88.926938] Starting dynamic subtest: vcs0
[102.775530] Dynamic subtest vcs0: SUCCESS (13.856s)
[102.786522] Starting dynamic subtest: bcs0
[115.915355] Dynamic subtest bcs0: SUCCESS (13.140s)
[115.925566] Starting dynamic subtest: rcs0
[129.057606] Dynamic subtest rcs0: SUCCESS (13.140s)
[129.069554] Starting dynamic subtest: vcs1
[142.775919] Dynamic subtest vcs1: SUCCESS (13.716s)
[142.778859] Subtest duration: SUCCESS (81.288s)
[142.845556] [004/133] (876s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[142.937951] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[142.940365] Starting dynamic subtest: pipe-A-eDP-1
[158.937434] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.581s)
[158.947244] Starting dynamic subtest: pipe-B-eDP-1
[175.913696] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.513s)
[175.922887] Starting dynamic subtest: pipe-C-eDP-1
[192.898263] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.368s)
[192.907056] Starting dynamic subtest: pipe-D-eDP-1
[209.909908] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.419s)
[209.911948] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.884s)
[211.156276] [005/133] (808s left) drm_buddy (drm_buddy)
[211.200901] Starting subtest: drm_buddy
[211.205410] Subtest drm_buddy: SKIP (0.000s)
[211.258539] [006/133] (808s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[211.375603] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[212.263437] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.887s)
[212.454635] [007/133] (806s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[212.526285] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[212.528184] Starting dynamic subtest: pipe-A-eDP-1
[213.253674] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.718s)
[213.263259] Starting dynamic subtest: pipe-B-eDP-1
[215.051482] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.792s)
[215.061468] Starting dynamic subtest: pipe-C-eDP-1
[216.790762] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.734s)
[216.802933] Starting dynamic subtest: pipe-D-eDP-1
[218.526473] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.732s)
[218.528385] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (5.980s)
[219.682220] [008/133] (799s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[219.749144] Starting subtest: bad-pixel-format-yf-tiled-ccs
[219.751296] Starting dynamic subtest: pipe-A-eDP-1
[219.773172] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[219.781986] Starting dynamic subtest: pipe-B-eDP-1
[219.803148] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[219.811212] Starting dynamic subtest: pipe-C-eDP-1
[219.832221] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[219.839945] Starting dynamic subtest: pipe-D-eDP-1
[219.861424] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[219.865270] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.003s)
[222.049380] [009/133] (797s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[222.106399] Starting subtest: multi-wait-available-unsubmitted-submitted
[222.108859] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.001s)
[222.193329] [010/133] (797s left) perf_pmu (event-wait)
[222.230767] Starting subtest: event-wait
[222.233277] Starting dynamic subtest: rcs0
[222.237838] Dynamic subtest rcs0: SKIP (0.000s)
[222.242668] Subtest event-wait: SKIP (0.000s)
[222.334575] [011/133] (797s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[222.416886] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[222.421264] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[222.526368] [012/133] (797s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[222.626791] Starting subtest: psr-rgb565-draw-mmap-gtt
[222.631402] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[222.734777] [013/133] (796s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[222.816729] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[222.818875] Starting dynamic subtest: pipe-A-eDP-1
[228.720485] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.901s)
[228.730435] Starting dynamic subtest: pipe-B-eDP-1
[235.384944] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.659s)
[235.387225] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.562s)
[236.258143] [014/133] (783s left) kms_psr (fbc-psr2-dpms)
[236.340541] Starting subtest: fbc-psr2-dpms
[236.342884] Starting dynamic subtest: eDP-1
[236.347318] Dynamic subtest eDP-1: SKIP (0.000s)
[236.351780] Subtest fbc-psr2-dpms: SKIP (0.001s)
[236.423797] [015/133] (783s left) gem_exec_balancer (parallel-ordering)
[236.683261] Starting subtest: parallel-ordering
[237.602561] Subtest parallel-ordering: SUCCESS (0.919s)
[237.726801] [016/133] (781s left) kms_joiner (basic-big-joiner)
[237.808168] Starting subtest: basic-big-joiner
[237.812575] Subtest basic-big-joiner: SKIP (0.000s)
[237.871689] [017/133] (781s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[237.978750] Starting subtest: flip-vs-cursor-crc-atomic
[238.685083] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.704s)
[239.497672] [018/133] (780s left) gem_wait (wait)
[239.564175] Starting subtest: wait
[239.566677] Starting dynamic subtest: all-engines
[240.939894] Dynamic subtest all-engines: SUCCESS (1.373s)
[240.955319] Starting dynamic subtest: rcs0
[241.985214] Dynamic subtest rcs0: SUCCESS (1.046s)
[241.996723] Starting dynamic subtest: bcs0
[243.030587] Dynamic subtest bcs0: SUCCESS (1.045s)
[243.040633] Starting dynamic subtest: vcs0
[244.076043] Dynamic subtest vcs0: SUCCESS (1.044s)
[244.091297] Starting dynamic subtest: vcs1
[245.121538] Dynamic subtest vcs1: SUCCESS (1.044s)
[245.132245] Starting dynamic subtest: vecs0
[246.166025] Dynamic subtest vecs0: SUCCESS (1.044s)
[246.177139] Starting dynamic subtest: ccs0
[247.213151] Dynamic subtest ccs0: SUCCESS (1.046s)
[247.215792] Subtest wait: SUCCESS (7.655s)
[247.409445] [019/133] (772s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[247.497733] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[247.502132] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[247.585183] [020/133] (772s left) kms_flip (2x-flip-vs-expired-vblank)
[247.662650] Starting subtest: 2x-flip-vs-expired-vblank
[247.669792] Subtest 2x-flip-vs-expired-vblank: SKIP (0.008s)
[247.755538] [021/133] (772s left) kms_lease (page-flip-implicit-plane)
[247.830101] Starting subtest: page-flip-implicit-plane
[247.832520] Starting dynamic subtest: pipe-A-eDP-1
[248.310664] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.479s)
[248.320395] Starting dynamic subtest: pipe-B-eDP-1
[249.421309] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.112s)
[249.429693] Starting dynamic subtest: pipe-C-eDP-1
[250.544396] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.122s)
[250.561776] Starting dynamic subtest: pipe-D-eDP-1
[251.675167] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.127s)
[251.677099] Subtest page-flip-implicit-plane: SUCCESS (3.846s)
[252.509459] [022/133] (767s left) gem_exec_params (rsvd2-dirt)
[252.569825] Starting subtest: rsvd2-dirt
[252.574273] Subtest rsvd2-dirt: SKIP (0.000s)
[252.659784] [023/133] (767s left) api_intel_bb (blit-reloc-purge-cache)
[252.707195] Starting subtest: blit-reloc-purge-cache
[252.711706] Subtest blit-reloc-purge-cache: SKIP (0.000s)
[252.807661] [024/133] (767s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[252.902946] Starting subtest: fbc-shrfb-scaledprimary
[256.067839] Subtest fbc-shrfb-scaledprimary: SUCCESS (3.167s)
[257.228859] [025/133] (762s left) i915_pm_rpm (gem-idle)
[259.043872] Starting subtest: gem-idle
[265.249879] Subtest gem-idle: SUCCESS (6.206s)
[265.576377] [026/133] (754s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[266.923240] Starting subtest: x-tiled-8bpp-rotate-0
[268.117754] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.194s)
[268.227143] [027/133] (751s left) gem_exec_schedule (preempt-contexts)
[268.300419] Starting subtest: preempt-contexts
[268.302365] Starting dynamic subtest: rcs0
[268.350070] Dynamic subtest rcs0: SUCCESS (0.057s)
[268.359535] Starting dynamic subtest: bcs0
[268.407474] Dynamic subtest bcs0: SUCCESS (0.056s)
[268.418423] Starting dynamic subtest: vcs0
[268.464979] Dynamic subtest vcs0: SUCCESS (0.056s)
[268.473692] Starting dynamic subtest: vcs1
[268.517613] Dynamic subtest vcs1: SUCCESS (0.052s)
[268.527788] Starting dynamic subtest: vecs0
[268.562304] Dynamic subtest vecs0: SUCCESS (0.044s)
[268.570736] Starting dynamic subtest: ccs0
[268.607392] Dynamic subtest ccs0: SUCCESS (0.045s)
[268.609285] Subtest preempt-contexts: SUCCESS (0.315s)
[270.040803] [028/133] (750s left) gem_exec_flush (basic-uc-rw-default)
[270.093463] Starting subtest: basic-uc-rw-default
[275.553383] Subtest basic-uc-rw-default: SUCCESS (5.460s)
[275.741639] [029/133] (744s left) kms_color_pipeline (plane-lut1d)
[275.814623] Starting subtest: plane-lut1d
[275.972030] Starting dynamic subtest: pipe-A-plane-0
[276.307789] Dynamic subtest pipe-A-plane-0: FAIL (0.173s)
[276.321078] Starting dynamic subtest: pipe-A-plane-1
[276.537101] Dynamic subtest pipe-A-plane-1: FAIL (0.156s)
[276.546793] Starting dynamic subtest: pipe-A-plane-2
[276.766051] Dynamic subtest pipe-A-plane-2: FAIL (0.166s)
[277.669492] Starting dynamic subtest: pipe-B-plane-0
[278.063634] Dynamic subtest pipe-B-plane-0: FAIL (0.141s)
[278.072530] Starting dynamic subtest: pipe-B-plane-1
[278.363385] Dynamic subtest pipe-B-plane-1: FAIL (0.167s)
[278.373557] Starting dynamic subtest: pipe-B-plane-2
[278.670881] Dynamic subtest pipe-B-plane-2: FAIL (0.165s)
[279.304395] Starting dynamic subtest: pipe-C-plane-0
[279.785700] Dynamic subtest pipe-C-plane-0: FAIL (0.128s)
[279.796165] Starting dynamic subtest: pipe-C-plane-1
[280.187926] Dynamic subtest pipe-C-plane-1: FAIL (0.145s)
[280.198265] Starting dynamic subtest: pipe-C-plane-2
[280.543116] Dynamic subtest pipe-C-plane-2: FAIL (0.645s)
[281.470683] Starting dynamic subtest: pipe-D-plane-0
[282.062693] Dynamic subtest pipe-D-plane-0: FAIL (0.159s)
[282.076175] Starting dynamic subtest: pipe-D-plane-1
[282.507428] Dynamic subtest pipe-D-plane-1: FAIL (0.640s)
[282.516802] Starting dynamic subtest: pipe-D-plane-2
[282.928872] Dynamic subtest pipe-D-plane-2: FAIL (0.534s)
[283.112799] Subtest plane-lut1d: FAIL (7.298s)
[283.901512] [030/133] (736s left) gem_exec_schedule (deep)
[284.086937] Starting subtest: deep
[284.089104] Starting dynamic subtest: rcs0
[288.153186] Dynamic subtest rcs0: SKIP (4.065s)
[288.163996] Starting dynamic subtest: vcs0
[297.708982] Dynamic subtest vcs0: SUCCESS (9.552s)
[297.721599] Starting dynamic subtest: vcs1
[309.539178] Dynamic subtest vcs1: SUCCESS (11.829s)
[309.550876] Starting dynamic subtest: vecs0
[320.688608] Dynamic subtest vecs0: SUCCESS (11.150s)
[320.700264] Starting dynamic subtest: ccs0
[333.780815] Dynamic subtest ccs0: SUCCESS (13.092s)
[333.783572] Subtest deep: SUCCESS (49.693s)
[335.258857] [FACT gem_exec_schedule (deep)] new: kernel.kmod_is_loaded.vgem: true
[335.262699] [031/133] (685s left) kms_cursor_crc (cursor-suspend)
[335.378432] Starting subtest: cursor-suspend
[335.380676] Starting dynamic subtest: pipe-A-eDP-1
[368.206129] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.181s)
[368.216043] Starting dynamic subtest: pipe-D-eDP-1
[402.184567] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.814s)
[402.186994] Subtest cursor-suspend: SUCCESS (6.999s)
[403.024472] [032/133] (617s left) perf (gen8-unprivileged-single-ctx-counters)
[403.163544] Starting subtest: gen8-unprivileged-single-ctx-counters
[403.167877] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[403.207648] [033/133] (617s left) api_intel_bb (intel-bb-blit-y)
[403.275081] Starting subtest: intel-bb-blit-y
[406.923172] Subtest intel-bb-blit-y: SUCCESS (3.636s)
[407.042652] [034/133] (613s left) prime_mmap (test_refcounting)
[407.102352] Starting subtest: test_refcounting
[407.104197] Starting dynamic subtest: test_refcounting-smem
[407.132225] Dynamic subtest test_refcounting-smem: SUCCESS (0.030s)
[407.134731] Subtest test_refcounting: SUCCESS (0.031s)
[407.231896] [035/133] (613s left) kms_atomic_transition (modeset-transition)
[407.317565] Starting subtest: modeset-transition
[407.319369] Starting dynamic subtest: 1x-outputs
[418.183901] Dynamic subtest 1x-outputs: SUCCESS (10.848s)
[418.186283] Subtest modeset-transition: SUCCESS (10.850s)
[419.043645] [036/133] (601s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[419.132246] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[419.134504] Starting dynamic subtest: pipe-A
[419.153992] Dynamic subtest pipe-A: SKIP (0.017s)
[419.163591] Starting dynamic subtest: pipe-B
[419.185352] Dynamic subtest pipe-B: SKIP (0.032s)
[419.194579] Starting dynamic subtest: pipe-C
[419.214015] Dynamic subtest pipe-C: SKIP (0.027s)
[419.223042] Starting dynamic subtest: pipe-D
[419.242508] Dynamic subtest pipe-D: SKIP (0.028s)
[419.246588] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.106s)
[419.347562] [037/133] (601s left) kms_frontbuffer_tracking (fbc-suspend)
[419.426232] Starting subtest: fbc-suspend
[457.224498] Subtest fbc-suspend: SUCCESS (7.529s)
[458.424496] [038/133] (562s left) gem_pxp (display-protected-crc)
[458.564450] Starting subtest: display-protected-crc
[460.133956] Subtest display-protected-crc: SUCCESS (1.568s)
[460.259257] [039/133] (560s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[460.348824] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[460.353469] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[460.450691] [040/133] (560s left) gem_userptr_blits (dmabuf-unsync)
[460.515039] Subtest dmabuf-unsync: SKIP (0.000s)
[460.647956] [041/133] (560s left) gem_eio (context-create)
[460.865364] Starting subtest: context-create
[461.175998] Subtest context-create: SUCCESS (0.309s)
[461.287103] [042/133] (559s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[461.365554] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[468.084898] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.713s)
[468.245329] [043/133] (552s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[468.338905] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[468.343815] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[468.442108] [044/133] (552s left) kms_selftest (drm_dp_mst_helper)
[468.489579] Starting subtest: drm_dp_mst_helper
[468.566845] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[468.725133] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.158s)
[468.735978] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[468.876242] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.149s)
[468.886571] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[469.040580] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.162s)
[469.043225] Subtest drm_dp_mst_helper: SUCCESS (0.551s)
[469.236795] [045/133] (551s left) gem_spin_batch (resubmit-new)
[469.333711] Starting subtest: resubmit-new
[469.336321] Starting dynamic subtest: rcs0
[469.344301] Dynamic subtest rcs0: SUCCESS (0.010s)
[469.355475] Starting dynamic subtest: bcs0
[469.359136] Dynamic subtest bcs0: SUCCESS (0.005s)
[469.369748] Starting dynamic subtest: vcs0
[469.372032] Dynamic subtest vcs0: SUCCESS (0.006s)
[469.382383] Starting dynamic subtest: vcs1
[469.385366] Dynamic subtest vcs1: SUCCESS (0.005s)
[469.395220] Starting dynamic subtest: vecs0
[469.397512] Dynamic subtest vecs0: SUCCESS (0.006s)
[469.407072] Starting dynamic subtest: ccs0
[469.409467] Dynamic subtest ccs0: SUCCESS (0.007s)
[469.412150] Subtest resubmit-new: SUCCESS (0.044s)
[471.006798] [046/133] (549s left) testdisplay
[471.327323] [047/133] (549s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[471.411849] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[471.414445] Starting dynamic subtest: pipe-A-eDP-1
[471.562227] Dynamic subtest pipe-A-eDP-1: SKIP (0.153s)
[471.574446] Starting dynamic subtest: pipe-B-eDP-1
[472.729369] Dynamic subtest pipe-B-eDP-1: SKIP (1.163s)
[472.735139] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.318s)
[473.916420] [048/133] (547s left) i915_selftest (live)
[475.688927] Starting subtest: live
[475.691699] Starting dynamic subtest: sanitycheck
[479.230704] Dynamic subtest sanitycheck: SUCCESS (3.539s)
[479.240973] Starting dynamic subtest: uncore
[482.767018] Dynamic subtest uncore: SUCCESS (3.533s)
[482.778327] Starting dynamic subtest: workarounds
[486.823974] Dynamic subtest workarounds: SUCCESS (4.055s)
[486.834277] Starting dynamic subtest: gt_engines
[490.751791] Dynamic subtest gt_engines: SUCCESS (3.927s)
[490.762414] Starting dynamic subtest: gt_timelines
[505.342620] Dynamic subtest gt_timelines: SUCCESS (14.590s)
[505.352872] Starting dynamic subtest: gt_contexts
[508.954069] Dynamic subtest gt_contexts: SUCCESS (3.609s)
[508.964435] Starting dynamic subtest: gt_lrc
[514.112425] Dynamic subtest gt_lrc: SUCCESS (5.156s)
[514.121010] Starting dynamic subtest: gt_mocs
[517.952307] Dynamic subtest gt_mocs: SUCCESS (3.837s)
[517.962441] Starting dynamic subtest: gt_pm
[523.666877] Dynamic subtest gt_pm: SUCCESS (5.710s)
[523.676993] Starting dynamic subtest: gt_heartbeat
[528.836881] Dynamic subtest gt_heartbeat: SUCCESS (5.167s)
[528.847021] Starting dynamic subtest: gt_tlb
[539.656432] Dynamic subtest gt_tlb: SUCCESS (10.814s)
[539.666612] Starting dynamic subtest: requests
[552.624042] Dynamic subtest requests: SUCCESS (12.964s)
[552.634314] Starting dynamic subtest: migrate
[559.251036] Dynamic subtest migrate: SUCCESS (6.627s)
[559.263900] Starting dynamic subtest: active
[562.803562] Dynamic subtest active: SUCCESS (3.553s)
[562.813841] Starting dynamic subtest: objects
[566.989889] Dynamic subtest objects: SUCCESS (4.186s)
[566.999433] Starting dynamic subtest: mman
[572.692083] Dynamic subtest mman: SUCCESS (5.700s)
[572.701891] Starting dynamic subtest: dmabuf
[576.280819] Dynamic subtest dmabuf: SUCCESS (3.587s)
[576.291379] Starting dynamic subtest: vma
[581.541989] Dynamic subtest vma: SUCCESS (5.260s)
[581.551876] Starting dynamic subtest: coherency
[587.409073] Dynamic subtest coherency: SUCCESS (5.865s)
[587.418971] Starting dynamic subtest: gtt
[597.732473] Dynamic subtest gtt: SUCCESS (10.322s)
[597.742917] Starting dynamic subtest: gem
[604.616006] Dynamic subtest gem: SUCCESS (6.880s)
[604.626175] Starting dynamic subtest: evict
[609.448866] Dynamic subtest evict: SUCCESS (4.829s)
[609.458439] Starting dynamic subtest: hugepages
[619.734012] Dynamic subtest hugepages: SUCCESS (10.282s)
[619.743978] Starting dynamic subtest: gem_contexts
[646.036661] Dynamic subtest gem_contexts: SUCCESS (26.296s)
[646.046538] Starting dynamic subtest: client
[649.704236] Dynamic subtest client: SUCCESS (3.665s)
[649.712479] Starting dynamic subtest: gem_migrate
[653.287821] Dynamic subtest gem_migrate: SUCCESS (3.580s)
[653.303264] Starting dynamic subtest: reset
[656.915237] Dynamic subtest reset: SUCCESS (3.624s)
[656.924421] Starting dynamic subtest: memory_region
[660.463002] Dynamic subtest memory_region: SUCCESS (3.545s)
[660.473378] Starting dynamic subtest: hangcheck
[674.650989] Dynamic subtest hangcheck: SUCCESS (14.182s)
[674.659230] Starting dynamic subtest: execlists
[679.797745] Dynamic subtest execlists: SUCCESS (5.144s)
[679.808269] Starting dynamic subtest: ring_submission
[683.366011] Dynamic subtest ring_submission: SUCCESS (3.568s)
[683.376719] Starting dynamic subtest: perf
[688.708976] Dynamic subtest perf: SUCCESS (5.342s)
[688.718975] Starting dynamic subtest: slpc
[702.148698] Dynamic subtest slpc: SUCCESS (13.439s)
[702.165660] Starting dynamic subtest: guc
[706.919241] Dynamic subtest guc: SUCCESS (4.769s)
[706.928825] Starting dynamic subtest: guc_multi_lrc
[710.484940] Dynamic subtest guc_multi_lrc: SUCCESS (3.564s)
[710.496828] Starting dynamic subtest: guc_hang
[714.752978] Dynamic subtest guc_hang: SUCCESS (4.266s)
[714.766833] Starting dynamic subtest: late_gt_pm
[718.355429] Dynamic subtest late_gt_pm: SUCCESS (3.601s)
[718.358447] Subtest live: SUCCESS (242.645s)
[718.389428] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[718.390128] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[718.394129] [049/133] (302s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[720.809862] Subtest writes-after-reads-uncached: SKIP (0.000s)
[720.905148] [FACT gem_partial_pwrite_pread (writes-after-reads-uncached)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[720.906216] [FACT gem_partial_pwrite_pread (writes-after-reads-uncached)] new: kernel.kmod_is_loaded.i915: true
[720.910282] [050/133] (300s left) kms_getfb (getfb-handle-not-fb)
[720.991451] Starting subtest: getfb-handle-not-fb
[720.994269] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[721.099081] [051/133] (300s left) kms_psr (fbc-psr-sprite-plane-onoff)
[721.180377] Starting subtest: fbc-psr-sprite-plane-onoff
[721.183039] Starting dynamic subtest: eDP-1
[721.187475] Dynamic subtest eDP-1: SKIP (0.000s)
[721.192062] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[721.255175] [052/133] (299s left) i915_hangman (gt-error-state-capture)
[721.330780] Starting subtest: gt-error-state-capture
[721.333468] Starting dynamic subtest: rcs0
[732.938277] Dynamic subtest rcs0: SUCCESS (11.607s)
[732.954431] Starting dynamic subtest: bcs0
[744.908918] Dynamic subtest bcs0: SUCCESS (11.967s)
[744.920338] Starting dynamic subtest: vcs0
[756.940777] Dynamic subtest vcs0: SUCCESS (12.029s)
[756.959029] Starting dynamic subtest: vcs1
[767.947667] Dynamic subtest vcs1: SUCCESS (11.004s)
[767.960587] Starting dynamic subtest: vecs0
[778.956254] Dynamic subtest vecs0: SUCCESS (11.004s)
[778.969386] Starting dynamic subtest: ccs0
[790.924745] Dynamic subtest ccs0: SUCCESS (11.964s)
[790.927864] Subtest gt-error-state-capture: SUCCESS (69.589s)
[791.038969] [053/133] (230s left) perf (invalid-open-flags)
[791.158461] Starting subtest: invalid-open-flags
[791.161037] Subtest invalid-open-flags: SUCCESS (0.000s)
[791.233833] [054/133] (230s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[791.316203] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[791.320870] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[791.412679] [055/133] (229s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[791.486969] Starting subtest: async-flip-with-page-flip-events-linear
[791.874234] Starting dynamic subtest: pipe-A-eDP-1
[794.651083] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.776s)
[795.026387] Starting dynamic subtest: pipe-B-eDP-1
[797.782455] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.761s)
[798.152344] Starting dynamic subtest: pipe-C-eDP-1
[800.908984] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.764s)
[801.282191] Starting dynamic subtest: pipe-D-eDP-1
[804.033729] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.759s)
[804.036603] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.546s)
[805.217950] [056/133] (216s left) sw_sync (alloc_fence)
[805.253268] Starting subtest: alloc_fence
[805.255886] Subtest alloc_fence: SUCCESS (0.000s)
[805.319123] [057/133] (216s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[805.385654] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[805.387802] Starting dynamic subtest: pipe-A-default-mode
[806.596731] Dynamic subtest pipe-A-default-mode: SKIP (1.205s)
[806.601340] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.206s)
[806.728848] [058/133] (214s left) gem_ctx_persistence (heartbeat-close)
[806.785338] Starting subtest: heartbeat-close
[806.790678] Subtest heartbeat-close: SKIP (0.000s)
[806.879562] [059/133] (214s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[806.961454] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[806.966434] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[807.063972] [060/133] (214s left) kms_flip (2x-flip-vs-modeset)
[807.139289] Starting subtest: 2x-flip-vs-modeset
[807.146259] Subtest 2x-flip-vs-modeset: SKIP (0.007s)
[807.245824] [061/133] (214s left) sw_sync (alloc_timeline)
[807.292361] Starting subtest: alloc_timeline
[807.295082] Subtest alloc_timeline: SUCCESS (0.000s)
[807.345345] [062/133] (214s left) gem_exec_fence (syncobj-timeline-chain-engines)
[807.875071] Starting subtest: syncobj-timeline-chain-engines
[808.026164] Subtest syncobj-timeline-chain-engines: SUCCESS (0.151s)
[809.052253] [063/133] (212s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[809.147306] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[809.152315] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[809.222759] [064/133] (212s left) perf_pmu (all-busy-check-all)
[809.269711] Starting subtest: all-busy-check-all
[810.989922] Subtest all-busy-check-all: SUCCESS (1.720s)
[811.085121] [065/133] (210s left) kms_chamelium_frames (hdmi-crc-single)
[811.448085] Subtest hdmi-crc-single: SKIP (0.000s)
[812.265474] [066/133] (209s left) kms_draw_crc (draw-method-mmap-wc)
[812.332948] Starting subtest: draw-method-mmap-wc
[812.335642] Starting dynamic subtest: xrgb8888-untiled
[812.566862] Dynamic subtest xrgb8888-untiled: SUCCESS (0.234s)
[812.577169] Starting dynamic subtest: rgb565-untiled
[812.778069] Dynamic subtest rgb565-untiled: SUCCESS (0.210s)
[812.790468] Starting dynamic subtest: xrgb2101010-untiled
[812.978217] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.199s)
[812.988344] Starting dynamic subtest: xbgr16161616f-untiled
[813.189761] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.210s)
[813.210808] Starting dynamic subtest: xrgb8888-xtiled
[813.322781] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.132s)
[813.335020] Starting dynamic subtest: rgb565-xtiled
[813.444462] Dynamic subtest rgb565-xtiled: SUCCESS (0.120s)
[813.454490] Starting dynamic subtest: xrgb2101010-xtiled
[813.555620] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s)
[813.565125] Starting dynamic subtest: xbgr16161616f-xtiled
[813.677653] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.121s)
[813.687736] Starting dynamic subtest: xrgb8888-4tiled
[813.833326] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.155s)
[813.843917] Starting dynamic subtest: rgb565-4tiled
[813.966753] Dynamic subtest rgb565-4tiled: SUCCESS (0.132s)
[813.978639] Starting dynamic subtest: xrgb2101010-4tiled
[814.111084] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.144s)
[814.121006] Starting dynamic subtest: xbgr16161616f-4tiled
[814.277354] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.166s)
[814.279138] Subtest draw-method-mmap-wc: SUCCESS (1.945s)
[814.379240] [067/133] (207s left) kms_content_protection (atomic)
[814.497798] Starting subtest: atomic
[814.502694] Subtest atomic: SKIP (0.000s)
[814.606771] [068/133] (207s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[814.685164] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[814.687220] Starting dynamic subtest: pipe-A-eDP-1
[814.707608] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[814.719228] Starting dynamic subtest: pipe-B-eDP-1
[814.740728] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[814.749683] Starting dynamic subtest: pipe-C-eDP-1
[814.769418] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[814.777925] Starting dynamic subtest: pipe-D-eDP-1
[814.797229] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[814.800818] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.005s)
[816.881161] [069/133] (205s left) kms_psr (pr-primary-render)
[816.955714] Starting subtest: pr-primary-render
[816.960304] Subtest pr-primary-render: SKIP (0.000s)
[817.033953] [070/133] (204s left) gem_exec_flush (basic-uc-ro-default)
[817.105944] Starting subtest: basic-uc-ro-default
[822.565138] Subtest basic-uc-ro-default: SUCCESS (5.456s)
[822.752526] [071/133] (199s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[822.838406] Starting subtest: fb-8bpc-vs-panel-8bpc
[822.841194] Starting dynamic subtest: pipe-A-eDP-1
[824.274926] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.438s)
[824.277700] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.439s)
[825.136349] [072/133] (196s left) gem_madvise (dontneed-after-mmap)
[825.174673] Starting subtest: dontneed-after-mmap
[825.192371] Subtest dontneed-after-mmap: SUCCESS (0.017s)
[825.319577] [073/133] (196s left) kms_plane_alpha_blend (constant-alpha-mid)
[825.384359] Starting subtest: constant-alpha-mid
[825.689360] Starting dynamic subtest: pipe-A-eDP-1
[826.479420] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.790s)
[826.491060] Starting dynamic subtest: pipe-D-eDP-1
[827.915497] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.434s)
[827.918482] Subtest constant-alpha-mid: SUCCESS (2.533s)
[828.739408] [074/133] (193s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[828.803023] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[828.873101] [075/133] (193s left) kms_flip (2x-flip-vs-wf_vblank)
[828.950328] Starting subtest: 2x-flip-vs-wf_vblank
[828.958070] Subtest 2x-flip-vs-wf_vblank: SKIP (0.007s)
[829.036832] [076/133] (193s left) kms_cursor_crc (cursor-sliding-128x42)
[829.251214] Starting subtest: cursor-sliding-128x42
[829.298107] Subtest cursor-sliding-128x42: SKIP (0.039s)
[829.503917] [077/133] (192s left) kms_psr (psr2-suspend)
[829.572297] Starting subtest: psr2-suspend
[829.575137] Starting dynamic subtest: eDP-1
[847.147175] Dynamic subtest eDP-1: SUCCESS (2.894s)
[847.149284] Subtest psr2-suspend: SUCCESS (2.895s)
[848.025184] [078/133] (174s left) gem_mmap_offset (open-flood)
[848.092642] Starting subtest: open-flood
[869.565368] Subtest open-flood: SUCCESS (21.489s)
[869.666982] [079/133] (152s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[869.760986] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[869.764349] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[869.858028] [080/133] (152s left) gem_exec_nop (basic-sequential)
[869.922635] Starting subtest: basic-sequential
[884.683988] Subtest basic-sequential: SUCCESS (14.766s)
[884.915755] [081/133] (137s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[884.996128] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[885.000729] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[885.100077] [082/133] (137s left) gem_mmap_gtt (basic-small-bo-tiledy)
[885.164024] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[885.227221] [083/133] (137s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[885.312288] Starting subtest: y-tiled-64bpp-rotate-90
[885.317063] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[885.419163] [084/133] (137s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[885.493864] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[894.088925] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.598s)
[894.205773] [085/133] (128s left) gem_exec_alignment (single)
[894.264288] Starting subtest: single
[894.269469] Subtest single: SUCCESS (0.005s)
[894.390922] [086/133] (128s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[894.496656] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[894.500965] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[894.599107] [087/133] (128s left) syncobj_timeline (etime-single-wait-submitted)
[894.665503] Starting subtest: etime-single-wait-submitted
[894.770644] Subtest etime-single-wait-submitted: SUCCESS (0.104s)
[894.844817] [088/133] (127s left) i915_drm_fdinfo (virtual-busy-all)
[894.882150] Starting subtest: virtual-busy-all
[894.886724] Subtest virtual-busy-all: SKIP (0.000s)
[894.943378] [089/133] (127s left) gem_ctx_exec (basic)
[894.995022] Starting subtest: basic
[894.999889] Subtest basic: SUCCESS (0.006s)
[895.118489] [090/133] (127s left) gem_busy (parallel)
[895.302642] Starting subtest: parallel
[895.304685] Starting dynamic subtest: rcs0
[896.647227] Dynamic subtest rcs0: SUCCESS (1.346s)
[896.658800] Starting dynamic subtest: bcs0
[898.630811] Dynamic subtest bcs0: SUCCESS (1.980s)
[898.644495] Starting dynamic subtest: vcs0
[900.615626] Dynamic subtest vcs0: SUCCESS (1.982s)
[900.628449] Starting dynamic subtest: vcs1
[902.599190] Dynamic subtest vcs1: SUCCESS (1.981s)
[902.614196] Starting dynamic subtest: vecs0
[904.646608] Dynamic subtest vecs0: SUCCESS (2.045s)
[904.659742] Starting dynamic subtest: ccs0
[906.630647] Dynamic subtest ccs0: SUCCESS (1.982s)
[906.633668] Subtest parallel: SUCCESS (11.331s)
[906.862660] [091/133] (116s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[906.918442] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[906.920675] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[907.038269] [092/133] (115s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[907.120149] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[907.124625] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[907.203085] [093/133] (115s left) kms_vblank (ts-continuation-dpms-rpm)
[907.271820] Starting subtest: ts-continuation-dpms-rpm
[907.274179] Starting dynamic subtest: pipe-A-eDP-1
[909.734841] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.462s)
[909.749740] Starting dynamic subtest: pipe-D-eDP-1
[911.904269] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.164s)
[911.906174] Subtest ts-continuation-dpms-rpm: SUCCESS (4.630s)
[912.715113] [094/133] (110s left) sw_sync (timeline_closed_signaled)
[912.755346] Starting subtest: timeline_closed_signaled
[912.757971] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[912.812216] [095/133] (110s left) gem_lmem_swapping (verify)
[912.857573] Subtest verify: SKIP (0.000s)
[912.901245] [096/133] (110s left) syncobj_wait (invalid-signal-zero-handles)
[912.956889] Starting subtest: invalid-signal-zero-handles
[912.959140] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[913.057496] [097/133] (110s left) kms_pm_rpm (i2c)
[914.772954] Starting subtest: i2c
[920.265951] Subtest i2c: SUCCESS (5.495s)
[920.357213] [098/133] (102s left) vgem_basic (setversion)
[920.395811] Starting subtest: setversion
[920.400077] Subtest setversion: SUCCESS (0.000s)
[920.467865] [099/133] (102s left) gem_exec_reloc (basic-write-gtt)
[920.526390] Subtest basic-write-gtt: SKIP (0.000s)
[920.599331] [100/133] (102s left) kms_scaling_modes (scaling-mode-center)
[920.678159] Starting subtest: scaling-mode-center
[920.679981] Starting dynamic subtest: pipe-A-eDP-1
[920.773991] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.097s)
[920.790979] Starting dynamic subtest: pipe-B-eDP-1
[921.937379] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.160s)
[921.948828] Starting dynamic subtest: pipe-C-eDP-1
[923.043220] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.105s)
[923.054046] Starting dynamic subtest: pipe-D-eDP-1
[924.176044] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.131s)
[924.178370] Subtest scaling-mode-center: SUCCESS (3.501s)
[925.332333] [101/133] ( 98s left) perf_pmu (frequency)
[925.373461] Starting subtest: frequency
[925.375964] Starting dynamic subtest: gt0
[927.521369] Dynamic subtest gt0: SUCCESS (2.141s)
[927.533515] Starting dynamic subtest: idle-gt0
[928.026865] Dynamic subtest idle-gt0: SUCCESS (0.504s)
[928.039600] Starting dynamic subtest: gt1
[932.614321] Dynamic subtest gt1: SUCCESS (4.582s)
[932.626852] Starting dynamic subtest: idle-gt1
[933.118623] Dynamic subtest idle-gt1: SUCCESS (0.504s)
[933.121343] Subtest frequency: SUCCESS (7.749s)
[933.223605] [102/133] ( 90s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[933.309403] Starting subtest: 4-tiled-32bpp-rotate-180
[934.622951] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.313s)
[934.754548] [103/133] ( 88s left) kms_hdr (bpc-switch-dpms)
[934.834050] Starting subtest: bpc-switch-dpms
[935.900227] Starting dynamic subtest: pipe-A-eDP-1
[940.422264] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.524s)
[940.424666] Subtest bpc-switch-dpms: SUCCESS (5.588s)
[940.536430] [104/133] ( 82s left) syncobj_timeline (wait-any-interrupted)
[940.587783] Starting subtest: wait-any-interrupted
[940.690224] Subtest wait-any-interrupted: SUCCESS (0.103s)
[940.782730] [105/133] ( 82s left) gem_exec_parallel (contexts)
[940.848508] Starting subtest: contexts
[940.850940] Starting dynamic subtest: rcs0
[943.568144] Dynamic subtest rcs0: SUCCESS (2.720s)
[943.581460] Starting dynamic subtest: bcs0
[947.007050] Dynamic subtest bcs0: SUCCESS (3.438s)
[947.017826] Starting dynamic subtest: vcs0
[951.424291] Dynamic subtest vcs0: SUCCESS (4.415s)
[951.439448] Starting dynamic subtest: vcs1
[957.023801] Dynamic subtest vcs1: SUCCESS (5.596s)
[957.037492] Starting dynamic subtest: vecs0
[961.138690] Dynamic subtest vecs0: SUCCESS (4.111s)
[961.152309] Starting dynamic subtest: ccs0
[964.830027] Dynamic subtest ccs0: SUCCESS (3.690s)
[964.832562] Subtest contexts: SUCCESS (23.983s)
[965.019360] [106/133] ( 58s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[965.139964] Starting subtest: verify-pxp-key-change-after-suspend-resume
[972.345371] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.207s)
[972.463896] [107/133] ( 51s left) gem_create (create-ext-placement-each)
[972.636475] Starting subtest: create-ext-placement-each
[972.638656] Subtest create-ext-placement-each: SUCCESS (0.000s)
[972.751332] [108/133] ( 50s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[972.827233] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[972.829630] Starting dynamic subtest: pipe-A-eDP-1
[972.850829] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[972.862877] Starting dynamic subtest: pipe-B-eDP-1
[972.882980] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[972.893356] Starting dynamic subtest: pipe-C-eDP-1
[972.912920] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[972.923115] Starting dynamic subtest: pipe-D-eDP-1
[972.940997] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[972.942702] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.007s)
[975.009183] [109/133] ( 48s left) gem_close_race (basic-process)
[975.080376] Starting subtest: basic-process
[975.129117] Subtest basic-process: SUCCESS (0.049s)
[975.311956] [110/133] ( 48s left) gem_exec_schedule (u-independent)
[975.379979] Starting subtest: u-independent
[975.382344] Starting dynamic subtest: rcs0
[976.646349] Dynamic subtest rcs0: SUCCESS (1.276s)
[976.661126] Starting dynamic subtest: vcs0
[978.640363] Dynamic subtest vcs0: SUCCESS (1.993s)
[978.653803] Starting dynamic subtest: vcs1
[980.687796] Dynamic subtest vcs1: SUCCESS (2.045s)
[980.704998] Starting dynamic subtest: vecs0
[982.671753] Dynamic subtest vecs0: SUCCESS (1.983s)
[982.684190] Starting dynamic subtest: ccs0
[984.646081] Dynamic subtest ccs0: SUCCESS (1.974s)
[984.648421] Subtest u-independent: SUCCESS (9.279s)
[984.940828] [111/133] ( 38s left) gen9_exec_parse (batch-without-end)
[984.999435] Subtest batch-without-end: SKIP (0.000s)
[985.072152] [112/133] ( 38s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[990.546475] Starting subtest: dpms-mode-unset-lpsp
[994.610621] Subtest dpms-mode-unset-lpsp: SUCCESS (4.063s)
[995.002835] [113/133] ( 28s left) kms_chamelium_hpd (vga-hpd)
[995.376834] Subtest vga-hpd: SKIP (0.000s)
[996.200117] [114/133] ( 27s left) gem_lmem_swapping (heavy-multi)
[996.247276] Subtest heavy-multi: SKIP (0.000s)
[996.288535] [115/133] ( 27s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[996.373536] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[996.377596] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[996.439209] [116/133] ( 27s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[996.523395] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[996.527970] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[996.623284] [117/133] ( 27s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[996.705307] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[1001.144274] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.445s)
[1002.318167] [118/133] ( 21s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[1002.398463] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[1009.696672] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.303s)
[1009.827340] [119/133] ( 14s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[1009.914837] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[1009.919241] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[1010.017612] [120/133] ( 14s left) gem_exec_balancer (noheartbeat)
[1010.292316] Starting subtest: noheartbeat
[1010.297194] Subtest noheartbeat: SKIP (0.000s)
[1010.399426] [121/133] ( 13s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[1010.448218] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[1010.554444] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.106s)
[1010.631576] [122/133] ( 13s left) kms_big_fb (linear-addfb)
[1010.741467] Starting subtest: linear-addfb
[1010.743764] Subtest linear-addfb: SUCCESS (0.000s)
[1010.832112] [123/133] ( 13s left) perf_pmu (busy)
[1010.866548] Starting subtest: busy
[1010.868798] Starting dynamic subtest: rcs0
[1011.453003] Dynamic subtest rcs0: SUCCESS (0.587s)
[1011.464975] Starting dynamic subtest: bcs0
[1012.024941] Dynamic subtest bcs0: SUCCESS (0.569s)
[1012.038157] Starting dynamic subtest: vcs0
[1013.637938] Dynamic subtest vcs0: SUCCESS (1.610s)
[1013.651430] Starting dynamic subtest: vcs1
[1015.622420] Dynamic subtest vcs1: SUCCESS (1.981s)
[1015.635626] Starting dynamic subtest: vecs0
[1017.670741] Dynamic subtest vecs0: SUCCESS (2.044s)
[1017.684683] Starting dynamic subtest: ccs0
[1018.233239] Dynamic subtest ccs0: SUCCESS (0.561s)
[1018.235854] Subtest busy: SUCCESS (7.368s)
[1018.323688] [124/133] (  6s left) kms_force_connector_basic (force-load-detect)
[1018.392438] Subtest force-load-detect: SKIP (0.000s)
[1018.458130] [125/133] (  5s left) gem_ctx_param (invalid-get-ringsize)
[1018.511505] Starting subtest: invalid-get-ringsize
[1018.513810] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[1018.609101] [126/133] (  5s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[1018.691146] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[1025.964207] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.277s)
[1026.052616] Overall timeout time exceeded, stopping.
[1026.068272] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_crc
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: sysfs_timeslice_duration
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: drm_buddy
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: kms_ccs
results: parsing output: 8/ for test: syncobj_timeline
results: parsing output: 9/ for test: perf_pmu
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_psr2_sf
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: gem_exec_balancer
results: parsing output: 15/ for test: kms_joiner
results: parsing output: 16/ for test: kms_cursor_legacy
results: parsing output: 17/ for test: gem_wait
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_flip
results: parsing output: 20/ for test: kms_lease
results: parsing output: 21/ for test: gem_exec_params
results: parsing output: 22/ for test: api_intel_bb
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: i915_pm_rpm
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: gem_exec_schedule
results: parsing output: 27/ for test: gem_exec_flush
results: parsing output: 28/ for test: kms_color_pipeline
results: parsing output: 29/ for test: gem_exec_schedule
results: parsing output: 30/ for test: kms_cursor_crc
results: parsing output: 31/ for test: perf
results: parsing output: 32/ for test: api_intel_bb
results: parsing output: 33/ for test: prime_mmap
results: parsing output: 34/ for test: kms_atomic_transition
results: parsing output: 35/ for test: kms_plane_scaling
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_pxp
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_userptr_blits
results: parsing output: 40/ for test: gem_eio
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_selftest
results: parsing output: 44/ for test: gem_spin_batch
results: parsing output: 45/ for test: testdisplay
results: parsing output: 46/ for test: kms_psr2_sf
results: parsing output: 47/ for test: i915_selftest
results: parsing output: 48/ for test: gem_partial_pwrite_pread
results: parsing output: 49/ for test: kms_getfb
results: parsing output: 50/ for test: kms_psr
results: parsing output: 51/ for test: i915_hangman
results: parsing output: 52/ for test: perf
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_async_flips
results: parsing output: 55/ for test: sw_sync
results: parsing output: 56/ for test: kms_flip_scaled_crc
results: parsing output: 57/ for test: gem_ctx_persistence
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: kms_flip
results: parsing output: 60/ for test: sw_sync
results: parsing output: 61/ for test: gem_exec_fence
results: parsing output: 62/ for test: kms_plane
results: parsing output: 63/ for test: perf_pmu
results: parsing output: 64/ for test: kms_chamelium_frames
results: parsing output: 65/ for test: kms_draw_crc
results: parsing output: 66/ for test: kms_content_protection
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: gem_exec_flush
results: parsing output: 70/ for test: kms_dither
results: parsing output: 71/ for test: gem_madvise
results: parsing output: 72/ for test: kms_plane_alpha_blend
results: parsing output: 73/ for test: kms_pipe_b_c_ivb
results: parsing output: 74/ for test: kms_flip
results: parsing output: 75/ for test: kms_cursor_crc
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: gem_mmap_offset
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_exec_nop
results: parsing output: 80/ for test: kms_flip_scaled_crc
results: parsing output: 81/ for test: gem_mmap_gtt
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: gem_exec_alignment
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: syncobj_timeline
results: parsing output: 87/ for test: i915_drm_fdinfo
results: parsing output: 88/ for test: gem_ctx_exec
results: parsing output: 89/ for test: gem_busy
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: kms_flip_scaled_crc
results: parsing output: 92/ for test: kms_vblank
results: parsing output: 93/ for test: sw_sync
results: parsing output: 94/ for test: gem_lmem_swapping
results: parsing output: 95/ for test: syncobj_wait
results: parsing output: 96/ for test: kms_pm_rpm
results: parsing output: 97/ for test: vgem_basic
results: parsing output: 98/ for test: gem_exec_reloc
results: parsing output: 99/ for test: kms_scaling_modes
results: parsing output: 100/ for test: perf_pmu
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: kms_hdr
results: parsing output: 103/ for test: syncobj_timeline
results: parsing output: 104/ for test: gem_exec_parallel
results: parsing output: 105/ for test: gem_pxp
results: parsing output: 106/ for test: gem_create
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: gem_close_race
results: parsing output: 109/ for test: gem_exec_schedule
results: parsing output: 110/ for test: gen9_exec_parse
results: parsing output: 111/ for test: kms_pm_rpm
results: parsing output: 112/ for test: kms_chamelium_hpd
results: parsing output: 113/ for test: gem_lmem_swapping
results: parsing output: 114/ for test: kms_psr2_sf
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: gem_exec_balancer
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: perf_pmu
results: parsing output: 123/ for test: kms_force_connector_basic
results: parsing output: 124/ for test: gem_ctx_param
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_cursor_legacy
results: 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.