[88.450472] Initializing watchdogs
[88.450661]   /dev/watchdog0
[88.489480] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[88.504170] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[88.511520] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[88.517160] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[88.739259] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[88.744127] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[88.896036] [002/133] (960s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[89.079038] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[89.081088] Starting dynamic subtest: pipe-A-HDMI-A-1
[89.172253] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.012s)
[89.206678] Starting dynamic subtest: pipe-A-HDMI-A-2
[89.322328] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.012s)
[89.338929] Starting dynamic subtest: pipe-B-HDMI-A-1
[89.402461] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.012s)
[89.418135] Starting dynamic subtest: pipe-B-HDMI-A-2
[89.480719] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.012s)
[89.496452] Starting dynamic subtest: pipe-C-HDMI-A-1
[89.559388] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.012s)
[89.579086] Starting dynamic subtest: pipe-C-HDMI-A-2
[89.727273] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.012s)
[89.738450] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.087s)
[90.108730] [003/133] (959s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[90.296557] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[90.302345] Subtest plane-all-modeset-transition-fencing-internal-panels: SKIP (0.000s)
[90.430272] [004/133] (958s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[90.605571] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[90.610384] Starting dynamic subtest: pipe-A
[90.912679] Dynamic subtest pipe-A: SUCCESS (0.309s)
[90.948117] Starting dynamic subtest: pipe-B
[91.326081] Dynamic subtest pipe-B: SUCCESS (0.412s)
[91.359214] Starting dynamic subtest: pipe-C
[91.388835] Dynamic subtest pipe-C: SUCCESS (0.063s)
[91.392318] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (0.786s)
[91.851783] [005/133] (957s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[92.066168] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[92.070116] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[92.203044] [006/133] (957s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[92.390568] Starting subtest: plane-ctm3x4-lut1d
[94.062972] Subtest plane-ctm3x4-lut1d: SKIP (1.670s)
[94.473264] [007/133] (955s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[94.668181] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[94.672293] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[94.807223] [008/133] (954s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[95.013432] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[95.016979] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[95.169323] [009/133] (954s left) gem_exec_fence (syncobj-unused-fence)
[95.811204] Starting subtest: syncobj-unused-fence
[95.817124] Subtest syncobj-unused-fence: SUCCESS (0.007s)
[96.216825] [FACT gem_exec_fence (syncobj-unused-fence)] new: kernel.kmod_is_loaded.vgem: true
[96.222293] [010/133] (953s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[96.402990] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[96.406217] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[96.535866] [011/133] (953s left) gem_render_copy (y-tiled)
[96.662075] Starting subtest: y-tiled
[96.663781] Starting dynamic subtest: smem
[96.880245] Dynamic subtest smem: SUCCESS (0.219s)
[96.882443] Subtest y-tiled: SUCCESS (0.220s)
[97.139470] [012/133] (952s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[97.321121] Starting subtest: flip-vs-cursor-busy-crc-legacy
[98.379091] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (1.057s)
[98.768165] [013/133] (951s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[99.443086] Starting subtest: syncobj-timeline-invalid-wait
[99.451416] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.006s)
[99.737404] [014/133] (950s left) gem_mmap_gtt (fault-concurrent)
[99.842267] Starting subtest: fault-concurrent
[106.054631] Subtest fault-concurrent: SUCCESS (6.215s)
[106.226044] [015/133] (944s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite)
[106.453614] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite
[110.080033] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (3.626s)
[110.354376] [016/133] (939s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[110.561099] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[110.566385] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[110.728475] [017/133] (939s left) kms_frontbuffer_tracking (fbc-tiling-y)
[110.924614] Starting subtest: fbc-tiling-y
[113.963413] Subtest fbc-tiling-y: SUCCESS (3.035s)
[114.253704] [018/133] (936s left) kms_dp_linktrain_fallback (dsc-fallback)
[114.432143] Starting subtest: dsc-fallback
[114.436960] Subtest dsc-fallback: SKIP (0.000s)
[114.569821] [019/133] (936s left) gem_ctx_persistence (heartbeat-close)
[114.689536] Starting subtest: heartbeat-close
[114.824530] Subtest heartbeat-close: SUCCESS (0.136s)
[114.973043] [020/133] (935s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[115.187070] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[116.879798] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.690s)
[117.138211] [021/133] (933s left) gem_userptr_blits (sync-overlap)
[117.278636] Starting subtest: sync-overlap
[117.281908] Subtest sync-overlap: SUCCESS (0.000s)
[117.475127] [022/133] (933s left) gem_exec_schedule (noreorder-corked)
[117.738354] Starting subtest: noreorder-corked
[117.739982] Starting dynamic subtest: rcs0
[118.851120] Dynamic subtest rcs0: SUCCESS (1.113s)
[118.868995] Starting dynamic subtest: bcs0
[119.976300] Dynamic subtest bcs0: SUCCESS (1.125s)
[119.995353] Starting dynamic subtest: vcs0
[121.092428] Dynamic subtest vcs0: SUCCESS (1.110s)
[121.111329] Starting dynamic subtest: vecs0
[122.207992] Dynamic subtest vecs0: SUCCESS (1.116s)
[122.210764] Subtest noreorder-corked: SUCCESS (4.470s)
[122.456384] [023/133] (928s left) gem_pxp (fail-invalid-protected-context)
[125.098345] Starting subtest: fail-invalid-protected-context
[125.101868] Subtest fail-invalid-protected-context: SKIP (0.000s)
[125.236867] [024/133] (925s left) i915_getparams_basic (basic-eu-total)
[125.342592] Starting subtest: basic-eu-total
[125.345907] Subtest basic-eu-total: SUCCESS (0.000s)
[125.489531] [025/133] (925s left) prime_vgem (basic-read)
[125.615108] Starting subtest: basic-read
[125.678275] Subtest basic-read: SUCCESS (0.065s)
[125.822192] [026/133] (925s left) gem_mmap_gtt (fault-concurrent-x)
[125.924176] Starting subtest: fault-concurrent-X
[131.795242] Subtest fault-concurrent-X: SUCCESS (5.871s)
[131.956347] [027/133] (919s left) kms_sequence (queue-busy)
[132.139068] Starting subtest: queue-busy
[132.142076] Starting dynamic subtest: pipe-A-HDMI-A-1
[135.047712] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.906s)
[135.083547] Starting dynamic subtest: pipe-A-HDMI-A-2
[137.679143] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.626s)
[137.703215] Starting dynamic subtest: pipe-B-HDMI-A-1
[140.286222] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.604s)
[140.308031] Starting dynamic subtest: pipe-B-HDMI-A-2
[142.904743] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.617s)
[142.939348] Starting dynamic subtest: pipe-C-HDMI-A-1
[145.560148] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.646s)
[145.601074] Starting dynamic subtest: pipe-C-HDMI-A-2
[148.185904] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.624s)
[148.187772] Subtest queue-busy: SUCCESS (16.047s)
[148.519076] [028/133] (902s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[148.728247] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[148.733906] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[148.873552] [029/133] (902s left) gem_exec_whisper (basic-forked-all)
[149.001106] Starting subtest: basic-forked-all
[157.154224] Subtest basic-forked-all: SUCCESS (8.154s)
[157.425337] [030/133] (894s left) kms_flip (dpms-off-confusion)
[157.601086] Starting subtest: dpms-off-confusion
[157.608255] Starting dynamic subtest: A-HDMI-A1
[163.289467] Dynamic subtest A-HDMI-A1: SUCCESS (5.680s)
[163.312014] Starting dynamic subtest: B-HDMI-A1
[168.694775] Dynamic subtest B-HDMI-A1: SUCCESS (5.403s)
[168.720335] Starting dynamic subtest: C-HDMI-A1
[174.110308] Dynamic subtest C-HDMI-A1: SUCCESS (5.408s)
[174.131264] Starting dynamic subtest: A-HDMI-A2
[179.523301] Dynamic subtest A-HDMI-A2: SUCCESS (5.409s)
[179.543711] Starting dynamic subtest: B-HDMI-A2
[184.936135] Dynamic subtest B-HDMI-A2: SUCCESS (5.407s)
[184.957126] Starting dynamic subtest: C-HDMI-A2
[190.336068] Dynamic subtest C-HDMI-A2: SUCCESS (5.396s)
[190.341072] Subtest dpms-off-confusion: SUCCESS (32.731s)
[190.829138] [031/133] (860s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[191.037140] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[191.271107] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.231s)
[191.543202] [032/133] (860s left) prime_self_import (basic-llseek-bad)
[191.643378] Starting subtest: basic-llseek-bad
[191.648087] Subtest basic-llseek-bad: SUCCESS (0.006s)
[191.793335] [033/133] (860s left) gem_exec_async (forked-writes)
[191.923190] Starting subtest: forked-writes
[191.927331] Starting dynamic subtest: rcs0
[191.984921] Dynamic subtest rcs0: SUCCESS (0.060s)
[192.013085] Starting dynamic subtest: bcs0
[192.049088] Dynamic subtest bcs0: SUCCESS (0.063s)
[192.079428] Starting dynamic subtest: vcs0
[192.121873] Dynamic subtest vcs0: SUCCESS (0.065s)
[192.159720] Starting dynamic subtest: vecs0
[192.180671] Dynamic subtest vecs0: SUCCESS (0.059s)
[192.182302] Subtest forked-writes: SUCCESS (0.259s)
[192.460669] [034/133] (859s left) gem_exec_balancer (indices)
[192.585457] Starting subtest: indices
[196.914658] Subtest indices: SUCCESS (4.330s)
[197.197606] [035/133] (854s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[197.299852] Starting subtest: multi-wait-available-unsubmitted-signaled
[197.306212] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.002s)
[197.445383] [036/133] (854s left) kms_fb_coherency (memset-crc)
[197.632106] Starting subtest: memset-crc
[197.634170] Starting dynamic subtest: mmap-gtt
[198.369055] Dynamic subtest mmap-gtt: SUCCESS (0.730s)
[198.604177] Starting dynamic subtest: mmap-offset-wc
[199.007448] Dynamic subtest mmap-offset-wc: SUCCESS (0.420s)
[199.265066] Starting dynamic subtest: mmap-offset-uc
[200.059942] Dynamic subtest mmap-offset-uc: SUCCESS (0.828s)
[200.322820] Starting dynamic subtest: mmap-legacy-wc
[200.694544] Dynamic subtest mmap-legacy-wc: SUCCESS (0.409s)
[200.914213] Subtest memset-crc: SUCCESS (3.276s)
[201.242083] [037/133] (851s left) sysfs_heartbeat_interval (mixed)
[201.364181] Starting subtest: mixed
[201.368398] Starting dynamic subtest: vecs0
[206.614830] Dynamic subtest vecs0: SUCCESS (5.248s)
[206.638403] Starting dynamic subtest: vcs0
[211.855906] Dynamic subtest vcs0: SUCCESS (5.237s)
[211.877950] Starting dynamic subtest: bcs0
[217.128031] Dynamic subtest bcs0: SUCCESS (5.270s)
[217.155167] Starting dynamic subtest: rcs0
[222.385019] Dynamic subtest rcs0: SUCCESS (5.255s)
[222.387905] Subtest mixed: SUCCESS (21.022s)
[222.526904] [038/133] (829s left) kms_cursor_crc (cursor-suspend)
[222.712086] Starting subtest: cursor-suspend
[222.717247] Starting dynamic subtest: pipe-A-HDMI-A-1