[89.628743] Initializing watchdogs
[89.628917]   /dev/watchdog0
[89.668117] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[89.682931] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[89.690561] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[89.696563] [001/133] (960s left) kms_selftest (drm_plane_helper)
[89.830628] Starting subtest: drm_plane_helper
[89.838072] Starting dynamic subtest: drm_test_check_plane_state
[89.907111] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.064s)
[89.924418] Starting dynamic subtest: drm_test_check_invalid_plane_state
[89.973716] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.069s)
[89.978281] Subtest drm_plane_helper: SUCCESS (0.146s)
[90.144376] [002/133] (960s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[90.333935] Starting subtest: 2x-plain-flip-ts-check-interruptible
[90.341149] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[101.450122] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (11.109s)
[101.469376] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[112.539371] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (11.085s)
[112.557901] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[123.547541] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (10.999s)
[123.551052] Subtest 2x-plain-flip-ts-check-interruptible: SUCCESS (33.208s)
[124.202342] [003/133] (926s left) gem_userptr_blits (map-fixed-invalidate-busy)
[124.351699] Starting subtest: map-fixed-invalidate-busy
[124.353308] Starting dynamic subtest: gtt
[127.829249] Dynamic subtest gtt: SUCCESS (3.477s)
[127.848335] Starting dynamic subtest: wb
[131.183219] Dynamic subtest wb: SUCCESS (3.353s)
[131.202366] Starting dynamic subtest: wc
[134.537095] Dynamic subtest wc: SUCCESS (3.353s)
[134.555975] Starting dynamic subtest: uc
[137.853135] Dynamic subtest uc: SUCCESS (3.315s)
[137.854952] Subtest map-fixed-invalidate-busy: SUCCESS (13.506s)
[138.019988] [004/133] (912s left) gem_eio (in-flight-10ms)
[138.158083] Starting subtest: in-flight-10ms
[139.251048] Subtest in-flight-10ms: SUCCESS (1.091s)
[139.501423] [FACT gem_eio (in-flight-10ms)] new: kernel.kmod_is_loaded.vgem: true
[139.505907] [005/133] (911s left) gem_flink_race (flink_name)
[139.605190] Starting subtest: flink_name
[144.979421] Subtest flink_name: SUCCESS (5.374s)
[145.141276] [006/133] (905s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[145.336520] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[145.340424] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[145.490245] [007/133] (905s left) gen7_exec_parse (basic-offset)
[145.604063] Subtest basic-offset: SKIP (0.000s)
[145.716171] [008/133] (905s left) syncobj_wait (signal)
[145.822245] Starting subtest: signal
[145.824843] Subtest signal: SUCCESS (0.002s)
[145.963306] [009/133] (904s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[146.165542] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[147.855085] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.685s)
[148.144411] [010/133] (902s left) i915_fb_tiling (basic-x-tiling)
[148.250121] Starting subtest: basic-x-tiling
[148.251687] Subtest basic-x-tiling: SUCCESS (0.001s)
[148.424947] [011/133] (902s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling)
[148.613243] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling
[148.616457] Starting dynamic subtest: pipe-A-valid-mode
[149.436367] Dynamic subtest pipe-A-valid-mode: SKIP (0.821s)
[149.440062] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.824s)
[149.968235] [012/133] (901s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[150.091077] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[150.094269] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[150.344802] [013/133] (900s left) i915_drm_fdinfo (memory-info-resident)
[150.458390] Starting subtest: memory-info-resident
[150.459966] Starting dynamic subtest: smem0
[151.634485] Dynamic subtest smem0: SUCCESS (1.176s)
[151.636459] Subtest memory-info-resident: SUCCESS (1.177s)
[151.779265] [014/133] (899s left) kms_feature_discovery (display-2x)
[151.966148] Starting subtest: display-2x
[151.967788] Subtest display-2x: SUCCESS (0.000s)
[152.105054] [015/133] (899s left) syncobj_timeline (invalid-transfer-bad-pad)
[152.211412] Starting subtest: invalid-transfer-bad-pad
[152.213372] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[152.385320] [016/133] (899s left) gem_create (create-ext-cpu-access-big)
[152.611150] Starting subtest: create-ext-cpu-access-big
[152.616710] Subtest create-ext-cpu-access-big: SKIP (0.003s)
[152.759106] [017/133] (898s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[152.972097] Starting subtest: x-tiled-16bpp-rotate-270
[153.339749] Subtest x-tiled-16bpp-rotate-270: SKIP (0.368s)
[153.621963] [018/133] (898s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[153.833109] Starting subtest: fbc-farfromfence-mmap-gtt
[156.878216] Subtest fbc-farfromfence-mmap-gtt: SUCCESS (3.042s)
[157.136776] [019/133] (894s left) gem_barrier_race (remote-request)
[157.261153] Starting subtest: remote-request
[157.264063] Starting dynamic subtest: rcs0
[162.354351] Dynamic subtest rcs0: SUCCESS (5.094s)
[162.357526] Subtest remote-request: SUCCESS (5.095s)
[162.537602] [020/133] (889s left) kms_psr (fbc-psr2-cursor-plane-move)
[162.718628] Subtest fbc-psr2-cursor-plane-move: SKIP (0.000s)
[162.825928] [021/133] (889s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[163.029692] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[165.550316] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SUCCESS (2.517s)
[165.720938] [022/133] (886s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[166.338278] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[166.689925] [023/133] (885s left) syncobj_wait (invalid-single-wait-unsubmitted)
[166.800869] Starting subtest: invalid-single-wait-unsubmitted
[166.804065] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[166.945224] [024/133] (885s left) gem_exec_schedule (noreorder-priority)
[167.205101] Starting subtest: noreorder-priority
[167.207091] Starting dynamic subtest: rcs0
[168.325044] Dynamic subtest rcs0: SUCCESS (1.120s)
[168.345480] Starting dynamic subtest: bcs0
[169.447162] Dynamic subtest bcs0: SUCCESS (1.121s)
[169.472213] Starting dynamic subtest: vcs0
[170.561350] Dynamic subtest vcs0: SUCCESS (1.113s)
[170.584726] Starting dynamic subtest: vecs0
[171.667197] Dynamic subtest vecs0: SUCCESS (1.105s)
[171.668973] Subtest noreorder-priority: SUCCESS (4.466s)
[171.956303] [025/133] (880s left) kms_plane_multiple (2x-tiling-4)
[172.132883] Starting subtest: 2x-tiling-4
[172.137672] Subtest 2x-tiling-4: SKIP (0.000s)
[172.274085] [026/133] (880s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[172.466532] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[172.469704] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.000s)
[172.608015] [027/133] (880s left) gem_pxp (create-valid-protected-context)
[175.256354] Starting subtest: create-valid-protected-context
[175.259705] Subtest create-valid-protected-context: SKIP (0.000s)
[175.391516] [028/133] (877s left) gem_exec_schedule (semaphore-noskip)
[175.525390] Starting subtest: semaphore-noskip
[175.755810] Subtest semaphore-noskip: SUCCESS (0.228s)
[176.170300] [029/133] (876s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[176.347841] Starting subtest: short-flip-before-cursor-atomic-transitions
[177.732150] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (1.380s)
[178.047670] [030/133] (874s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[178.237142] Starting subtest: flip-vs-cursor-crc-legacy
[179.177457] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.941s)
[179.489108] [031/133] (873s left) perf (mi-rpc)
[179.683502] Starting subtest: mi-rpc
[179.710703] Subtest mi-rpc: SUCCESS (0.027s)
[179.824266] [032/133] (873s left) kms_atomic_transition (modeset-transition-nonblocking)
[180.014059] Starting subtest: modeset-transition-nonblocking
[180.017050] Starting dynamic subtest: 1x-outputs
[183.532881] Dynamic subtest 1x-outputs: SUCCESS (3.523s)
[183.554927] Starting dynamic subtest: 2x-outputs
[190.879828] Dynamic subtest 2x-outputs: SUCCESS (7.344s)
[190.881963] Subtest modeset-transition-nonblocking: SUCCESS (10.871s)
[191.203507] [033/133] (862s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[191.386128] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[191.389269] Starting dynamic subtest: pipe-A
[191.741412] Dynamic subtest pipe-A: SUCCESS (0.354s)
[191.784362] Starting dynamic subtest: pipe-B
[192.154801] Dynamic subtest pipe-B: SUCCESS (0.412s)
[192.181073] Starting dynamic subtest: pipe-C
[192.227441] Dynamic subtest pipe-C: SUCCESS (0.071s)
[192.229963] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (0.841s)
[192.713626] [034/133] (860s left) kms_chamelium_frames (hdmi-crc-fast)
[193.284333] Subtest hdmi-crc-fast: SKIP (0.000s)
[193.688106] [035/133] (859s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs)
[193.878075] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs
[193.880212] Starting dynamic subtest: pipe-A-HDMI-A-1
[194.733522] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.840s)
[194.764574] Starting dynamic subtest: pipe-A-HDMI-A-2
[195.582582] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.844s)
[195.624493] Starting dynamic subtest: pipe-B-HDMI-A-1
[196.495281] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.898s)
[196.520712] Starting dynamic subtest: pipe-B-HDMI-A-2
[197.330774] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.847s)
[197.358947] Starting dynamic subtest: pipe-C-HDMI-A-1
[197.468101] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.013s)
[197.488293] Starting dynamic subtest: pipe-C-HDMI-A-2
[197.556047] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.011s)
[197.557575] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SUCCESS (3.472s)
[198.212989] [036/133] (855s left) kms_cursor_crc (cursor-onscreen-32x10)
[198.409693] Starting subtest: cursor-onscreen-32x10
[198.688106] Subtest cursor-onscreen-32x10: SKIP (0.275s)
[198.848079] [037/133] (854s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[199.061248] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[199.065267] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[199.211883] [038/133] (854s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[199.426238] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[199.429860] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[199.577617] [039/133] (854s left) gem_exec_reloc (basic-write-wc)
[199.700072] Starting subtest: basic-write-wc
[199.713749] Subtest basic-write-wc: SUCCESS (0.017s)
[199.946154] [040/133] (853s left) gem_fence_thrash (bo-write-verify-threaded-none)
[200.044313] Starting subtest: bo-write-verify-threaded-none
[204.775712] Subtest bo-write-verify-threaded-none: SUCCESS (4.733s)
[204.932577] [041/133] (849s left) api_intel_bb (offset-control)
[205.038233] Starting subtest: offset-control
[205.054553] Subtest offset-control: SUCCESS (0.018s)
[205.215839] [042/133] (848s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[205.421219] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[205.426766] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[205.562676] [043/133] (848s left) prime_mmap (test_dup)
[205.666141] Starting subtest: test_dup
[205.668157] Starting dynamic subtest: test_dup-smem
[205.671207] Dynamic subtest test_dup-smem: SUCCESS (0.008s)
[205.673221] Subtest test_dup: SUCCESS (0.010s)
[205.813798] [044/133] (848s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[205.918126] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[205.922295] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.001s)
[206.091656] [045/133] (848s left) kms_frontbuffer_tracking (fbc-suspend)
[206.294858] Starting subtest: fbc-suspend