[86.884178] Initializing watchdogs
[86.884378]   /dev/watchdog0
[86.923459] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[86.938236] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[86.945679] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[86.951532] [001/133] (960s left) kms_plane_scaling (planes-upscale-factor-0-25)
[87.152356] Starting subtest: planes-upscale-factor-0-25
[87.154564] Starting dynamic subtest: pipe-A
[87.526174] Dynamic subtest pipe-A: SUCCESS (0.379s)
[87.544616] Starting dynamic subtest: pipe-B
[87.940872] Dynamic subtest pipe-B: SUCCESS (0.413s)
[87.975235] Starting dynamic subtest: pipe-C
[88.026740] Dynamic subtest pipe-C: SUCCESS (0.083s)
[88.030466] Subtest planes-upscale-factor-0-25: SUCCESS (0.877s)
[88.471491] [002/133] (959s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[88.684404] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[88.688924] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[88.820938] [003/133] (958s left) kms_cdclk (plane-scaling)
[88.922085] Subtest plane-scaling: SKIP (0.000s)
[89.016224] [004/133] (958s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[89.203065] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[89.294523] [005/133] (958s left) kms_psr (fbc-psr-suspend)
[89.482378] Subtest fbc-psr-suspend: SKIP (0.000s)
[89.577959] [006/133] (958s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[89.780464] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[92.193173] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (2.412s)
[92.452223] [007/133] (955s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[92.573189] Starting subtest: writes-after-reads-snoop
[112.718484] Subtest writes-after-reads-snoop: SUCCESS (20.148s)
[112.892048] [008/133] (935s left) gem_exec_fence (submit3)
[113.152939] Starting subtest: submit3
[113.156193] Starting dynamic subtest: rcs0
[113.169582] Dynamic subtest rcs0: SUCCESS (0.017s)
[113.207417] Starting dynamic subtest: bcs0
[113.213312] Dynamic subtest bcs0: SUCCESS (0.015s)
[113.231230] Starting dynamic subtest: vcs0
[113.233650] Dynamic subtest vcs0: SUCCESS (0.014s)
[113.251536] Starting dynamic subtest: vecs0
[113.254095] Dynamic subtest vecs0: SUCCESS (0.011s)
[113.256882] Subtest submit3: SUCCESS (0.062s)
[114.010136] [FACT gem_exec_fence (submit3)] new: kernel.kmod_is_loaded.vgem: true
[114.015407] [009/133] (934s left) vgem_basic (busy-fence)
[114.128900] Starting subtest: busy-fence
[114.131248] Subtest busy-fence: SUCCESS (0.000s)
[114.248151] [010/133] (933s left) kms_pm_dc (dc5-psr)
[115.434975] Starting subtest: dc5-psr
[115.440280] Subtest dc5-psr: SKIP (0.000s)
[115.579690] [011/133] (932s left) i915_pm_rps (basic-api)
[115.700231] Starting subtest: basic-api
[115.709709] Subtest basic-api: SUCCESS (0.011s)
[115.849253] [012/133] (932s left) i915_pm_freq_api (freq-reset)
[115.967069] Subtest freq-reset: SKIP (0.000s)
[116.072101] [013/133] (932s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[116.187706] Starting subtest: yf-tiled-to-vebox-yf-tiled
[116.190954] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[116.452350] [014/133] (932s left) gem_softpin (overlap)
[116.570816] Starting subtest: overlap
[119.157539] Subtest overlap: SUCCESS (2.589s)
[119.298348] [015/133] (929s left) kms_plane_multiple (tiling-none)
[119.481432] Starting subtest: tiling-none
[119.488753] Starting dynamic subtest: pipe-A-HDMI-A-1
[121.278169] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.794s)
[121.306349] Starting dynamic subtest: pipe-A-HDMI-A-2
[122.857072] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (1.576s)
[122.898433] Starting dynamic subtest: pipe-B-HDMI-A-1
[124.409266] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.541s)
[124.443913] Starting dynamic subtest: pipe-B-HDMI-A-2
[126.031200] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (1.619s)
[126.072968] Starting dynamic subtest: pipe-C-HDMI-A-1
[127.652202] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.616s)
[127.695100] Starting dynamic subtest: pipe-C-HDMI-A-2
[129.333161] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.677s)
[129.337121] Subtest tiling-none: SUCCESS (9.853s)
[129.681662] [016/133] (919s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[129.902890] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[129.910095] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[130.055575] [017/133] (918s left) prime_vgem (wait)
[130.183214] Starting subtest: wait
[130.185402] Starting dynamic subtest: rcs0
[130.205736] Dynamic subtest rcs0: SUCCESS (0.022s)
[130.228070] Starting dynamic subtest: vcs0
[130.233227] Dynamic subtest vcs0: SUCCESS (0.016s)
[130.257569] Starting dynamic subtest: vecs0
[130.260324] Dynamic subtest vecs0: SUCCESS (0.014s)
[130.262424] Subtest wait: SUCCESS (0.057s)
[130.401668] [018/133] (918s left) gem_pwrite (basic-random)
[130.505158] Starting subtest: basic-random
[136.710140] Subtest basic-random: SUCCESS (6.203s)
[136.878477] [019/133] (912s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[137.198565] Starting subtest: plane-downscale-factor-0-75-with-rotation
[137.201213] Starting dynamic subtest: pipe-A
[143.112107] Dynamic subtest pipe-A: SKIP (5.908s)
[143.154262] Starting dynamic subtest: pipe-B
[147.821647] Dynamic subtest pipe-B: SKIP (4.702s)
[147.866293] Starting dynamic subtest: pipe-C
[152.729436] Dynamic subtest pipe-C: SKIP (4.911s)
[152.735516] Subtest plane-downscale-factor-0-75-with-rotation: SKIP (15.529s)
[153.333882] [020/133] (895s left) api_intel_allocator (two-level-inception)
[153.482057] Starting subtest: two-level-inception
[159.059049] Subtest two-level-inception: SUCCESS (5.579s)
[159.217676] [021/133] (890s left) kms_dsc (dsc-fractional-bpp-with-bpc)
[159.418735] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.000s)
[159.524614] [022/133] (889s left) gem_exec_schedule (semaphore-resolve)
[159.684068] Starting subtest: semaphore-resolve
[159.733646] Subtest semaphore-resolve: SUCCESS (0.050s)
[160.134777] [023/133] (889s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[160.355249] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[160.359088] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[160.499607] [024/133] (889s left) gen3_render_tiledx_blits
[160.729043] [025/133] (888s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[160.962250] Starting subtest: y-tiled-32bpp-rotate-180
[166.335074] Subtest y-tiled-32bpp-rotate-180: SUCCESS (5.379s)
[166.784718] [026/133] (883s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[166.987115] Starting subtest: 2x-flip-vs-modeset-vs-hang
[166.989129] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[181.679252] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (14.686s)
[181.681872] Subtest 2x-flip-vs-modeset-vs-hang: SUCCESS (14.700s)
[182.010286] [027/133] (867s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[182.133508] Starting subtest: no-spare-fences-busy-interruptible
[184.322640] Subtest no-spare-fences-busy-interruptible: SUCCESS (2.181s)
[184.491193] [028/133] (865s left) i915_drm_fdinfo (memory-info-resident)
[184.606166] Starting subtest: memory-info-resident
[184.608484] Starting dynamic subtest: smem0
[185.725582] Dynamic subtest smem0: SUCCESS (1.120s)
[185.728664] Subtest memory-info-resident: SUCCESS (1.124s)
[185.876263] [029/133] (864s left) kms_atomic_transition (modeset-transition-fencing)
[186.064090] Starting subtest: modeset-transition-fencing
[186.066075] Starting dynamic subtest: 1x-outputs
[189.585084] Dynamic subtest 1x-outputs: SUCCESS (3.521s)
[189.607396] Starting dynamic subtest: 2x-outputs
[196.937506] Dynamic subtest 2x-outputs: SUCCESS (7.349s)
[196.939296] Subtest modeset-transition-fencing: SUCCESS (10.879s)
[197.282408] [030/133] (852s left) syncobj_wait (reset-signaled)
[197.400344] Starting subtest: reset-signaled
[197.404315] Subtest reset-signaled: SUCCESS (0.001s)
[197.549109] [031/133] (852s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[197.750194] Starting subtest: primary-4-tiled-reflect-x-180
[197.754094] Subtest primary-4-tiled-reflect-x-180: SKIP (0.003s)
[197.900210] [032/133] (852s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[198.097058] Starting subtest: plane-lut1d-post-ctm3x4
[199.771621] Subtest plane-lut1d-post-ctm3x4: SKIP (1.679s)
[200.123710] [033/133] (850s left) gem_ctx_freq (sysfs)
[200.247097] Starting subtest: sysfs
[200.251948] Starting dynamic subtest: gt0
[205.150788] Dynamic subtest gt0: SUCCESS (4.897s)
[205.152918] Subtest sysfs: SUCCESS (4.903s)
[205.311393] [034/133] (845s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[205.529939] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[205.533796] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[205.694240] [035/133] (844s left) gem_exec_schedule (implicit-read-write)
[205.827929] Starting subtest: implicit-read-write
[205.830060] Starting dynamic subtest: rcs0
[205.955645] Dynamic subtest rcs0: SUCCESS (0.118s)
[205.982220] Starting dynamic subtest: bcs0
[206.077348] Dynamic subtest bcs0: SUCCESS (0.122s)
[206.113294] Starting dynamic subtest: vcs0
[206.203030] Dynamic subtest vcs0: SUCCESS (0.115s)
[206.230644] Starting dynamic subtest: vecs0
[206.314801] Dynamic subtest vecs0: SUCCESS (0.115s)
[206.320079] Subtest implicit-read-write: SUCCESS (0.483s)
[206.714370] [036/133] (844s left) gem_mmap_offset (partial-unmap)
[206.820073] Starting subtest: partial-unmap
[206.822082] Starting dynamic subtest: smem0
[206.934065] Dynamic subtest smem0: SUCCESS (0.118s)
[206.935813] Subtest partial-unmap: SUCCESS (0.120s)
[207.093903] [037/133] (843s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[207.289846] Starting subtest: flip-vs-dpms-on-nop-interruptible
[207.298899] Starting dynamic subtest: A-HDMI-A1
[208.730755] Dynamic subtest A-HDMI-A1: SUCCESS (1.434s)
[208.757107] Starting dynamic subtest: B-HDMI-A1
[209.939776] Dynamic subtest B-HDMI-A1: SUCCESS (1.205s)
[209.967548] Starting dynamic subtest: C-HDMI-A1
[211.147499] Dynamic subtest C-HDMI-A1: SUCCESS (1.201s)
[211.173291] Starting dynamic subtest: A-HDMI-A2
[212.365581] Dynamic subtest A-HDMI-A2: SUCCESS (1.214s)
[212.393379] Starting dynamic subtest: B-HDMI-A2
[213.533870] Dynamic subtest B-HDMI-A2: SUCCESS (1.162s)
[213.562255] Starting dynamic subtest: C-HDMI-A2
[214.698091] Dynamic subtest C-HDMI-A2: SUCCESS (1.156s)
[214.703265] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.411s)
[215.255257] [038/133] (835s left) gem_exec_balancer (noheartbeat)
[215.518058] Starting subtest: noheartbeat
[219.897691] Subtest noheartbeat: SUCCESS (4.380s)
[220.054388] [039/133] (831s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[220.263814] Starting subtest: fbcpsr-stridechange
[220.269944] Subtest fbcpsr-stridechange: SKIP (0.000s)
[220.426154] [040/133] (830s left) gem_exec_params (invalid-bsd2-flag-on-render)
[220.539346] Starting subtest: invalid-bsd2-flag-on-render
[220.541895] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.001s)
[220.706239] [041/133] (830s left) kms_cursor_crc (cursor-onscreen-256x85)
[220.907491] Starting subtest: cursor-onscreen-256x85
[220.950882] Starting dynamic subtest: pipe-A-HDMI-A-1
[223.682097] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.732s)
[223.799082] Starting dynamic subtest: pipe-C-HDMI-A-1
[226.156798] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.395s)
[226.159104] Subtest cursor-onscreen-256x85: SUCCESS (5.253s)
[226.456081] [042/133] (824s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[227.043985] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[227.355162] [043/133] (824s left) gem_spin_batch (resubmit)
[227.491340] Starting subtest: resubmit
[227.493366] Starting dynamic subtest: rcs0
[227.501256] Dynamic subtest rcs0: SUCCESS (0.006s)
[227.529190] Starting dynamic subtest: bcs0
[227.531348] Dynamic subtest bcs0: SUCCESS (0.008s)
[227.554328] Starting dynamic subtest: vcs0
[227.556355] Dynamic subtest vcs0: SUCCESS (0.007s)
[227.579400] Starting dynamic subtest: vecs0
[227.582191] Dynamic subtest vecs0: SUCCESS (0.005s)
[227.584176] Subtest resubmit: SUCCESS (0.044s)
[227.838323] [044/133] (823s left) kms_frontbuffer_tracking (fbc-suspend)
[228.048534] Starting subtest: fbc-suspend