[89.914974] Initializing watchdogs
[89.915251]   /dev/watchdog0
[89.956114] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[89.970760] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[89.978046] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[89.986858] [001/132] (960s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[92.667642] Starting subtest: verify-pxp-key-change-after-suspend-resume
[92.674990] Subtest verify-pxp-key-change-after-suspend-resume: SKIP (0.000s)
[92.816644] [002/132] (957s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[93.034047] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[95.982364] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (2.950s)
[96.269764] [003/132] (954s left) gem_wait (await)
[96.411884] Starting subtest: await
[96.415409] Starting dynamic subtest: all-engines
[97.529938] Dynamic subtest all-engines: SUCCESS (1.117s)
[97.554250] Starting dynamic subtest: rcs0
[98.567799] Dynamic subtest rcs0: SUCCESS (1.036s)
[98.592496] Starting dynamic subtest: bcs0
[99.601384] Dynamic subtest bcs0: SUCCESS (1.034s)
[99.630258] Starting dynamic subtest: vcs0
[100.653082] Dynamic subtest vcs0: SUCCESS (1.051s)
[100.677304] Starting dynamic subtest: vecs0
[101.697195] Dynamic subtest vecs0: SUCCESS (1.039s)
[101.700443] Subtest await: SUCCESS (5.282s)
[101.972334] [FACT gem_wait (await)] new: kernel.kmod_is_loaded.vgem: true
[101.979742] [004/132] (948s left) kms_properties (crtc-properties-legacy)
[102.175865] Starting subtest: crtc-properties-legacy
[102.180684] Starting dynamic subtest: pipe-A-HDMI-A-1
[102.843191] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.660s)
[102.875166] Starting dynamic subtest: pipe-B-HDMI-A-2
[103.276422] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.438s)
[103.300805] Starting dynamic subtest: pipe-C-HDMI-A-1
[103.772063] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.492s)
[103.775697] Subtest crtc-properties-legacy: SUCCESS (1.602s)
[104.107025] [005/132] (946s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[104.314087] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[104.430593] [006/132] (946s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[104.649378] Starting subtest: yf-tiled-32bpp-rotate-270
[109.584436] Subtest yf-tiled-32bpp-rotate-270: SUCCESS (4.939s)
[109.985603] [007/132] (941s left) gem_exec_store (pages)
[110.114999] Starting subtest: pages
[110.118536] Starting dynamic subtest: rcs0
[110.211303] Dynamic subtest rcs0: SUCCESS (0.096s)
[110.234234] Starting dynamic subtest: bcs0
[110.303775] Dynamic subtest bcs0: SUCCESS (0.089s)
[110.327024] Starting dynamic subtest: vcs0
[110.385931] Dynamic subtest vcs0: SUCCESS (0.081s)
[110.407909] Starting dynamic subtest: vecs0
[110.465926] Dynamic subtest vecs0: SUCCESS (0.080s)
[110.470189] Subtest pages: SUCCESS (0.354s)
[110.747808] [008/132] (940s left) gem_exec_balancer (busy)
[110.883806] Starting subtest: busy
[113.169254] Subtest busy: SUCCESS (2.283s)
[113.449785] [009/132] (937s left) i915_hangman (gt-error-state-capture)
[113.596875] Starting subtest: gt-error-state-capture
[113.601173] Starting dynamic subtest: rcs0
[123.083297] Dynamic subtest rcs0: SUCCESS (9.492s)
[123.115266] Starting dynamic subtest: bcs0
[133.015079] Dynamic subtest bcs0: SUCCESS (9.922s)
[133.055185] Starting dynamic subtest: vcs0
[143.063447] Dynamic subtest vcs0: SUCCESS (10.049s)
[143.106390] Starting dynamic subtest: vecs0
[153.027116] Dynamic subtest vecs0: SUCCESS (9.966s)
[153.032084] Subtest gt-error-state-capture: SUCCESS (39.439s)
[153.218679] [010/132] (898s left) kms_vrr (lobf)
[153.401021] Starting subtest: lobf
[153.407532] Subtest lobf: SKIP (0.001s)
[153.556265] [011/132] (897s left) kms_atomic_interruptible (atomic-setmode)
[153.753677] Starting subtest: atomic-setmode
[153.757960] Starting dynamic subtest: pipe-A-HDMI-A-1
[160.668788] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.913s)
[160.672116] Subtest atomic-setmode: SUCCESS (6.917s)
[161.029961] [012/132] (890s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[161.259407] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[161.266434] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[161.411656] [013/132] (890s left) kms_cursor_crc (cursor-sliding-32x10)
[161.608641] Starting subtest: cursor-sliding-32x10
[161.770209] Subtest cursor-sliding-32x10: SKIP (0.153s)
[161.927889] [014/132] (889s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[162.144435] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[162.151958] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[162.313978] [015/132] (889s left) kms_chamelium_frames (dp-frame-dump)
[162.903136] Subtest dp-frame-dump: SKIP (0.000s)
[163.208508] [016/132] (888s left) gem_exec_fence (syncobj-export)
[163.789564] Starting subtest: syncobj-export
[163.797057] Subtest syncobj-export: SUCCESS (0.008s)
[164.215809] [017/132] (887s left) gem_ctx_persistence (engines-hostile-preempt)
[164.337500] Starting subtest: engines-hostile-preempt
[164.341482] Starting dynamic subtest: rcs0
[164.432052] Dynamic subtest rcs0: SUCCESS (0.091s)
[164.456774] Starting dynamic subtest: bcs0
[164.515669] Dynamic subtest bcs0: SUCCESS (0.081s)
[164.538964] Starting dynamic subtest: vcs0
[164.602290] Dynamic subtest vcs0: SUCCESS (0.084s)
[164.625398] Starting dynamic subtest: vecs0
[164.689557] Dynamic subtest vecs0: SUCCESS (0.086s)
[164.693989] Subtest engines-hostile-preempt: SUCCESS (0.352s)
[164.884299] [018/132] (887s left) syncobj_timeline (invalid-query-bad-pad)
[164.995564] Starting subtest: invalid-query-bad-pad
[164.999217] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[165.136793] [019/132] (887s left) i915_query (query-topology-kernel-writes)
[165.247462] Starting subtest: query-topology-kernel-writes
[165.254080] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[165.386984] [020/132] (887s left) device_reset (cold-reset-bound)
[165.532987] Starting subtest: cold-reset-bound
[165.541970] Subtest cold-reset-bound: SKIP (0.000s)
[165.670529] [021/132] (886s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[165.864477] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[165.868184] Starting dynamic subtest: pipe-A-HDMI-A-1
[165.918875] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[165.958911] Starting dynamic subtest: pipe-A-HDMI-A-2
[166.010183] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s)
[166.033880] Starting dynamic subtest: pipe-B-HDMI-A-1
[166.071997] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[166.094962] Starting dynamic subtest: pipe-B-HDMI-A-2
[166.130901] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s)
[166.153131] Starting dynamic subtest: pipe-C-HDMI-A-1
[166.188959] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[166.213968] Starting dynamic subtest: pipe-C-HDMI-A-2
[166.248974] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[166.255222] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.019s)
[166.897379] [022/132] (885s left) gem_exec_reloc (basic-write-wc-noreloc)
[167.035637] Starting subtest: basic-write-wc-noreloc
[167.041083] Subtest basic-write-wc-noreloc: SUCCESS (0.008s)
[167.279098] [023/132] (885s left) kms_dp_link_training (non-uhbr-sst)
[167.478920] Starting subtest: non-uhbr-sst
[167.498809] Subtest non-uhbr-sst: SKIP (0.000s)
[167.628346] [024/132] (885s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[167.743080] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[167.863209] [025/132] (885s left) kms_universal_plane (disable-primary-vs-flip)
[168.052968] Starting subtest: disable-primary-vs-flip
[168.058091] Starting dynamic subtest: pipe-A-HDMI-A-1
[169.111692] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.056s)
[169.163671] Starting dynamic subtest: pipe-B-HDMI-A-2
[169.950820] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.835s)
[169.982494] Starting dynamic subtest: pipe-C-HDMI-A-1
[170.747358] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.787s)
[170.753597] Subtest disable-primary-vs-flip: SUCCESS (2.695s)
[171.080603] [026/132] (882s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[171.306807] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[174.209137] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (2.903s)
[174.507888] [027/132] (878s left) gem_softpin (safe-alignment)
[174.633682] Starting subtest: safe-alignment
[174.667490] Subtest safe-alignment: SUCCESS (0.032s)
[174.838079] [028/132] (878s left) kms_color (ctm-red-to-blue)
[175.018939] Starting subtest: ctm-red-to-blue
[175.023029] Starting dynamic subtest: pipe-A-HDMI-A-1
[175.963483] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.938s)
[176.016626] Starting dynamic subtest: pipe-A-HDMI-A-2
[176.633704] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.666s)
[176.684046] Starting dynamic subtest: pipe-B-HDMI-A-1
[177.267263] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.633s)
[177.316244] Starting dynamic subtest: pipe-B-HDMI-A-2
[177.905199] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.639s)
[177.937354] Starting dynamic subtest: pipe-C-HDMI-A-1
[178.555121] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.649s)
[178.580047] Starting dynamic subtest: pipe-C-HDMI-A-2
[179.218350] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.659s)
[179.222308] Subtest ctm-red-to-blue: SUCCESS (4.198s)
[179.531814] [029/132] (873s left) gem_exec_schedule (u-semaphore-user)
[179.685371] Starting subtest: u-semaphore-user
[179.701394] Subtest u-semaphore-user: SUCCESS (0.020s)
[180.094636] [030/132] (873s left) sw_sync (sync_busy)
[180.198379] Starting subtest: sync_busy
[180.206893] Subtest sync_busy: SUCCESS (0.010s)
[180.342385] [031/132] (873s left) kms_getfb (getfb-handle-valid)
[180.540844] Starting subtest: getfb-handle-valid
[180.544244] Subtest getfb-handle-valid: SUCCESS (0.000s)
[180.694970] [032/132] (873s left) gem_pread (snoop)
[180.810639] Starting subtest: snoop
[184.064914] Subtest snoop: SUCCESS (3.248s)
[184.208995] [033/132] (869s left) gem_exec_reloc (basic-cpu-wc)
[184.356731] Starting subtest: basic-cpu-wc
[184.375265] Subtest basic-cpu-wc: SUCCESS (0.025s)
[184.616801] [034/132] (869s left) vgem_basic (busy-fence)
[184.758435] Starting subtest: busy-fence
[184.763064] Subtest busy-fence: SUCCESS (0.000s)
[184.877773] [035/132] (869s left) kms_busy (extended-pageflip-hang-newfb)
[185.078257] Starting subtest: extended-pageflip-hang-newfb
[185.082239] Starting dynamic subtest: pipe-A
[188.926677] Dynamic subtest pipe-A: SUCCESS (3.843s)
[188.960462] Starting dynamic subtest: pipe-C
[192.849431] Dynamic subtest pipe-C: SUCCESS (3.916s)
[192.853103] Subtest extended-pageflip-hang-newfb: SUCCESS (7.776s)
[193.209683] [036/132] (860s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[193.407521] Starting subtest: flip-vs-cursor-varying-size
[217.276954] Subtest flip-vs-cursor-varying-size: SUCCESS (23.870s)
[217.622827] [037/132] (836s left) kms_hdr (invalid-metadata-sizes)
[217.821438] Starting subtest: invalid-metadata-sizes
[217.836951] Subtest invalid-metadata-sizes: SKIP (0.001s)
[217.970811] [038/132] (836s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[218.191758] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[218.200652] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[218.339033] [039/132] (836s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[218.545370] Starting subtest: 2x-absolute-wf_vblank-interruptible
[218.549891] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[229.342121] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (10.799s)
[229.382210] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[240.280919] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (10.925s)
[240.307692] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[250.989980] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (10.700s)
[250.994995] Subtest 2x-absolute-wf_vblank-interruptible: SUCCESS (32.451s)
[251.657953] [040/132] (802s left) kms_draw_crc (draw-method-mmap-cpu)
[251.846061] Starting subtest: draw-method-mmap-cpu
[251.850032] Starting dynamic subtest: xrgb8888-untiled
[252.344298] Dynamic subtest xrgb8888-untiled: SUCCESS (0.496s)
[252.371868] Starting dynamic subtest: rgb565-untiled
[252.592539] Dynamic subtest rgb565-untiled: SUCCESS (0.246s)
[252.619610] Starting dynamic subtest: xrgb2101010-untiled
[252.860502] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.264s)
[252.886513] Starting dynamic subtest: xbgr16161616f-untiled
[253.144369] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.281s)
[253.167316] Starting dynamic subtest: xrgb8888-xtiled
[253.325443] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.182s)
[253.348514] Starting dynamic subtest: rgb565-xtiled
[253.509470] Dynamic subtest rgb565-xtiled: SUCCESS (0.181s)
[253.532897] Starting dynamic subtest: xrgb2101010-xtiled
[253.677381] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.163s)
[253.700588] Starting dynamic subtest: xbgr16161616f-xtiled
[253.859972] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.181s)
[253.883484] Starting dynamic subtest: xrgb8888-ytiled
[254.042639] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.181s)
[254.066100] Starting dynamic subtest: rgb565-ytiled
[254.225535] Dynamic subtest rgb565-ytiled: SUCCESS (0.180s)
[254.249160] Starting dynamic subtest: xrgb2101010-ytiled
[254.393074] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.163s)
[254.418730] Starting dynamic subtest: xbgr16161616f-ytiled
[254.575607] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.181s)
[254.580779] Subtest draw-method-mmap-cpu: SUCCESS (2.731s)
[254.814704] [041/132] (799s left) kms_psr (pr-sprite-mmap-gtt)
[255.024484] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[255.143557] [042/132] (799s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[255.359202] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[255.365962] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[255.513450] [043/132] (799s left) perf (invalid-oa-exponent)
[255.734089] Starting subtest: invalid-oa-exponent
[255.778131] Subtest invalid-oa-exponent: SUCCESS (0.041s)
[255.903864] [044/132] (799s left) gen9_exec_parse (batch-without-end)
[256.036023] Starting subtest: batch-without-end
[256.044307] Subtest batch-without-end: SUCCESS (0.004s)
[256.314780] [045/132] (798s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[256.523335] Starting subtest: y-tiled-32bpp-rotate-0
[262.359395] Subtest y-tiled-32bpp-rotate-0: SUCCESS (5.837s)
[262.765220] [046/132] (792s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[262.982217] Starting subtest: cursor-rapid-movement-512x512
[262.988828] Subtest cursor-rapid-movement-512x512: SKIP (0.003s)
[263.150647] [047/132] (792s left) gem_create (create-clear)
[263.267536] Starting subtest: create-clear
[263.272507] Starting dynamic subtest: smem0
[295.830184] Dynamic subtest smem0: SUCCESS (32.552s)
[295.835484] Subtest create-clear: SUCCESS (32.557s)
[296.096970] [048/132] (759s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[296.301545] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[298.797073] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (2.506s)
[299.080056] [049/132] (756s left) api_intel_bb (offset-control)
[299.192371] Starting subtest: offset-control
[299.206121] Subtest offset-control: SUCCESS (0.018s)
[299.378402] [050/132] (756s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[299.586303] Starting subtest: psr-1p-pri-indfb-multidraw
[299.594436] Subtest psr-1p-pri-indfb-multidraw: SKIP (0.000s)
[299.734169] [051/132] (756s left) gem_exec_flush (basic-wb-ro-before-default)
[299.874693] Starting subtest: basic-wb-ro-before-default
[305.289056] Subtest basic-wb-ro-before-default: SUCCESS (5.416s)
[305.564490] [052/132] (750s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[305.774249] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[305.783287] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[305.932555] [053/132] (750s left) gem_tiled_fence_blits (basic)
[306.974259] Starting subtest: basic
[307.011517] Subtest basic: SUCCESS (0.035s)
[307.199781] [054/132] (748s left) kms_plane_alpha_blend (alpha-7efc)
[307.549144] Starting subtest: alpha-7efc
[307.785744] Starting dynamic subtest: pipe-A-HDMI-A-1
[308.841666] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.064s)
[308.971617] Starting dynamic subtest: pipe-C-HDMI-A-1
[309.987358] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.055s)
[309.999874] Subtest alpha-7efc: SUCCESS (2.435s)
[310.349754] [055/132] (745s left) kms_draw_crc (fill-fb)
[310.574902] Starting subtest: fill-fb
[311.175606] Subtest fill-fb: SUCCESS (0.604s)
[311.464557] [056/132] (744s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[311.696306] Starting subtest: 4-tiled-16bpp-rotate-0
[311.702776] Subtest 4-tiled-16bpp-rotate-0: SKIP (0.000s)
[311.849571] [057/132] (744s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[312.068533] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[313.946949] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SUCCESS (1.882s)
[314.163639] [058/132] (742s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[314.381118] Starting subtest: fbc-1p-pri-indfb-multidraw
[331.076158] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (16.697s)
[331.382452] [059/132] (725s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[331.603586] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[331.609835] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[331.768567] [060/132] (724s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[331.901189] Starting subtest: multi-wait-for-submit-available-submitted
[331.911307] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.005s)
[332.064251] [061/132] (724s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs)
[332.250200] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs
[332.254539] Starting dynamic subtest: pipe-A-HDMI-A-1
[333.149622] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.846s)
[333.174683] Starting dynamic subtest: pipe-A-HDMI-A-2
[333.996349] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.843s)
[334.043656] Starting dynamic subtest: pipe-B-HDMI-A-1
[334.900775] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.907s)
[334.927447] Starting dynamic subtest: pipe-B-HDMI-A-2
[335.713312] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.810s)
[335.766602] Starting dynamic subtest: pipe-C-HDMI-A-1
[335.916751] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.011s)
[335.946762] Starting dynamic subtest: pipe-C-HDMI-A-2
[336.140997] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.011s)
[336.144751] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SUCCESS (3.456s)
[336.485822] [062/132] (720s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[336.677034] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[336.683565] Starting dynamic subtest: pipe-A
[336.980966] Dynamic subtest pipe-A: SUCCESS (0.306s)
[337.031967] Starting dynamic subtest: pipe-B
[337.414702] Dynamic subtest pipe-B: SUCCESS (0.430s)
[337.465099] Starting dynamic subtest: pipe-C
[337.496543] Dynamic subtest pipe-C: SUCCESS (0.074s)
[337.502915] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SUCCESS (0.821s)
[337.965538] [063/132] (719s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping)
[338.152650] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping
[338.162224] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[338.318471] [064/132] (718s left) gem_softpin (evict-active)
[338.454182] Starting subtest: evict-active
[338.464075] Subtest evict-active: SUCCESS (0.016s)
[338.663202] [065/132] (718s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[338.856481] Starting subtest: addfb25-x-tiled-legacy
[338.860091] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[339.021282] [066/132] (718s left) kms_plane_lowres (tiling-none)
[339.223612] Starting subtest: tiling-none
[339.226901] Starting dynamic subtest: pipe-A-HDMI-A-1
[345.965869] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.745s)
[346.220064] Starting dynamic subtest: pipe-A-HDMI-A-2
[352.591083] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (6.404s)
[352.866140] Starting dynamic subtest: pipe-B-HDMI-A-1
[358.981901] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (6.151s)
[359.216534] Starting dynamic subtest: pipe-B-HDMI-A-2
[365.532822] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (6.348s)
[365.773680] Starting dynamic subtest: pipe-C-HDMI-A-1
[371.926856] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (6.188s)
[372.160329] Starting dynamic subtest: pipe-C-HDMI-A-2
[378.245201] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (6.117s)
[378.447621] Subtest tiling-none: SUCCESS (39.227s)
[378.814645] [067/132] (678s left) gem_userptr_blits (process-exit)
[378.970519] Starting subtest: process-exit
[378.997735] Subtest process-exit: SUCCESS (0.028s)
[379.182365] [068/132] (678s left) gem_ccs (large-ctrl-surf-copy)
[379.307502] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[379.443148] [069/132] (678s left) gem_mmap (big-bo)
[379.556238] Starting subtest: big-bo
[379.946923] Subtest big-bo: SUCCESS (0.394s)
[380.126136] [070/132] (677s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[380.493917] Subtest psr2-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[380.626870] [071/132] (677s left) gem_exec_schedule (independent)
[380.793131] Starting subtest: independent
[380.796518] Starting dynamic subtest: rcs0
[380.946886] Dynamic subtest rcs0: SUCCESS (0.153s)
[380.975544] Starting dynamic subtest: bcs0
[381.103027] Dynamic subtest bcs0: SUCCESS (0.153s)
[381.132232] Starting dynamic subtest: vcs0
[381.248968] Dynamic subtest vcs0: SUCCESS (0.142s)
[381.277255] Starting dynamic subtest: vecs0
[381.395571] Dynamic subtest vecs0: SUCCESS (0.143s)
[381.400273] Subtest independent: SUCCESS (0.607s)
[381.798603] [072/132] (676s left) kms_pm_dc (dc5-psr)
[383.026341] Starting subtest: dc5-psr
[383.035642] Subtest dc5-psr: SKIP (0.000s)
[383.186973] [073/132] (674s left) kms_lease (implicit-plane-lease)
[383.380302] Starting subtest: implicit-plane-lease
[383.384924] Subtest implicit-plane-lease: SUCCESS (0.010s)
[383.556758] [074/132] (674s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[383.787596] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[383.795053] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[383.951355] [075/132] (674s left) kms_pm_rpm (i2c)
[385.941557] Starting subtest: i2c
[387.888738] Subtest i2c: SUCCESS (1.947s)
[388.261314] [076/132] (670s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[388.451722] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[388.455037] Starting dynamic subtest: pipe-A-HDMI-A-1
[388.494109] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[388.542235] Starting dynamic subtest: pipe-A-HDMI-A-2
[388.587295] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s)
[388.633154] Starting dynamic subtest: pipe-B-HDMI-A-1
[388.666465] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[388.692049] Starting dynamic subtest: pipe-B-HDMI-A-2
[388.721639] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s)
[388.746882] Starting dynamic subtest: pipe-C-HDMI-A-1
[388.775400] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[388.800404] Starting dynamic subtest: pipe-C-HDMI-A-2
[388.830325] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[388.836469] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.032s)
[389.569236] [077/132] (668s left) gem_exec_reloc (basic-cpu-wc-active)
[389.712689] Starting subtest: basic-cpu-wc-active
[389.833163] Subtest basic-cpu-wc-active: SUCCESS (0.139s)
[390.099156] [078/132] (668s left) gem_workarounds (suspend-resume-context)
[390.249556] Starting subtest: suspend-resume-context
[407.822329] Subtest suspend-resume-context: SUCCESS (1.387s)
[420.043991] [079/132] (650s left) kms_big_fb (linear-32bpp-rotate-180)
[420.264454] Starting subtest: linear-32bpp-rotate-180
[425.106390] Subtest linear-32bpp-rotate-180: SUCCESS (4.838s)
[425.534475] [080/132] (645s left) syncobj_wait (single-wait-signaled)
[425.652389] Starting subtest: single-wait-signaled
[425.655965] Subtest single-wait-signaled: SUCCESS (0.001s)
[425.812389] [081/132] (645s left) i915_pm_rps (fence-order)
[425.950848] Starting subtest: fence-order
[428.347908] Subtest fence-order: SUCCESS (2.396s)
[428.519474] [082/132] (642s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[428.717063] Starting subtest: flip-vs-cursor-atomic-transitions
[443.408545] Subtest flip-vs-cursor-atomic-transitions: FAIL (13.675s)
[443.519943] [083/132] (627s left) perf_pmu (busy-start)
[443.646197] Starting subtest: busy-start
[443.650343] Starting dynamic subtest: rcs0
[446.164538] Dynamic subtest rcs0: SUCCESS (2.520s)
[446.201896] Starting dynamic subtest: bcs0
[448.692695] Dynamic subtest bcs0: SUCCESS (2.522s)
[448.723897] Starting dynamic subtest: vcs0
[451.215926] Dynamic subtest vcs0: SUCCESS (2.521s)
[451.247539] Starting dynamic subtest: vecs0
[453.739660] Dynamic subtest vecs0: SUCCESS (2.519s)
[453.744082] Subtest busy-start: SUCCESS (10.096s)
[453.904796] [084/132] (617s left) kms_frontbuffer_tracking (psr-1p-rte)
[454.119607] Starting subtest: psr-1p-rte
[454.128079] Subtest psr-1p-rte: SKIP (0.000s)
[454.288207] [085/132] (617s left) kms_invalid_mode (int-max-clock)
[454.510385] Starting subtest: int-max-clock
[454.516890] Starting dynamic subtest: pipe-A-HDMI-A-1
[454.940711] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.421s)
[454.986814] Starting dynamic subtest: pipe-A-HDMI-A-2
[454.991654] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.003s)
[455.029019] Starting dynamic subtest: pipe-B-HDMI-A-1
[455.036280] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.004s)
[455.094457] Starting dynamic subtest: pipe-B-HDMI-A-2
[455.101400] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.003s)
[455.154985] Starting dynamic subtest: pipe-C-HDMI-A-1
[455.160119] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.003s)
[455.196963] Starting dynamic subtest: pipe-C-HDMI-A-2
[455.200182] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.003s)
[455.203441] Subtest int-max-clock: SUCCESS (0.488s)
[455.373054] [086/132] (616s left) kms_psr (fbc-psr-sprite-plane-onoff)
[455.571285] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.000s)
[455.704920] [087/132] (616s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[455.819745] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[455.926065] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.106s)
[456.092878] [088/132] (615s left) prime_busy (hang-wait)
[456.216506] Starting subtest: hang-wait
[456.220264] Starting dynamic subtest: rcs0
[462.824386] Dynamic subtest rcs0: SUCCESS (6.598s)
[462.855860] Starting dynamic subtest: bcs0
[469.862360] Dynamic subtest bcs0: SUCCESS (7.035s)
[469.893852] Starting dynamic subtest: vcs0
[476.838163] Dynamic subtest vcs0: SUCCESS (6.969s)
[476.868160] Starting dynamic subtest: vecs0
[483.814849] Dynamic subtest vecs0: SUCCESS (6.972s)
[483.819171] Subtest hang-wait: SUCCESS (27.593s)
[483.976285] [089/132] (587s left) i915_drm_fdinfo (memory-info-idle)
[484.091814] Starting subtest: memory-info-idle
[484.095494] Starting dynamic subtest: smem0
[484.126503] Dynamic subtest smem0: SUCCESS (0.031s)
[484.131368] Subtest memory-info-idle: SUCCESS (0.035s)
[484.290272] [090/132] (587s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[484.506068] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[487.080528] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SUCCESS (2.583s)
[487.307302] [091/132] (584s left) gem_mmap_gtt (cpuset-big-copy-odd)
[487.424428] Starting subtest: cpuset-big-copy-odd
[505.573424] Subtest cpuset-big-copy-odd: SUCCESS (18.149s)
[505.965048] [092/132] (566s left) gem_exec_params (readonly)
[507.488595] Starting subtest: readonly
[507.492125] Subtest readonly: SUCCESS (0.003s)
[507.658409] [093/132] (564s left) gem_render_copy (yf-tiled-to-vebox-linear)
[507.789265] Starting subtest: yf-tiled-to-vebox-linear
[507.797655] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[508.058294] [094/132] (564s left) syncobj_wait (wait-all-complex)
[508.198003] Starting subtest: wait-all-complex
[508.418665] Subtest wait-all-complex: SUCCESS (0.224s)
[508.605511] [095/132] (564s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[508.732161] Starting subtest: basic-wc-gtt-noreloc
[508.742228] Subtest basic-wc-gtt-noreloc: SUCCESS (0.009s)
[508.994815] [096/132] (563s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[509.193761] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[555.861446] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (46.668s)
[556.232120] [097/132] (516s left) kms_addfb_basic (invalid-get-prop-any)
[556.345083] Starting subtest: invalid-get-prop-any
[556.349045] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[556.591097] [098/132] (516s left) kms_rmfb (close-fd)
[556.807824] Starting subtest: close-fd
[556.813827] Starting dynamic subtest: pipe-A-HDMI-A-1
[557.154439] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.357s)
[557.214740] Starting dynamic subtest: pipe-B-HDMI-A-2
[557.583955] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.427s)
[557.639935] Starting dynamic subtest: pipe-C-HDMI-A-1
[558.003889] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.409s)
[558.008056] Subtest close-fd: SUCCESS (1.214s)
[558.582879] [099/132] (514s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[559.161686] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[559.541886] [100/132] (513s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[559.745731] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[559.869216] [101/132] (513s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[560.072430] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.000s)
[560.201501] [102/132] (513s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[560.318790] Starting subtest: single-wait-all-for-submit-available-submitted
[560.323072] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.002s)
[560.488627] [103/132] (513s left) api_intel_allocator (open-vm)
[560.603787] Starting subtest: open-vm
[560.607480] Subtest open-vm: SUCCESS (0.005s)
[560.770645] [104/132] (513s left) gem_mmap_gtt (basic-read-write-distinct)
[560.891253] Starting subtest: basic-read-write-distinct
[560.897614] Subtest basic-read-write-distinct: SUCCESS (0.013s)
[561.054304] [105/132] (512s left) gem_mmap_gtt (pf-nonblock)
[561.170306] Starting subtest: pf-nonblock
[561.174462] Subtest pf-nonblock: SUCCESS (0.006s)
[561.338286] [106/132] (512s left) kms_cursor_crc (cursor-onscreen-max-size)
[561.557420] Starting subtest: cursor-onscreen-max-size
[561.567518] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[561.723377] [107/132] (512s left) gem_exec_reloc (basic-cpu-noreloc)
[561.841832] Starting subtest: basic-cpu-noreloc
[561.851620] Subtest basic-cpu-noreloc: SUCCESS (0.009s)
[562.108162] [108/132] (512s left) gem_lmem_swapping (massive)
[562.233284] Subtest massive: SKIP (0.000s)
[562.362016] [109/132] (511s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[562.578130] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[564.344640] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.766s)
[564.644620] [110/132] (509s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[564.846136] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[564.853325] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[565.009108] [111/132] (509s left) gem_exec_balancer (waits)
[565.146828] Starting subtest: waits
[569.521976] Subtest waits: SUCCESS (4.374s)
[569.823518] [112/132] (504s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[570.013309] Starting subtest: plane-use-after-nonblocking-unbind
[570.016747] Starting dynamic subtest: pipe-A-HDMI-A-1
[570.444264] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.432s)
[570.726372] Starting dynamic subtest: pipe-A-HDMI-A-2
[571.093083] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.430s)
[571.379480] Starting dynamic subtest: pipe-B-HDMI-A-1
[571.743498] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.418s)
[572.019046] Starting dynamic subtest: pipe-B-HDMI-A-2
[572.378236] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.422s)
[572.575133] Subtest plane-use-after-nonblocking-unbind: SUCCESS (2.566s)
[572.883107] [113/132] (501s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[573.008051] Starting subtest: etime-multi-wait-all-submitted-signaled
[573.118193] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.112s)
[573.315119] [114/132] (501s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[573.539987] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[573.546661] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[573.719249] [115/132] (501s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[573.946753] Starting subtest: fbcpsr-tiling-4
[573.953038] Subtest fbcpsr-tiling-4: SKIP (0.000s)
[574.118071] [116/132] (501s left) gem_linear_blits (interruptible)
[574.452174] Starting subtest: interruptible
[589.951098] Subtest interruptible: SUCCESS (15.502s)
[590.124737] [117/132] (485s left) i915_suspend (debugfs-reader)
[590.380773] Starting subtest: debugfs-reader