[89.336627] Initializing watchdogs
[89.336805]   /dev/watchdog0
[89.375544] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3184 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 605]
[89.389909] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[89.396431] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[89.401524] [001/133] (960s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[89.586180] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[89.587305] Starting dynamic subtest: pipe-A-HDMI-A-1
[89.596852] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.003s)
[89.611910] Starting dynamic subtest: pipe-A-HDMI-A-2
[89.633724] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.003s)
[89.650726] Starting dynamic subtest: pipe-B-HDMI-A-1
[89.670719] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s)
[89.685142] Starting dynamic subtest: pipe-B-HDMI-A-2
[89.694834] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.002s)
[89.709141] Starting dynamic subtest: pipe-C-HDMI-A-1
[89.717840] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[89.732202] Starting dynamic subtest: pipe-C-HDMI-A-2
[89.740173] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.003s)
[89.742702] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.030s)
[90.510273] [002/133] (959s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[90.621596] Starting subtest: rel-constants-invalid-rel-gen5
[90.622663] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[90.776203] [003/133] (959s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[90.958628] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[90.963292] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[91.094655] [004/133] (959s left) syncobj_timeline (32bits-limit)
[91.194072] Starting subtest: 32bits-limit
[91.196643] Subtest 32bits-limit: SUCCESS (0.003s)
[91.311331] [005/133] (958s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[91.481164] Starting subtest: flip-vs-cursor-atomic-transitions
[104.807648] Subtest flip-vs-cursor-atomic-transitions: FAIL (13.031s)
[104.875454] [006/133] (945s left) i915_drm_fdinfo (memory-info-shared)
[104.979832] Starting subtest: memory-info-shared
[104.980975] Starting dynamic subtest: smem0
[105.031960] Dynamic subtest smem0: SUCCESS (0.052s)
[105.033916] Subtest memory-info-shared: SUCCESS (0.053s)
[105.163877] [007/133] (945s left) kms_scaling_modes (scaling-mode-full-aspect)
[105.331293] Starting subtest: scaling-mode-full-aspect
[105.338309] Subtest scaling-mode-full-aspect: SKIP (0.003s)
[105.460197] [008/133] (944s left) dumb_buffer (invalid-bpp)
[105.555359] Starting subtest: invalid-bpp
[105.556381] Subtest invalid-bpp: SUCCESS (0.000s)
[105.696383] [009/133] (944s left) vgem_basic (create)
[105.875512] Starting subtest: create
[105.876546] Subtest create: SUCCESS (0.001s)
[105.987710] [FACT vgem_basic (create)] new: kernel.kmod_is_loaded.vgem: true
[105.991700] [010/133] (944s left) kms_busy (basic)
[106.170713] Starting subtest: basic
[106.174605] Starting dynamic subtest: flip
[107.154248] Dynamic subtest flip: SUCCESS (0.974s)
[107.170453] Starting dynamic subtest: modeset
[108.411859] Dynamic subtest modeset: SUCCESS (1.260s)
[108.413805] Subtest basic: SUCCESS (2.239s)
[108.733803] [011/133] (941s left) gem_mmap_gtt (medium-copy-xy)
[108.833375] Starting subtest: medium-copy-XY
[114.516979] Subtest medium-copy-XY: SUCCESS (5.683s)
[114.710838] [012/133] (936s left) kms_psr (pr-sprite-blt)
[114.987433] Subtest pr-sprite-blt: SKIP (0.000s)
[115.099681] [013/133] (935s left) i915_hangman (detector)
[115.219622] Starting subtest: detector
[115.220642] Starting dynamic subtest: rcs0
[125.238612] Dynamic subtest rcs0: SUCCESS (10.019s)
[125.255059] Starting dynamic subtest: bcs0
[135.221144] Dynamic subtest bcs0: SUCCESS (9.979s)
[135.237873] Starting dynamic subtest: vcs0
[145.218543] Dynamic subtest vcs0: SUCCESS (9.993s)
[145.235281] Starting dynamic subtest: vecs0
[155.195716] Dynamic subtest vecs0: SUCCESS (9.979s)
[155.196919] Subtest detector: SUCCESS (39.976s)
[155.385308] [014/133] (895s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[155.567721] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[158.451455] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (2.882s)
[158.737891] [015/133] (892s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[158.917374] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[158.919168] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[159.068917] [016/133] (892s left) kms_content_protection (uevent)
[159.274345] Starting subtest: uevent
[159.291887] Subtest uevent: SKIP (0.009s)
[159.435542] [017/133] (891s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[159.625636] Starting subtest: x-tiled-8bpp-rotate-180
[162.651898] Subtest x-tiled-8bpp-rotate-180: SUCCESS (3.025s)
[162.959089] [018/133] (888s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[163.483747] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[163.729581] [019/133] (887s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[163.913171] Starting subtest: 4-tiled-16bpp-rotate-0
[163.916869] Subtest 4-tiled-16bpp-rotate-0: SKIP (0.000s)
[164.066507] [020/133] (887s left) kms_tiled_display (basic-test-pattern)
[164.311207] Starting subtest: basic-test-pattern
[165.449738] Subtest basic-test-pattern: FAIL (0.906s)
[165.526569] [021/133] (886s left) kms_pm_rpm (modeset-pc8-residency-stress)
[167.307822] Starting subtest: modeset-pc8-residency-stress
[167.316033] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[167.602317] [022/133] (884s left) gem_exec_whisper (basic-fds-forked-all)
[167.723293] Starting subtest: basic-fds-forked-all
[177.928932] Subtest basic-fds-forked-all: SUCCESS (10.205s)
[178.189404] [023/133] (873s left) gem_exec_reloc (basic-concurrent0)
[178.296791] Starting subtest: basic-concurrent0
[183.727772] Subtest basic-concurrent0: SUCCESS (5.432s)
[183.922107] [024/133] (867s left) kms_frontbuffer_tracking (psr-2p-rte)
[184.057706] Starting subtest: psr-2p-rte
[184.059451] Subtest psr-2p-rte: SKIP (0.000s)
[184.220930] [025/133] (867s left) kms_psr (fbc-psr-no-drrs)
[184.337549] Subtest fbc-psr-no-drrs: SKIP (0.000s)
[184.442827] [026/133] (867s left) gem_sync (basic-all)
[184.558726] Starting subtest: basic-all
[187.047662] Subtest basic-all: SUCCESS (2.488s)
[187.288708] [027/133] (864s left) kms_vblank (query-forked-busy)
[187.410237] Starting subtest: query-forked-busy
[187.411331] Starting dynamic subtest: pipe-A-HDMI-A-1
[190.283315] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.870s)
[190.305263] Starting dynamic subtest: pipe-A-HDMI-A-2
[192.896543] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.605s)
[192.921100] Starting dynamic subtest: pipe-C-HDMI-A-1
[195.469166] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.566s)
[195.488514] Starting dynamic subtest: pipe-C-HDMI-A-2
[198.054461] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.579s)
[198.055717] Subtest query-forked-busy: SUCCESS (10.642s)
[198.346051] [028/133] (853s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[198.470960] Starting subtest: addfb25-framebuffer-vs-set-tiling
[198.472070] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[198.629922] [029/133] (853s left) gem_render_copy (y-tiled-to-vebox-linear)
[198.739928] Starting subtest: y-tiled-to-vebox-linear
[198.742115] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[198.998584] [030/133] (853s left) syncobj_wait (multi-wait-submitted-signaled)
[199.106219] Starting subtest: multi-wait-submitted-signaled
[199.107281] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[199.247692] [031/133] (853s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[199.386751] Starting subtest: y-tiled-16bpp-rotate-90
[199.661867] Subtest y-tiled-16bpp-rotate-90: SKIP (0.276s)
[199.912515] [032/133] (852s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[200.047488] Starting subtest: fbcpsr-modesetfrombusy
[200.049488] Subtest fbcpsr-modesetfrombusy: SKIP (0.000s)
[200.198214] [033/133] (852s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[200.303310] Starting subtest: writes-after-reads
[203.273473] Subtest writes-after-reads: SUCCESS (2.970s)
[203.430671] [034/133] (849s left) gem_mmap_gtt (basic-small-bo)
[203.526674] Starting subtest: basic-small-bo
[203.948232] Subtest basic-small-bo: SUCCESS (0.417s)
[204.123612] [035/133] (848s left) i915_pm_rps (engine-order)
[204.342466] Starting subtest: engine-order
[215.783227] Subtest engine-order: SUCCESS (11.441s)
[216.044176] [036/133] (836s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[216.170698] Starting subtest: disable-crc-after-crtc
[216.172162] Starting dynamic subtest: pipe-A-HDMI-A-1
[217.256303] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.077s)
[217.277330] Starting dynamic subtest: pipe-B-HDMI-A-2
[218.047872] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.787s)
[218.068341] Starting dynamic subtest: pipe-C-HDMI-A-1
[218.825812] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.781s)
[218.826903] Subtest disable-crc-after-crtc: SUCCESS (2.657s)
[219.116992] [037/133] (833s left) syncobj_timeline (multi-wait-all-available-signaled)
[219.225561] Starting subtest: multi-wait-all-available-signaled
[219.226517] Subtest multi-wait-all-available-signaled: SUCCESS (0.002s)
[219.368613] [038/133] (833s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[219.501519] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[219.503543] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[219.649975] [039/133] (833s left) gem_bad_reloc (negative-reloc-lut)
[219.754905] Starting subtest: negative-reloc-lut
[219.757985] Subtest negative-reloc-lut: SUCCESS (0.001s)
[219.918726] [040/133] (833s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[220.028732] Starting subtest: yf-tiled-ccs-to-yf-tiled
[220.029814] Starting dynamic subtest: smem
[220.381167] Dynamic subtest smem: SUCCESS (0.351s)
[220.382426] Subtest yf-tiled-ccs-to-yf-tiled: SUCCESS (0.353s)
[220.636842] [041/133] (832s left) gem_softpin (invalid)
[220.745943] Starting subtest: invalid
[220.754100] Subtest invalid: SUCCESS (0.011s)
[220.933804] [042/133] (832s left) i915_selftest (perf)
[222.531217] Starting subtest: perf
[222.532304] Starting dynamic subtest: engine_cs
[225.218858] Dynamic subtest engine_cs: SUCCESS (2.687s)
[225.240377] Starting dynamic subtest: request
[230.785671] Dynamic subtest request: SUCCESS (5.564s)
[230.806825] Starting dynamic subtest: migrate
[233.403437] Dynamic subtest migrate: SUCCESS (2.615s)
[233.423800] Starting dynamic subtest: region
[237.071038] Dynamic subtest region: SUCCESS (3.664s)
[237.072232] Subtest perf: SUCCESS (14.541s)
[237.134296] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[237.137290] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[237.140950] [043/133] (816s left) kms_psr (fbc-psr2-basic)
[239.611827] Subtest fbc-psr2-basic: SKIP (0.000s)
[239.724839] [FACT kms_psr (fbc-psr2-basic)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[239.727802] [FACT kms_psr (fbc-psr2-basic)] new: kernel.kmod_is_loaded.i915: true
[239.733724] [044/133] (813s left) syncobj_timeline (wait-zero-handles)
[239.833859] Starting subtest: wait-zero-handles
[239.834924] Subtest wait-zero-handles: SUCCESS (0.000s)
[239.974099] [045/133] (813s left) syncobj_timeline (transfer-timeline-point)
[240.068641] Starting subtest: transfer-timeline-point
[240.071533] Subtest transfer-timeline-point: SUCCESS (0.001s)
[240.206990] [046/133] (813s left) perf_pmu (semaphore-wait)
[240.319444] Starting subtest: semaphore-wait
[240.322591] Starting dynamic subtest: rcs0
[240.843812] Dynamic subtest rcs0: SUCCESS (0.527s)
[240.864824] Starting dynamic subtest: bcs0
[241.363877] Dynamic subtest bcs0: SUCCESS (0.519s)
[241.384832] Starting dynamic subtest: vcs0
[241.881909] Dynamic subtest vcs0: SUCCESS (0.515s)
[241.902676] Starting dynamic subtest: vecs0
[242.397878] Dynamic subtest vecs0: SUCCESS (0.513s)
[242.399064] Subtest semaphore-wait: SUCCESS (2.084s)
[242.574148] [047/133] (811s left) gem_wait (busy)
[242.700262] Starting subtest: busy
[242.701391] Starting dynamic subtest: all-engines
[243.229734] Dynamic subtest all-engines: SUCCESS (0.529s)
[243.254689] Starting dynamic subtest: rcs0
[243.750563] Dynamic subtest rcs0: SUCCESS (0.519s)
[243.771670] Starting dynamic subtest: bcs0
[244.270533] Dynamic subtest bcs0: SUCCESS (0.517s)
[244.292534] Starting dynamic subtest: vcs0
[244.793676] Dynamic subtest vcs0: SUCCESS (0.521s)
[244.814180] Starting dynamic subtest: vecs0
[245.316179] Dynamic subtest vecs0: SUCCESS (0.518s)
[245.317391] Subtest busy: SUCCESS (2.616s)
[245.593449] [048/133] (808s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[245.703122] Starting subtest: y-tiled-ccs-to-x-tiled
[245.704106] Starting dynamic subtest: smem
[245.935169] Dynamic subtest smem: SUCCESS (0.228s)
[245.936762] Subtest y-tiled-ccs-to-x-tiled: SUCCESS (0.230s)
[246.193996] [049/133] (807s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[246.725332] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[246.985953] [050/133] (807s left) kms_big_fb (linear-8bpp-rotate-0)
[247.175064] Starting subtest: linear-8bpp-rotate-0
[251.317289] Subtest linear-8bpp-rotate-0: SUCCESS (4.141s)
[251.772380] [051/133] (802s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[251.943133] Starting subtest: 2x-flip-vs-modeset-vs-hang
[251.944629] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[266.733771] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (14.789s)
[266.734835] Subtest 2x-flip-vs-modeset-vs-hang: SUCCESS (14.795s)
[267.027370] [052/133] (787s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[267.211928] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[267.214366] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[267.385272] [053/133] (787s left) kms_plane (plane-position-hole)
[267.553413] Starting subtest: plane-position-hole
[268.271285] Starting dynamic subtest: pipe-A-plane-1
[268.803457] Dynamic subtest pipe-A-plane-1: SUCCESS (0.534s)
[268.825721] Starting dynamic subtest: pipe-A-plane-2
[269.358231] Dynamic subtest pipe-A-plane-2: SUCCESS (0.549s)
[269.377056] Starting dynamic subtest: pipe-A-plane-3
[269.910116] Dynamic subtest pipe-A-plane-3: SUCCESS (0.551s)
[269.930676] Starting dynamic subtest: pipe-A-plane-4
[269.932498] Dynamic subtest pipe-A-plane-4: SUCCESS (0.017s)
[270.377310] Starting dynamic subtest: pipe-B-plane-1
[270.877195] Dynamic subtest pipe-B-plane-1: SUCCESS (0.519s)
[270.898865] Starting dynamic subtest: pipe-B-plane-2
[271.394563] Dynamic subtest pipe-B-plane-2: SUCCESS (0.517s)
[271.413901] Starting dynamic subtest: pipe-B-plane-3
[271.933197] Dynamic subtest pipe-B-plane-3: SUCCESS (0.534s)
[271.952218] Starting dynamic subtest: pipe-B-plane-4
[271.954859] Dynamic subtest pipe-B-plane-4: SUCCESS (0.018s)
[271.956743] Subtest plane-position-hole: SUCCESS (4.399s)
[272.248938] [054/133] (782s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted)
[272.347909] Starting subtest: etime-single-wait-all-available-unsubmitted
[272.451065] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.102s)
[272.580778] [055/133] (781s left) gem_exec_fence (basic-busy-all)
[272.696257] Starting subtest: basic-busy-all
[272.734105] Subtest basic-busy-all: SUCCESS (0.037s)
[273.553835] [056/133] (781s left) gem_workarounds (suspend-resume-context)
[273.680176] Starting subtest: suspend-resume-context
[292.042293] Subtest suspend-resume-context: SUCCESS (1.832s)
[300.144194] [057/133] (762s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[300.332842] Starting subtest: fbc-rgb565-draw-mmap-gtt
[303.010166] Subtest fbc-rgb565-draw-mmap-gtt: SUCCESS (2.728s)
[303.279066] [058/133] (759s left) gem_exec_schedule (pi-userfault)
[303.528988] Starting subtest: pi-userfault
[303.530098] Starting dynamic subtest: rcs0
[303.547386] Dynamic subtest rcs0: SUCCESS (0.013s)
[303.575147] Starting dynamic subtest: bcs0
[303.577215] Dynamic subtest bcs0: SUCCESS (0.011s)
[303.599219] Starting dynamic subtest: vcs0
[303.600670] Dynamic subtest vcs0: SUCCESS (0.008s)
[303.622710] Starting dynamic subtest: vecs0
[303.624200] Dynamic subtest vecs0: SUCCESS (0.008s)
[303.625630] Subtest pi-userfault: SUCCESS (0.056s)
[303.858695] [059/133] (759s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[304.033069] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[304.141334] [060/133] (758s left) sw_sync (sync_expired_merge)
[304.231996] Starting subtest: sync_expired_merge
[305.293147] Subtest sync_expired_merge: SUCCESS (1.074s)
[305.418027] [061/133] (757s left) gem_eio (kms)
[305.614020] Starting subtest: kms
[310.514742] Subtest kms: SUCCESS (4.946s)
[310.759410] [062/133] (752s left) kms_rotation_crc (exhaust-fences)
[310.929933] Starting subtest: exhaust-fences
[313.905021] Subtest exhaust-fences: SUCCESS (2.990s)
[314.159870] [063/133] (749s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[314.258844] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[314.259792] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[314.395284] [064/133] (749s left) core_debugfs (read-all-entries)
[314.492075] Starting subtest: read-all-entries
[314.570098] Subtest read-all-entries: SUCCESS (0.079s)
[314.710609] [065/133] (748s left) gem_exec_schedule (u-lateslice)
[314.836969] Starting subtest: u-lateslice
[314.839049] Starting dynamic subtest: rcs0
[314.864314] Dynamic subtest rcs0: SUCCESS (0.031s)
[314.891972] Starting dynamic subtest: bcs0
[314.895809] Dynamic subtest bcs0: SUCCESS (0.028s)
[314.924330] Starting dynamic subtest: vcs0
[314.926025] Dynamic subtest vcs0: SUCCESS (0.025s)
[314.950509] Starting dynamic subtest: vecs0
[314.954546] Dynamic subtest vecs0: SUCCESS (0.025s)
[314.956522] Subtest u-lateslice: SUCCESS (0.123s)
[315.377256] [066/133] (748s left) gem_lmem_swapping (verify-random-ccs)
[315.480813] Subtest verify-random-ccs: SKIP (0.000s)
[315.583453] [067/133] (748s left) gem_ctx_isolation (preservation-s3)
[315.697815] Starting subtest: preservation-S3
[315.699367] Starting dynamic subtest: rcs0