[88.624867] Initializing watchdogs
[88.625168]   /dev/watchdog0
[88.665274] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[88.679955] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[88.687427] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[88.695430] [001/132] (960s left) i915_pm_rps (waitboost)
[88.837417] Starting subtest: waitboost
[92.414538] Subtest waitboost: SUCCESS (3.574s)
[92.590203] [002/132] (956s left) kms_psr (fbc-pr-cursor-plane-move)
[92.790136] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[92.885348] [003/132] (956s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[93.073057] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[93.075901] Starting dynamic subtest: pipe-A-HDMI-A-1
[93.125400] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[93.157444] Starting dynamic subtest: pipe-A-HDMI-A-2
[93.217884] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s)
[93.238729] Starting dynamic subtest: pipe-B-HDMI-A-1
[93.277643] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[93.297000] Starting dynamic subtest: pipe-B-HDMI-A-2
[93.332947] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[93.351334] Starting dynamic subtest: pipe-C-HDMI-A-1
[93.387560] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[93.411514] Starting dynamic subtest: pipe-C-HDMI-A-2
[93.446202] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[93.452472] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.019s)
[94.095207] [004/132] (955s left) gen9_exec_parse (shadow-peek)
[94.237173] Starting subtest: shadow-peek
[94.240650] Subtest shadow-peek: SUCCESS (0.005s)
[94.500901] [005/132] (955s left) gem_exec_reloc (basic-write-wc-noreloc)
[94.620959] Starting subtest: basic-write-wc-noreloc
[94.631740] Subtest basic-write-wc-noreloc: SUCCESS (0.011s)
[94.849645] [006/132] (954s left) gem_exec_flush (basic-wb-rw-before-default)
[94.986080] Starting subtest: basic-wb-rw-before-default
[100.410742] Subtest basic-wb-rw-before-default: SUCCESS (5.418s)
[100.670262] [007/132] (949s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[100.887236] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[100.893953] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[101.020773] [008/132] (948s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[101.223694] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[101.325697] [009/132] (948s left) gem_render_copy (linear-to-vebox-yf-tiled)
[101.451240] Starting subtest: linear-to-vebox-yf-tiled
[101.457221] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[101.702210] [010/132] (948s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[102.254206] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[102.564211] [011/132] (947s left) gem_exec_flush (basic-batch-kernel-default-wb)
[102.704199] Starting subtest: basic-batch-kernel-default-wb
[108.234669] Subtest basic-batch-kernel-default-wb: SUCCESS (5.525s)
[108.500392] [012/132] (941s left) gem_mmap_gtt (hang-busy)
[108.616035] Starting subtest: hang-busy
[124.047300] Subtest hang-busy: SUCCESS (15.434s)
[124.204825] [013/132] (926s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[124.426188] Starting subtest: fbcpsr-modesetfrombusy
[124.437087] Subtest fbcpsr-modesetfrombusy: SKIP (0.000s)
[124.586926] [014/132] (925s left) gem_exec_params (rsvd2-dirt)
[124.710441] Starting subtest: rsvd2-dirt
[124.717785] Subtest rsvd2-dirt: SKIP (0.000s)
[124.854357] [015/132] (925s left) gem_exec_schedule (semaphore-noskip)
[124.994279] Starting subtest: semaphore-noskip
[125.225212] Subtest semaphore-noskip: SUCCESS (0.233s)
[125.622277] [016/132] (924s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[125.804072] Starting subtest: plane-ctm3x4-lut1d
[127.399276] Subtest plane-ctm3x4-lut1d: SKIP (1.587s)
[127.720235] [017/132] (922s left) kms_atomic_transition (plane-all-modeset-transition)
[127.922734] Starting subtest: plane-all-modeset-transition
[127.925604] Starting dynamic subtest: pipe-A-HDMI-A-1
[172.258167] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (44.328s)
[172.446628] Starting dynamic subtest: pipe-A-HDMI-A-2
[216.432773] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (44.009s)
[216.629191] Starting dynamic subtest: pipe-B-HDMI-A-1
[257.257111] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (40.646s)
[257.435366] Starting dynamic subtest: pipe-B-HDMI-A-2
[298.073166] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (40.654s)
[298.232577] Subtest plane-all-modeset-transition: SUCCESS (170.306s)
[298.572059] [018/132] (752s left) gem_exec_reloc (basic-gtt-wc-active)
[298.693759] Starting subtest: basic-gtt-wc-active
[298.833166] Subtest basic-gtt-wc-active: SUCCESS (0.142s)
[299.058720] [019/132] (751s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[299.262250] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[299.270081] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[299.391741] [020/132] (751s left) gem_exec_whisper (basic-fds-all)
[299.526231] Starting subtest: basic-fds-all
[314.934534] Subtest basic-fds-all: SUCCESS (15.407s)
[315.192650] [021/132] (735s left) gem_mmap_wc (invalid-flags)
[315.307683] Starting subtest: invalid-flags
[315.312063] Subtest invalid-flags: SUCCESS (0.000s)
[315.440145] [022/132] (735s left) gem_spin_batch (legacy-resubmit)
[315.564379] Starting subtest: legacy-resubmit
[315.569198] Starting dynamic subtest: default
[315.574087] Dynamic subtest default: SUCCESS (0.005s)
[315.599179] Starting dynamic subtest: render
[315.603171] Dynamic subtest render: SUCCESS (0.005s)
[315.626650] Starting dynamic subtest: bsd
[315.631133] Dynamic subtest bsd: SUCCESS (0.007s)
[315.653509] Starting dynamic subtest: bsd1
[315.659474] Dynamic subtest bsd1: SUCCESS (0.005s)
[315.681657] Starting dynamic subtest: blt
[315.685788] Dynamic subtest blt: SUCCESS (0.007s)
[315.708642] Starting dynamic subtest: vebox
[315.715272] Dynamic subtest vebox: SUCCESS (0.005s)
[315.718938] Subtest legacy-resubmit: SUCCESS (0.044s)
[315.873760] [023/132] (735s left) kms_draw_crc (draw-method-pwrite)
[316.061065] Starting subtest: draw-method-pwrite
[316.065077] Starting dynamic subtest: xrgb8888-untiled
[316.553931] Dynamic subtest xrgb8888-untiled: SUCCESS (0.497s)
[316.577640] Starting dynamic subtest: rgb565-untiled
[316.816918] Dynamic subtest rgb565-untiled: SUCCESS (0.263s)
[316.842407] Starting dynamic subtest: xrgb2101010-untiled
[317.083226] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.266s)
[317.109077] Starting dynamic subtest: xbgr16161616f-untiled
[317.368231] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.283s)
[317.391816] Starting dynamic subtest: xrgb8888-xtiled
[317.683883] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.317s)
[317.705882] Starting dynamic subtest: rgb565-xtiled
[318.000827] Dynamic subtest rgb565-xtiled: SUCCESS (0.313s)
[318.050612] Starting dynamic subtest: xrgb2101010-xtiled
[318.301100] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.299s)
[318.326059] Starting dynamic subtest: xbgr16161616f-xtiled
[318.617926] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.316s)
[318.639825] Starting dynamic subtest: xrgb8888-ytiled
[319.132614] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.517s)
[319.154444] Starting dynamic subtest: rgb565-ytiled
[319.634689] Dynamic subtest rgb565-ytiled: SUCCESS (0.497s)
[319.656837] Starting dynamic subtest: xrgb2101010-ytiled
[320.134953] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.498s)
[320.157051] Starting dynamic subtest: xbgr16161616f-ytiled
[320.682765] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.549s)
[320.687854] Subtest draw-method-pwrite: SUCCESS (4.629s)
[320.923995] [024/132] (730s left) kms_flip (dpms-vs-vblank-race-interruptible)
[321.124133] Starting subtest: dpms-vs-vblank-race-interruptible
[321.133521] Starting dynamic subtest: A-HDMI-A1
[323.884280] Dynamic subtest A-HDMI-A1: SUCCESS (2.750s)
[323.914784] Starting dynamic subtest: B-HDMI-A1
[326.116147] Dynamic subtest B-HDMI-A1: SUCCESS (2.223s)
[326.143073] Starting dynamic subtest: C-HDMI-A1
[328.374686] Dynamic subtest C-HDMI-A1: SUCCESS (2.258s)
[328.401658] Starting dynamic subtest: A-HDMI-A2
[330.662382] Dynamic subtest A-HDMI-A2: SUCCESS (2.286s)
[330.693085] Starting dynamic subtest: B-HDMI-A2
[332.927083] Dynamic subtest B-HDMI-A2: SUCCESS (2.257s)
[332.954666] Starting dynamic subtest: C-HDMI-A2
[335.148559] Dynamic subtest C-HDMI-A2: SUCCESS (2.211s)
[335.152224] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (14.017s)
[335.546861] [025/132] (715s left) syncobj_basic (bad-destroy-pad)
[335.686170] Starting subtest: bad-destroy-pad
[335.691161] Subtest bad-destroy-pad: SUCCESS (0.000s)
[335.827470] [026/132] (715s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[335.940231] Starting subtest: invalid-single-wait-all-unsubmitted
[335.943271] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.001s)
[336.075753] [027/132] (715s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[336.276094] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[338.702438] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SUCCESS (2.434s)
[338.920785] [028/132] (712s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[339.209646] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[342.152155] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (2.952s)
[342.358571] [029/132] (709s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[342.476934] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[342.582293] [030/132] (709s left) syncobj_timeline (wait-for-submit-delayed-submit)
[342.695749] Starting subtest: wait-for-submit-delayed-submit
[342.796279] Subtest wait-for-submit-delayed-submit: SUCCESS (0.107s)
[342.953223] [031/132] (709s left) kms_psr (psr-cursor-mmap-cpu)
[343.157051] Subtest psr-cursor-mmap-cpu: SKIP (0.000s)
[343.266362] [032/132] (708s left) gem_mmap_gtt (basic-write)
[343.383543] Starting subtest: basic-write
[343.777566] Subtest basic-write: SUCCESS (0.400s)
[343.927467] [033/132] (708s left) syncobj_timeline (reset-during-wait-for-submit)
[344.039403] Starting subtest: reset-during-wait-for-submit
[344.142089] Subtest reset-during-wait-for-submit: SUCCESS (0.105s)
[344.274738] [034/132] (707s left) gem_ccs (block-multicopy-inplace)
[344.396350] Subtest block-multicopy-inplace: SKIP (0.000s)
[344.499330] [035/132] (707s left) gem_exec_parallel (basic)
[344.637370] Starting subtest: basic
[344.641353] Starting dynamic subtest: rcs0
[347.724268] Dynamic subtest rcs0: SUCCESS (3.085s)
[347.747788] Starting dynamic subtest: bcs0
[351.024733] Dynamic subtest bcs0: SUCCESS (3.299s)
[351.048214] Starting dynamic subtest: vcs0
[354.152156] Dynamic subtest vcs0: SUCCESS (3.122s)
[354.175817] Starting dynamic subtest: vecs0
[357.293296] Dynamic subtest vecs0: SUCCESS (3.141s)
[357.296983] Subtest basic: SUCCESS (12.657s)
[357.544700] [036/132] (694s left) core_getversion (basic)
[357.655122] Starting subtest: basic
[357.664077] Subtest basic: SUCCESS (0.000s)
[357.819659] [037/132] (694s left) gem_ctx_shared (exec-single-timeline)
[357.954297] Starting subtest: exec-single-timeline
[357.958167] Starting dynamic subtest: rcs0
[359.019515] Dynamic subtest rcs0: SUCCESS (1.068s)
[359.046334] Starting dynamic subtest: bcs0
[360.044813] Dynamic subtest bcs0: SUCCESS (1.022s)
[360.074153] Starting dynamic subtest: vcs0
[361.072892] Dynamic subtest vcs0: SUCCESS (1.022s)
[361.103983] Starting dynamic subtest: vecs0
[362.156564] Dynamic subtest vecs0: SUCCESS (1.086s)
[362.160518] Subtest exec-single-timeline: SUCCESS (4.206s)
[362.425630] [038/132] (690s left) gem_exec_schedule (preempt-queue-contexts)
[362.585782] Starting subtest: preempt-queue-contexts
[362.590269] Starting dynamic subtest: rcs0
[363.302275] Dynamic subtest rcs0: SUCCESS (0.719s)
[363.331891] Starting dynamic subtest: bcs0
[364.064061] Dynamic subtest bcs0: SUCCESS (0.754s)
[364.113374] Starting dynamic subtest: vcs0
[364.819552] Dynamic subtest vcs0: SUCCESS (0.763s)
[364.870442] Starting dynamic subtest: vecs0
[365.567041] Dynamic subtest vecs0: SUCCESS (0.745s)
[365.571114] Subtest preempt-queue-contexts: SUCCESS (2.993s)
[365.988077] [039/132] (686s left) prime_self_import (basic-with_one_bo_two_files)
[366.094321] Starting subtest: basic-with_one_bo_two_files
[366.104183] Subtest basic-with_one_bo_two_files: SUCCESS (0.008s)
[366.241182] [040/132] (686s left) gem_compute (compute-square)
[366.354194] Starting subtest: compute-square
[366.361390] Subtest compute-square: SKIP (0.000s)
[366.492738] [041/132] (686s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[366.689284] Starting subtest: psr-dirtyfb-ioctl
[366.719535] Subtest psr-dirtyfb-ioctl: SKIP (0.000s)
[366.828107] [042/132] (686s left) gem_ctx_persistence (engines-persistence)
[366.946935] Starting subtest: engines-persistence
[366.951164] Starting dynamic subtest: rcs0
[367.733024] Dynamic subtest rcs0: SUCCESS (0.782s)
[367.756366] Starting dynamic subtest: bcs0
[368.508141] Dynamic subtest bcs0: SUCCESS (0.775s)
[368.536787] Starting dynamic subtest: vcs0
[369.279104] Dynamic subtest vcs0: SUCCESS (0.766s)
[369.303128] Starting dynamic subtest: vecs0
[370.043054] Dynamic subtest vecs0: SUCCESS (0.763s)
[370.046524] Subtest engines-persistence: SUCCESS (3.097s)
[370.191076] [043/132] (682s left) gem_exec_reloc (basic-softpin)
[370.320338] Starting subtest: basic-softpin
[370.325719] Subtest basic-softpin: SUCCESS (0.006s)
[370.562145] [044/132] (682s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[370.773090] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[370.779895] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[370.910850] [045/132] (682s left) syncobj_wait (invalid-signal-zero-handles)
[371.026384] Starting subtest: invalid-signal-zero-handles
[371.029749] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[371.159341] [046/132] (682s left) gem_ctx_param (set-priority-range)
[371.273084] Starting subtest: set-priority-range
[371.314883] Subtest set-priority-range: SUCCESS (0.052s)
[371.462440] [047/132] (681s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[371.677488] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[371.684704] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[371.828133] [048/132] (681s left) gem_exec_balancer (fairslice)
[371.961709] Starting subtest: fairslice
[371.969361] Subtest fairslice: SKIP (0.000s)
[372.256858] [049/132] (681s left) kms_atomic (plane-invalid-params)
[372.449316] Starting subtest: plane-invalid-params
[372.454063] Starting dynamic subtest: pipe-A-HDMI-A-1
[373.054981] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.601s)
[373.062090] Subtest plane-invalid-params: SUCCESS (0.607s)
[373.348653] [050/132] (680s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[373.552551] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[373.558193] Starting dynamic subtest: pipe-A-HDMI-A-1
[373.574193] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[373.618558] Starting dynamic subtest: pipe-A-HDMI-A-2
[373.638522] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s)
[373.682268] Starting dynamic subtest: pipe-B-HDMI-A-1
[373.700461] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[373.734757] Starting dynamic subtest: pipe-B-HDMI-A-2
[373.746806] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[373.770940] Starting dynamic subtest: pipe-C-HDMI-A-1
[373.782854] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[373.807669] Starting dynamic subtest: pipe-C-HDMI-A-2
[373.821043] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[373.827197] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.030s)
[374.624764] [051/132] (679s left) gem_exec_reloc (basic-wc-read)
[374.750706] Starting subtest: basic-wc-read
[374.764084] Subtest basic-wc-read: SUCCESS (0.016s)
[374.999520] [052/132] (678s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[375.220568] Starting subtest: yf-tiled-16bpp-rotate-180
[379.103033] Subtest yf-tiled-16bpp-rotate-180: SUCCESS (3.885s)
[379.444898] [053/132] (674s left) gem_ctx_persistence (legacy-engines-cleanup)
[379.579140] Starting subtest: legacy-engines-cleanup
[379.583954] Starting dynamic subtest: render
[379.607468] Dynamic subtest render: SUCCESS (0.030s)
[379.637145] Starting dynamic subtest: bsd
[379.641331] Dynamic subtest bsd: SUCCESS (0.020s)
[379.668883] Starting dynamic subtest: blt
[379.672630] Dynamic subtest blt: SUCCESS (0.026s)
[379.695917] Starting dynamic subtest: vebox
[379.699829] Dynamic subtest vebox: SUCCESS (0.022s)
[379.703288] Subtest legacy-engines-cleanup: SUCCESS (0.114s)
[379.827670] [054/132] (674s left) gem_workarounds (suspend-resume-context)
[379.973783] Starting subtest: suspend-resume-context