[90.844229] Initializing watchdogs
[90.844443]   /dev/watchdog0
[90.884525] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[90.899347] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[90.906846] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[90.914960] [001/133] (960s left) kms_pm_dc (dc3co-vpb-simulation)
[92.128763] Starting subtest: dc3co-vpb-simulation
[92.137186] Subtest dc3co-vpb-simulation: SKIP (0.000s)
[92.279735] [002/133] (959s left) gem_mmap_gtt (basic-read)
[92.388157] Starting subtest: basic-read
[92.418363] Subtest basic-read: SUCCESS (0.034s)
[92.563666] [003/133] (959s left) i915_pm_freq_api (freq-reset)
[92.692278] Subtest freq-reset: SKIP (0.000s)
[92.788272] [004/133] (958s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[93.395087] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[93.682376] [005/133] (958s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[93.899540] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[93.906522] Subtest fbcpsr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[94.045251] [006/133] (957s left) gem_exec_whisper (basic-fds-priority-all)
[94.182462] Starting subtest: basic-fds-priority-all
[110.965551] Subtest basic-fds-priority-all: SUCCESS (16.773s)
[111.252740] [007/133] (940s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[111.374428] Starting subtest: basic-wc-gtt-noreloc
[111.384320] Subtest basic-wc-gtt-noreloc: SUCCESS (0.010s)
[111.624710] [008/133] (940s left) i915_drm_fdinfo (basics)
[111.741160] Starting subtest: basics
[111.744823] Subtest basics: SUCCESS (0.001s)
[111.891237] [009/133] (940s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[112.075076] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (0.000s)
[112.187287] [010/133] (940s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[112.375134] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[113.248988] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (0.876s)
[113.586675] [011/133] (938s left) drm_read (short-buffer-nonblock)
[114.015260] Starting subtest: short-buffer-nonblock
[114.018337] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[114.299332] [012/133] (938s left) gem_exec_balancer (hang)
[114.544872] Starting subtest: hang
[118.766591] Subtest hang: SUCCESS (4.220s)
[118.931513] [013/133] (933s left) gem_exec_schedule (preempt-hang)
[119.177020] Starting subtest: preempt-hang
[119.180357] Starting dynamic subtest: rcs0
[119.438052] Dynamic subtest rcs0: SUCCESS (0.258s)
[119.462532] Starting dynamic subtest: bcs0
[119.720783] Dynamic subtest bcs0: SUCCESS (0.288s)
[119.742962] Starting dynamic subtest: vcs0
[119.975052] Dynamic subtest vcs0: SUCCESS (0.250s)
[120.001534] Starting dynamic subtest: vecs0
[120.230364] Dynamic subtest vecs0: SUCCESS (0.254s)
[120.238722] Subtest preempt-hang: SUCCESS (1.053s)
[120.512739] [014/133] (932s left) kms_plane_cursor (overlay)
[120.696134] Starting subtest: overlay
[120.705641] Starting dynamic subtest: pipe-A-HDMI-A-1-size-64
[123.392089] Dynamic subtest pipe-A-HDMI-A-1-size-64: SUCCESS (2.694s)
[123.480431] Starting dynamic subtest: pipe-A-HDMI-A-1-size-128
[126.011083] Dynamic subtest pipe-A-HDMI-A-1-size-128: SUCCESS (2.549s)
[126.099101] Starting dynamic subtest: pipe-A-HDMI-A-1-size-256
[128.643657] Dynamic subtest pipe-A-HDMI-A-1-size-256: SUCCESS (2.566s)
[128.940277] Starting dynamic subtest: pipe-B-HDMI-A-2-size-64
[131.613313] Dynamic subtest pipe-B-HDMI-A-2-size-64: SUCCESS (2.694s)
[131.680932] Starting dynamic subtest: pipe-B-HDMI-A-2-size-128
[134.214084] Dynamic subtest pipe-B-HDMI-A-2-size-128: SUCCESS (2.549s)
[134.293426] Starting dynamic subtest: pipe-B-HDMI-A-2-size-256
[136.881102] Dynamic subtest pipe-B-HDMI-A-2-size-256: SUCCESS (2.617s)
[137.182077] Starting dynamic subtest: pipe-C-HDMI-A-1-size-64
[139.719077] Dynamic subtest pipe-C-HDMI-A-1-size-64: SUCCESS (2.588s)
[139.793668] Starting dynamic subtest: pipe-C-HDMI-A-1-size-128
[142.319108] Dynamic subtest pipe-C-HDMI-A-1-size-128: SUCCESS (2.547s)
[142.391212] Starting dynamic subtest: pipe-C-HDMI-A-1-size-256
[145.046103] Dynamic subtest pipe-C-HDMI-A-1-size-256: SUCCESS (2.548s)
[145.253900] Subtest overlay: SUCCESS (24.455s)
[145.846982] [015/133] (907s left) gem_vm_create (invalid-destroy)
[146.153976] Starting subtest: invalid-destroy
[146.158064] Subtest invalid-destroy: SUCCESS (0.001s)
[146.300487] [016/133] (906s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[146.510465] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[149.741933] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SUCCESS (3.244s)
[149.980501] [017/133] (903s left) gem_ctx_param (get-priority-new-ctx)
[150.093589] Starting subtest: get-priority-new-ctx
[150.097531] Subtest get-priority-new-ctx: SUCCESS (0.000s)
[150.250604] [018/133] (903s left) kms_dsc (dsc-basic)
[150.437065] Subtest dsc-basic: SKIP (0.000s)
[150.546719] [019/133] (902s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[150.733107] Starting subtest: primary-yf-tiled-reflect-x-0
[150.739428] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.003s)
[150.867065] [020/133] (902s left) gem_userptr_blits (sync-unmap-cycles)
[151.013261] Starting subtest: sync-unmap-cycles
[156.410093] Subtest sync-unmap-cycles: SUCCESS (5.396s)
[156.613559] [021/133] (897s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[156.806201] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[156.810451] Starting dynamic subtest: pipe-A
[157.142904] Dynamic subtest pipe-A: SUCCESS (0.341s)
[157.189099] Starting dynamic subtest: pipe-B
[157.590061] Dynamic subtest pipe-B: SUCCESS (0.446s)
[157.621061] Starting dynamic subtest: pipe-C
[157.665078] Dynamic subtest pipe-C: SUCCESS (0.073s)
[157.668248] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SUCCESS (0.864s)
[158.149853] [022/133] (895s left) kms_content_protection (dp-mst-type-1-suspend-resume)
[158.359535] Starting subtest: dp-mst-type-1-suspend-resume
[158.366272] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s)
[158.545998] [023/133] (895s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[158.764046] Starting subtest: x-tiled-32bpp-rotate-270
[159.127626] Subtest x-tiled-32bpp-rotate-270: SKIP (0.357s)
[159.380833] [024/133] (894s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[159.603175] Starting subtest: 4-tiled-16bpp-rotate-90
[159.610048] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.000s)
[159.747275] [025/133] (894s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[159.953295] Starting subtest: cursor-rapid-movement-32x10
[160.199139] Subtest cursor-rapid-movement-32x10: SKIP (0.238s)
[160.366909] [026/133] (893s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[160.574050] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[160.672503] [027/133] (893s left) gem_readwrite (new-obj)
[160.784691] Starting subtest: new-obj
[160.790827] Subtest new-obj: SUCCESS (0.000s)
[160.929034] [028/133] (893s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[161.114437] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[161.322093] Starting dynamic subtest: pipe-A-plane-0
[161.620059] Dynamic subtest pipe-A-plane-0: SUCCESS (0.299s)
[161.642759] Starting dynamic subtest: pipe-A-plane-1
[161.922045] Dynamic subtest pipe-A-plane-1: SUCCESS (0.298s)
[161.944184] Starting dynamic subtest: pipe-A-plane-2
[162.205508] Dynamic subtest pipe-A-plane-2: SUCCESS (0.282s)
[162.228168] Starting dynamic subtest: pipe-A-plane-3
[162.487834] Dynamic subtest pipe-A-plane-3: SUCCESS (0.282s)
[162.874547] Starting dynamic subtest: pipe-B-plane-0
[163.123918] Dynamic subtest pipe-B-plane-0: SUCCESS (0.268s)
[163.146406] Starting dynamic subtest: pipe-B-plane-1
[163.423203] Dynamic subtest pipe-B-plane-1: SUCCESS (0.296s)
[163.444889] Starting dynamic subtest: pipe-B-plane-2
[163.705372] Dynamic subtest pipe-B-plane-2: SUCCESS (0.282s)
[163.729538] Starting dynamic subtest: pipe-B-plane-3
[163.971977] Dynamic subtest pipe-B-plane-3: SUCCESS (0.265s)
[164.201196] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SUCCESS (3.082s)
[164.502454] [029/133] (889s left) drm_read (short-buffer-wakeup)
[164.928108] Starting subtest: short-buffer-wakeup
[197.142578] Subtest short-buffer-wakeup: SUCCESS (32.215s)
[197.448307] [030/133] (857s left) syncobj_wait (multi-wait-submitted)
[197.563283] Starting subtest: multi-wait-submitted
[197.669153] Subtest multi-wait-submitted: SUCCESS (0.106s)
[197.813310] [031/133] (856s left) kms_color (ctm-red-to-blue)
[198.004410] Starting subtest: ctm-red-to-blue
[198.007463] Starting dynamic subtest: pipe-A-HDMI-A-1
[198.951110] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.947s)
[198.996444] Starting dynamic subtest: pipe-A-HDMI-A-2
[199.654243] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.700s)
[199.678447] Starting dynamic subtest: pipe-B-HDMI-A-1
[200.337881] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.683s)
[200.383563] Starting dynamic subtest: pipe-B-HDMI-A-2
[201.005802] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.664s)
[201.029845] Starting dynamic subtest: pipe-C-HDMI-A-1
[201.695198] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.659s)
[201.742438] Starting dynamic subtest: pipe-C-HDMI-A-2
[202.327575] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.653s)
[202.334159] Subtest ctm-red-to-blue: SUCCESS (4.325s)
[202.646856] [032/133] (852s left) perf_pmu (busy-check-all)
[202.768099] Starting subtest: busy-check-all
[202.772040] Starting dynamic subtest: rcs0
[203.298188] Dynamic subtest rcs0: SUCCESS (0.528s)
[203.322902] Starting dynamic subtest: bcs0
[203.832041] Dynamic subtest bcs0: SUCCESS (0.533s)
[203.857518] Starting dynamic subtest: vcs0
[204.366660] Dynamic subtest vcs0: SUCCESS (0.533s)
[204.390174] Starting dynamic subtest: vecs0
[204.895622] Dynamic subtest vecs0: SUCCESS (0.525s)
[204.899032] Subtest busy-check-all: SUCCESS (2.129s)
[205.041819] [033/133] (849s left) vgem_basic (bad-fence)
[205.244161] Starting subtest: bad-fence
[205.248508] Subtest bad-fence: SUCCESS (0.000s)
[205.378147] [FACT vgem_basic (bad-fence)] new: kernel.kmod_is_loaded.vgem: true
[205.385723] [034/133] (849s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[205.602110] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[205.609679] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[205.753866] [035/133] (849s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[205.979504] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[205.987770] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[206.120343] [036/133] (848s left) gem_sync (basic-many-each)
[206.279047] Starting subtest: basic-many-each
[208.718147] Subtest basic-many-each: SUCCESS (2.459s)
[208.972787] [037/133] (846s left) gem_softpin (evict-active)
[209.097957] Starting subtest: evict-active
[209.110214] Subtest evict-active: SUCCESS (0.015s)
[209.271932] [038/133] (846s left) syncobj_timeline (single-wait-all-signaled)
[209.384255] Starting subtest: single-wait-all-signaled
[209.388277] Subtest single-wait-all-signaled: SUCCESS (0.002s)
[209.564776] [039/133] (845s left) kms_vblank (query-busy-hang)
[209.758477] Starting subtest: query-busy-hang
[209.761397] Starting dynamic subtest: pipe-A-HDMI-A-1
[216.829107] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (7.071s)
[216.880568] Starting dynamic subtest: pipe-A-HDMI-A-2
[223.879121] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (7.040s)
[223.920025] Starting dynamic subtest: pipe-C-HDMI-A-1
[230.840360] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (6.944s)
[230.868206] Starting dynamic subtest: pipe-C-HDMI-A-2
[237.869366] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (7.029s)
[237.874548] Subtest query-busy-hang: SUCCESS (28.118s)
[238.166404] [040/133] (817s left) gem_exec_alignment (forked)
[238.298231] Starting subtest: forked
[285.172104] Subtest forked: SUCCESS (46.880s)
[286.440301] [041/133] (769s left) kms_flip (2x-absolute-wf_vblank)
[286.802071] Starting subtest: 2x-absolute-wf_vblank
[286.807072] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[297.809268] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (11.006s)
[297.840815] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[308.734905] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (10.918s)
[308.760019] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[319.486137] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (10.743s)
[319.492906] Subtest 2x-absolute-wf_vblank: SUCCESS (32.684s)
[320.111455] [042/133] (735s left) gem_pxp (hw-rejects-pxp-context)
[322.765794] Starting subtest: hw-rejects-pxp-context
[322.768962] Subtest hw-rejects-pxp-context: SUCCESS (0.002s)
[322.941264] [043/133] (732s left) kms_cursor_crc (cursor-alpha-opaque)
[323.139545] Starting subtest: cursor-alpha-opaque
[323.142562] Starting dynamic subtest: pipe-A-HDMI-A-1
[324.039112] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.901s)
[324.066033] Starting dynamic subtest: pipe-C-HDMI-A-1
[324.633248] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.588s)
[324.637576] Subtest cursor-alpha-opaque: SUCCESS (1.503s)
[325.029085] [044/133] (730s left) kms_cursor_edge_walk (256x256-left-edge)
[325.244200] Starting subtest: 256x256-left-edge
[325.249319] Starting dynamic subtest: pipe-A-HDMI-A-1
[329.203098] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.956s)
[329.246260] Starting dynamic subtest: pipe-C-HDMI-A-1
[332.694996] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.484s)
[332.702049] Subtest 256x256-left-edge: SUCCESS (7.454s)
[333.010390] [045/133] (723s left) gem_exec_schedule (semaphore-codependency)
[333.175537] Starting subtest: semaphore-codependency
[333.197542] Subtest semaphore-codependency: SUCCESS (0.023s)
[333.591346] [046/133] (722s left) perf (short-reads)
[333.892128] Starting subtest: short-reads
[333.909946] Subtest short-reads: SUCCESS (0.030s)
[334.026793] [047/133] (722s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[334.233124] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[336.755098] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SUCCESS (2.530s)
[336.957128] [048/133] (719s left) kms_prime (basic-crc-vgem)
[337.188079] Starting subtest: basic-crc-vgem
[337.190892] Starting dynamic subtest: second-to-first
[338.840066] Dynamic subtest second-to-first: SUCCESS (1.648s)
[338.847659] Subtest basic-crc-vgem: SUCCESS (1.652s)
[339.163783] [049/133] (717s left) gem_exec_reloc (basic-write-cpu-active)
[339.292580] Starting subtest: basic-write-cpu-active
[339.430858] Subtest basic-write-cpu-active: SUCCESS (0.140s)
[339.657700] [050/133] (716s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[339.925263] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[339.931864] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[340.092124] [051/133] (716s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[340.207738] Starting subtest: multi-wait-for-submit-available-submitted
[340.211160] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.002s)
[340.354206] [052/133] (716s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[340.548309] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[340.553166] Starting dynamic subtest: pipe-A-HDMI-A-1
[340.594462] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[340.647514] Starting dynamic subtest: pipe-A-HDMI-A-2
[340.689871] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.001s)
[340.717458] Starting dynamic subtest: pipe-B-HDMI-A-1
[340.747845] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[340.772572] Starting dynamic subtest: pipe-B-HDMI-A-2
[340.800575] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.001s)
[340.823855] Starting dynamic subtest: pipe-C-HDMI-A-1
[340.856135] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[340.880254] Starting dynamic subtest: pipe-C-HDMI-A-2
[340.912130] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[340.915405] Subtest missing-ccs-buffer-y-tiled-ccs: SUCCESS (0.035s)
[341.581469] [053/133] (715s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[341.786720] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[341.792882] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s)
[341.947345] [054/133] (715s left) api_intel_allocator (two-level-inception-interruptible)
[342.058201] Starting subtest: two-level-inception-interruptible
[347.609075] Subtest two-level-inception-interruptible: SUCCESS (5.555s)
[347.762497] [055/133] (709s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[347.944078] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[347.951024] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.000s)
[348.097438] [056/133] (709s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[348.212282] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[348.216170] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.002s)
[348.359967] [057/133] (708s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[348.571941] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[348.578641] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[348.728441] [058/133] (708s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[348.946101] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[348.955510] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[349.137846] [059/133] (708s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[349.350555] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[352.063383] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SUCCESS (2.718s)
[352.259062] [060/133] (705s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[352.462028] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[352.469044] Starting dynamic subtest: pipe-A-HDMI-A-1