[93.529260] Initializing watchdogs
[93.529478]   /dev/watchdog0
[93.594877] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[93.609967] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[93.617965] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[93.624200] [001/133] (960s left) gem_create (busy-create)
[93.752891] Starting subtest: busy-create
[93.754833] Starting dynamic subtest: smem0
[126.008074] Dynamic subtest smem0: SUCCESS (32.251s)
[126.009722] Subtest busy-create: SUCCESS (32.254s)
[126.263053] [002/133] (927s left) kms_vrr (seamless-rr-switch-vrr)
[126.456676] Starting subtest: seamless-rr-switch-vrr
[126.463874] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[126.595802] [003/133] (927s left) kms_fb_coherency (memset-crc)
[126.794062] Starting subtest: memset-crc
[126.797088] Starting dynamic subtest: mmap-gtt
[127.578173] Dynamic subtest mmap-gtt: SUCCESS (0.787s)
[127.852455] Starting dynamic subtest: mmap-offset-wc
[128.206166] Dynamic subtest mmap-offset-wc: SUCCESS (0.395s)
[128.441206] Starting dynamic subtest: mmap-offset-uc
[129.255625] Dynamic subtest mmap-offset-uc: SUCCESS (0.830s)
[129.493084] Starting dynamic subtest: mmap-legacy-wc
[129.877700] Dynamic subtest mmap-legacy-wc: SUCCESS (0.402s)
[130.101467] Subtest memset-crc: SUCCESS (3.304s)
[130.415695] [004/133] (923s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[130.607313] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[130.609062] Starting dynamic subtest: pipe-A-valid-mode
[131.742261] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.130s)
[131.744601] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (1.135s)
[132.079825] [005/133] (922s left) gem_render_copy (yf-tiled-to-vebox-linear)
[132.202349] Starting subtest: yf-tiled-to-vebox-linear
[132.205490] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[132.451160] [006/133] (922s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[132.553207] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[132.659088] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.105s)
[132.798974] [007/133] (921s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[132.981312] Starting subtest: nonblocking-crc-frame-sequence
[132.984071] Starting dynamic subtest: pipe-A-HDMI-A-1
[133.998087] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.020s)
[134.033451] Starting dynamic subtest: pipe-B-HDMI-A-2
[134.725860] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.720s)
[134.746869] Starting dynamic subtest: pipe-C-HDMI-A-1
[135.448378] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.716s)
[135.452424] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.471s)
[135.738545] [008/133] (918s left) gem_exec_schedule (preempt-engines)
[135.895174] Starting subtest: preempt-engines
[135.898240] Starting dynamic subtest: rcs0
[136.120872] Dynamic subtest rcs0: SUCCESS (0.211s)
[136.150859] Starting dynamic subtest: bcs0
[136.456931] Dynamic subtest bcs0: SUCCESS (0.351s)
[136.489212] Starting dynamic subtest: vcs0
[136.688927] Dynamic subtest vcs0: SUCCESS (0.224s)
[136.727208] Starting dynamic subtest: vecs0
[136.919203] Dynamic subtest vecs0: SUCCESS (0.231s)
[136.926482] Subtest preempt-engines: SUCCESS (1.021s)
[137.293097] [009/133] (917s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[137.497869] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[137.501945] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[137.623700] [010/133] (917s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[137.902304] Starting subtest: basic-test-pattern-with-chamelium
[137.906973] Subtest basic-test-pattern-with-chamelium: SKIP (0.001s)
[138.038374] [011/133] (916s left) gem_wait (write-wait)
[138.177154] Starting subtest: write-wait
[138.180191] Starting dynamic subtest: all-engines
[139.348109] Dynamic subtest all-engines: SUCCESS (1.170s)
[139.369671] Starting dynamic subtest: rcs0
[140.385473] Dynamic subtest rcs0: SUCCESS (1.036s)
[140.406754] Starting dynamic subtest: bcs0
[141.425582] Dynamic subtest bcs0: SUCCESS (1.039s)
[141.447425] Starting dynamic subtest: vcs0
[142.460423] Dynamic subtest vcs0: SUCCESS (1.033s)
[142.480449] Starting dynamic subtest: vecs0
[143.494204] Dynamic subtest vecs0: SUCCESS (1.034s)
[143.497236] Subtest write-wait: SUCCESS (5.316s)
[143.782668] [FACT gem_wait (write-wait)] new: kernel.kmod_is_loaded.vgem: true
[143.787525] [012/133] (911s left) kms_plane_multiple (2x-tiling-4)
[143.924191] Starting subtest: 2x-tiling-4
[143.928708] Subtest 2x-tiling-4: SKIP (0.000s)
[144.066798] [013/133] (911s left) kms_chamelium_hpd (dp-hpd-fast)
[144.580278] Subtest dp-hpd-fast: SKIP (0.000s)
[144.913176] [014/133] (910s left) prime_self_import (export-vs-gem_close-race)
[145.018296] Starting subtest: export-vs-gem_close-race
[150.030436] Subtest export-vs-gem_close-race: SUCCESS (5.013s)
[150.166715] [015/133] (905s left) kms_joiner (invalid-modeset-force-big-joiner)
[150.308564] Starting subtest: invalid-modeset-force-big-joiner
[150.313644] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[150.447944] [016/133] (904s left) i915_selftest (perf)
[151.890177] Starting subtest: perf
[151.893244] Starting dynamic subtest: engine_cs
[154.369944] Dynamic subtest engine_cs: SUCCESS (2.480s)
[154.389135] Starting dynamic subtest: request
[159.946395] Dynamic subtest request: SUCCESS (5.574s)
[159.966272] Starting dynamic subtest: migrate
[162.436230] Dynamic subtest migrate: SUCCESS (2.490s)
[162.456272] Starting dynamic subtest: region
[166.042761] Dynamic subtest region: SUCCESS (3.602s)
[166.044439] Subtest perf: SUCCESS (14.154s)
[166.107278] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[166.110654] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[166.115164] [017/133] (889s left) kms_rotation_crc (bad-tiling)
[169.016069] Starting subtest: bad-tiling
[175.735073] Subtest bad-tiling: SUCCESS (6.722s)
[176.066696] [FACT kms_rotation_crc (bad-tiling)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[176.069605] [FACT kms_rotation_crc (bad-tiling)] new: kernel.kmod_is_loaded.i915: true
[176.077319] [018/133] (879s left) kms_pm_rpm (modeset-lpsp)
[178.018081] Starting subtest: modeset-lpsp
[178.361608] Subtest modeset-lpsp: SKIP (0.339s)
[178.777304] [019/133] (876s left) perf_pmu (init-busy)
[178.906681] Starting subtest: init-busy
[178.909222] Starting dynamic subtest: rcs0
[178.911193] Dynamic subtest rcs0: SUCCESS (0.007s)
[178.939061] Starting dynamic subtest: bcs0
[178.942147] Dynamic subtest bcs0: SUCCESS (0.002s)
[178.960132] Starting dynamic subtest: vcs0
[178.962090] Dynamic subtest vcs0: SUCCESS (0.002s)
[178.982048] Starting dynamic subtest: vecs0
[178.985076] Dynamic subtest vecs0: SUCCESS (0.002s)
[178.986613] Subtest init-busy: SUCCESS (0.020s)
[179.081284] [020/133] (876s left) kms_chamelium_frames (dp-frame-dump)
[179.697948] Subtest dp-frame-dump: SKIP (0.000s)
[180.044498] [021/133] (875s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[180.251348] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[180.363182] [022/133] (875s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[180.576271] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[180.579715] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[180.727345] [023/133] (875s left) api_intel_allocator (reopen-fork)
[180.832942] Starting subtest: reopen-fork
[184.195399] Subtest reopen-fork: SUCCESS (3.361s)
[184.349586] [024/133] (871s left) syncobj_timeline (wait-all-complex)
[184.453650] Starting subtest: wait-all-complex
[184.678494] Subtest wait-all-complex: SUCCESS (0.223s)
[184.830561] [025/133] (871s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[185.033326] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[185.038293] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[185.178520] [026/133] (871s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[185.373250] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[185.376201] Starting dynamic subtest: pipe-A-HDMI-A-1
[185.396125] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[185.435157] Starting dynamic subtest: pipe-A-HDMI-A-2
[185.472201] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s)
[185.507562] Starting dynamic subtest: pipe-B-HDMI-A-1
[185.544238] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[185.569255] Starting dynamic subtest: pipe-B-HDMI-A-2
[185.585364] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s)
[185.604355] Starting dynamic subtest: pipe-C-HDMI-A-1
[185.620324] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[185.638678] Starting dynamic subtest: pipe-C-HDMI-A-2
[185.653407] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[185.656427] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SKIP (0.035s)
[186.457603] [027/133] (870s left) vgem_slow (nohang)
[186.576914] Starting subtest: nohang
[196.782273] Subtest nohang: SUCCESS (10.206s)
[196.914305] [028/133] (859s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[197.115400] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[197.118823] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[197.262481] [029/133] (859s left) kms_psr (psr-no-drrs)
[197.453132] Subtest psr-no-drrs: SKIP (0.000s)
[197.569550] [030/133] (859s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[197.765578] Starting subtest: 2x-flip-vs-modeset-vs-hang
[197.770143] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[212.659037] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (14.886s)
[212.660611] Subtest 2x-flip-vs-modeset-vs-hang: SUCCESS (14.894s)
[213.085821] [031/133] (843s left) kms_rotation_crc (exhaust-fences)
[213.264086] Starting subtest: exhaust-fences
[215.728747] Subtest exhaust-fences: SUCCESS (2.464s)
[215.957708] [032/133] (840s left) gem_userptr_blits (access-control)
[216.120422] Starting subtest: access-control
[216.126889] Subtest access-control: SKIP (0.000s)
[216.261456] [033/133] (840s left) kms_content_protection (lic-type-0)
[216.464281] Starting subtest: lic-type-0
[216.511101] Subtest lic-type-0: SKIP (0.042s)
[216.700061] [034/133] (840s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[216.896154] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[216.906142] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.003s)
[217.054490] [035/133] (840s left) prime_self_import (basic-with_two_bos)
[217.153940] Starting subtest: basic-with_two_bos
[217.159418] Subtest basic-with_two_bos: SUCCESS (0.007s)
[217.308984] [036/133] (840s left) gem_ctx_isolation (clean)
[217.433133] Starting subtest: clean
[217.435147] Starting dynamic subtest: rcs0
[217.518939] Dynamic subtest rcs0: SUCCESS (0.084s)
[217.542169] Starting dynamic subtest: bcs0
[217.659990] Dynamic subtest bcs0: SUCCESS (0.138s)
[217.689189] Starting dynamic subtest: vcs0
[217.751621] Dynamic subtest vcs0: SUCCESS (0.087s)
[217.780062] Starting dynamic subtest: vecs0
[217.853460] Dynamic subtest vecs0: SUCCESS (0.094s)
[217.856374] Subtest clean: SUCCESS (0.421s)
[218.126294] [037/133] (839s left) gem_exec_whisper (basic-sync-all)
[218.251397] Starting subtest: basic-sync-all
[225.487051] Subtest basic-sync-all: SUCCESS (7.232s)
[225.763343] [038/133] (831s left) gem_mmap_offset (partial-mmap)
[225.864321] Starting subtest: partial-mmap
[225.865919] Starting dynamic subtest: smem0
[225.871990] Dynamic subtest smem0: SUCCESS (0.007s)
[225.873824] Subtest partial-mmap: SUCCESS (0.011s)
[226.026965] [039/133] (831s left) gem_exec_params (cliprects-invalid)
[226.140950] Starting subtest: cliprects-invalid
[226.143518] Subtest cliprects-invalid: SUCCESS (0.001s)
[226.293957] [040/133] (831s left) kms_pm_lpsp (kms-lpsp)
[227.476393] Starting subtest: kms-lpsp
[227.483246] Subtest kms-lpsp: SKIP (0.001s)
[227.626626] [041/133] (830s left) gem_workarounds (suspend-resume-fd)
[227.764580] Starting subtest: suspend-resume-fd