[90.254939] Initializing watchdogs
[90.255289]   /dev/watchdog0
[90.295372] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[90.309963] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[90.316982] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[90.325200] [001/133] (960s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[90.557332] Starting subtest: psr-rgb565-draw-mmap-wc
[90.564364] Subtest psr-rgb565-draw-mmap-wc: SKIP (0.000s)
[90.704319] [002/133] (960s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[90.934099] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[92.865208] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.933s)
[93.152969] [003/133] (957s left) gem_exec_suspend (basic-s3-devices)
[93.291966] Starting subtest: basic-S3-devices
[93.296421] Starting dynamic subtest: smem
[102.958423] Dynamic subtest smem: SUCCESS (9.668s)
[102.962808] Subtest basic-S3-devices: SUCCESS (9.669s)
[113.232167] [004/133] (947s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[113.427087] Starting subtest: plane-ctm3x4-lut1d
[115.038628] Subtest plane-ctm3x4-lut1d: SKIP (1.606s)
[115.362995] [005/133] (945s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[115.574030] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[115.582670] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[115.711925] [006/133] (945s left) gem_softpin (evict-single-offset)
[115.832110] Starting subtest: evict-single-offset
[149.975929] Subtest evict-single-offset: SUCCESS (34.148s)
[150.146478] [007/133] (911s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[150.503450] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[150.510121] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[150.644077] [008/133] (910s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[150.834066] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[151.017908] [009/133] (910s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[151.234906] Starting subtest: cursor-rapid-movement-512x170
[151.242047] Subtest cursor-rapid-movement-512x170: SKIP (0.003s)
[151.393433] [010/133] (910s left) gem_busy (busy)
[151.531035] Starting subtest: busy
[151.535110] Starting dynamic subtest: all-engines
[151.610057] Dynamic subtest all-engines: SUCCESS (0.080s)
[151.638804] Starting dynamic subtest: rcs0
[151.642947] Dynamic subtest rcs0: SUCCESS (0.014s)
[151.665378] Starting dynamic subtest: bcs0
[151.669511] Dynamic subtest bcs0: SUCCESS (0.013s)
[151.691277] Starting dynamic subtest: vcs0
[151.695242] Dynamic subtest vcs0: SUCCESS (0.014s)
[151.717515] Starting dynamic subtest: vecs0
[151.721514] Dynamic subtest vecs0: SUCCESS (0.013s)
[151.725511] Subtest busy: SUCCESS (0.140s)
[152.057701] [011/133] (909s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[152.244453] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[152.253955] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[152.404458] [012/133] (909s left) gen3_render_tiledx_blits
[152.627621] [013/133] (909s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[152.840871] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[152.851856] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[152.976763] [014/133] (909s left) api_intel_allocator (reserve-simple)
[153.090834] Starting subtest: reserve-simple
[153.094205] Subtest reserve-simple: SUCCESS (0.004s)
[153.254184] [015/133] (908s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[153.465671] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[153.473256] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[153.607273] [016/133] (908s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[153.730305] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[153.738531] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[153.981699] [017/133] (908s left) gem_sync (basic-all)
[154.130090] Starting subtest: basic-all
[156.460227] Subtest basic-all: SUCCESS (2.349s)
[156.707840] [018/133] (905s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[156.924064] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[159.518621] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SUCCESS (2.605s)
[159.740610] [019/133] (902s left) gem_eio (create)
[159.879073] Starting subtest: create
[159.940112] Subtest create: SUCCESS (0.058s)
[160.157757] [020/133] (902s left) kms_psr (fbc-pr-cursor-plane-onoff)
[160.364049] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[160.467537] [021/133] (902s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[160.664863] Starting subtest: primary-yf-tiled-reflect-x-180
[160.671388] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.004s)
[160.807815] [022/133] (902s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[161.001686] Starting subtest: basic-busy-flip-before-cursor-varying-size
[161.008503] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[161.141473] [023/133] (901s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[161.333973] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[161.338143] Starting dynamic subtest: pipe-A-HDMI-A-1
[161.376075] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s)
[161.417057] Starting dynamic subtest: pipe-A-HDMI-A-2
[161.451360] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.002s)
[161.482873] Starting dynamic subtest: pipe-B-HDMI-A-1
[161.514974] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s)
[161.538662] Starting dynamic subtest: pipe-B-HDMI-A-2
[161.571260] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.002s)
[161.593231] Starting dynamic subtest: pipe-C-HDMI-A-1
[161.624640] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[161.648523] Starting dynamic subtest: pipe-C-HDMI-A-2
[161.680064] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.002s)
[161.686554] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.028s)
[162.354701] [024/133] (900s left) syncobj_basic (bad-create-flags)
[162.464219] Starting subtest: bad-create-flags
[162.467611] Subtest bad-create-flags: SUCCESS (0.000s)
[162.616676] [025/133] (900s left) kms_cursor_legacy (single-move)
[162.808057] Starting subtest: single-move
[162.813046] Starting dynamic subtest: pipe-A
[168.225247] Dynamic subtest pipe-A: SUCCESS (5.411s)
[168.247524] Starting dynamic subtest: pipe-B
[173.621308] Dynamic subtest pipe-B: SUCCESS (5.399s)
[173.649077] Starting dynamic subtest: pipe-C
[179.019260] Dynamic subtest pipe-C: SUCCESS (5.397s)
[179.103968] Starting dynamic subtest: all-pipes
[184.413790] Dynamic subtest all-pipes: SUCCESS (5.398s)
[184.420212] Subtest single-move: SUCCESS (21.608s)
[184.572181] [026/133] (878s left) kms_plane_scaling (intel-max-src-size)
[184.761613] Starting subtest: intel-max-src-size
[184.790913] Starting dynamic subtest: pipe-A-HDMI-A-1
[184.867313] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.078s)
[184.927310] Starting dynamic subtest: pipe-A-HDMI-A-2
[184.982932] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.088s)
[184.988063] Subtest intel-max-src-size: SUCCESS (0.220s)
[185.155418] [027/133] (878s left) syncobj_wait (invalid-signal-illegal-handle)
[185.280100] Starting subtest: invalid-signal-illegal-handle
[185.284679] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[185.422980] [028/133] (878s left) gem_exec_gttfill (engines)
[185.554660] Starting subtest: engines
[185.563147] Starting dynamic subtest: rcs0
[213.432055] Dynamic subtest rcs0: SUCCESS (27.877s)
[213.457360] Starting dynamic subtest: bcs0
[243.600047] Dynamic subtest bcs0: SUCCESS (30.165s)
[243.627309] Starting dynamic subtest: vcs0
[270.972768] Dynamic subtest vcs0: SUCCESS (27.369s)
[271.014293] Starting dynamic subtest: vecs0
[298.250559] Dynamic subtest vecs0: SUCCESS (27.283s)
[298.255291] Subtest engines: SUCCESS (112.697s)
[298.529736] [029/133] (765s left) kms_addfb_basic (small-bo)
[298.867972] Starting subtest: small-bo
[298.872428] Subtest small-bo: SUCCESS (0.000s)
[299.025533] [030/133] (764s left) gem_tiled_fence_blits (basic)
[299.257784] Starting subtest: basic
[299.289649] Subtest basic: SUCCESS (0.034s)
[299.485196] [031/133] (764s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[299.863425] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[299.869440] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[300.004345] [032/133] (763s left) kms_chamelium_hpd (common-hpd-after-suspend)
[300.588086] Subtest common-hpd-after-suspend: SKIP (0.000s)
[300.888705] [033/133] (763s left) gem_exec_params (invalid-bsd1-flag-on-render)
[301.037843] Starting subtest: invalid-bsd1-flag-on-render
[301.043460] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.001s)
[301.199436] [034/133] (762s left) gem_create (create-clear)
[301.317585] Starting subtest: create-clear
[301.322583] Starting dynamic subtest: smem0
[333.859103] Dynamic subtest smem0: SUCCESS (32.537s)
[333.864377] Subtest create-clear: SUCCESS (32.538s)
[334.103320] [035/133] (730s left) sysfs_timeslice_duration (duration)
[334.219062] Starting subtest: duration
[334.223296] Starting dynamic subtest: vecs0
[334.306046] Dynamic subtest vecs0: SUCCESS (0.084s)
[334.332494] Starting dynamic subtest: vcs0
[334.384308] Dynamic subtest vcs0: SUCCESS (0.076s)
[334.411670] Starting dynamic subtest: bcs0
[334.476501] Dynamic subtest bcs0: SUCCESS (0.088s)
[334.505096] Starting dynamic subtest: rcs0
[334.561213] Dynamic subtest rcs0: SUCCESS (0.082s)
[334.565412] Subtest duration: SUCCESS (0.343s)
[334.701852] [036/133] (729s left) kms_psr (psr2-primary-render)
[334.893073] Subtest psr2-primary-render: SKIP (0.000s)
[334.998383] [037/133] (729s left) gem_mmap_wc (write-read)
[335.116533] Starting subtest: write-read
[335.120389] Subtest write-read: SUCCESS (0.010s)
[335.268922] [038/133] (729s left) gem_mmap_offset (mmap-boundaries)
[335.379308] Starting subtest: mmap-boundaries
[335.384316] Starting dynamic subtest: smem0
[336.268704] Dynamic subtest smem0: SUCCESS (0.892s)
[336.275854] Subtest mmap-boundaries: SUCCESS (0.892s)
[336.434369] [039/133] (728s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[336.637367] Starting subtest: 4-tiled-32bpp-rotate-270
[336.643650] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.000s)
[336.787389] [040/133] (727s left) kms_atomic (plane-cursor-legacy)
[336.971123] Starting subtest: plane-cursor-legacy
[336.975146] Starting dynamic subtest: pipe-A-HDMI-A-1
[337.567588] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.591s)
[337.572315] Subtest plane-cursor-legacy: SUCCESS (0.595s)
[337.862515] [041/133] (726s left) kms_chamelium_color (ctm-green-to-red)
[338.063092] Subtest ctm-green-to-red: SKIP (0.000s)
[338.168875] [042/133] (726s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[338.357347] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[338.361218] Starting dynamic subtest: pipe-A-valid-mode
[339.294406] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.935s)
[339.298517] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SUCCESS (0.938s)
[339.601285] [043/133] (725s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier)
[339.786183] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier
[339.794194] Subtest pixel-format-4-tiled-lnl-ccs-modifier: SKIP (0.000s)
[339.933517] [044/133] (725s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[340.126136] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[340.131069] Starting dynamic subtest: pipe-A-HDMI-A-1
[340.178147] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[340.222471] Starting dynamic subtest: pipe-A-HDMI-A-2
[340.272374] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s)
[340.298596] Starting dynamic subtest: pipe-B-HDMI-A-1
[340.331890] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[340.357051] Starting dynamic subtest: pipe-B-HDMI-A-2
[340.389652] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s)
[340.413436] Starting dynamic subtest: pipe-C-HDMI-A-1
[340.444835] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[340.471506] Starting dynamic subtest: pipe-C-HDMI-A-2
[340.503526] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[340.509812] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.021s)
[341.591272] [045/133] (723s left) gem_exec_schedule (out-order)
[342.467344] Starting subtest: out-order
[342.471567] Starting dynamic subtest: rcs0
[342.587623] Dynamic subtest rcs0: SUCCESS (0.119s)
[342.619347] Starting dynamic subtest: bcs0
[342.707250] Dynamic subtest bcs0: SUCCESS (0.126s)
[342.739794] Starting dynamic subtest: vcs0
[342.837708] Dynamic subtest vcs0: SUCCESS (0.118s)
[342.869677] Starting dynamic subtest: vecs0
[342.945840] Dynamic subtest vecs0: SUCCESS (0.115s)
[342.949482] Subtest out-order: SUCCESS (0.486s)
[343.337620] [046/133] (722s left) syncobj_wait (wait-any-interrupted)
[343.447325] Starting subtest: wait-any-interrupted
[343.549050] Subtest wait-any-interrupted: SUCCESS (0.104s)
[343.687438] [047/133] (722s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[343.872118] Starting subtest: 2x-long-flip-vs-cursor-legacy
[349.452996] Subtest 2x-long-flip-vs-cursor-legacy: SUCCESS (5.581s)
[349.797771] [048/133] (716s left) kms_chamelium_color (degamma)
[350.008470] Subtest degamma: SKIP (0.000s)
[350.117036] [049/133] (715s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[350.227481] Starting subtest: single-wait-all-for-submit-unsubmitted
[350.331303] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[350.478342] [050/133] (715s left) gem_exec_gttfill (basic)
[350.614345] Starting subtest: basic
[360.487321] Subtest basic: SUCCESS (9.878s)
[360.767450] [051/133] (705s left) gen9_exec_parse (bb-secure)
[361.039139] Starting subtest: bb-secure
[361.043269] Subtest bb-secure: SUCCESS (0.003s)
[361.325469] [052/133] (704s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[361.538257] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[408.095187] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (46.560s)
[408.411292] [053/133] (657s left) gem_pxp (reject-modify-context-protection-off-2)
[411.071983] Starting subtest: reject-modify-context-protection-off-2
[411.081084] Subtest reject-modify-context-protection-off-2: SKIP (0.000s)
[411.208205] [054/133] (655s left) kms_invalid_mode (zero-clock)
[411.397549] Starting subtest: zero-clock
[411.403337] Starting dynamic subtest: pipe-A-HDMI-A-1
[411.794501] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.405s)
[411.851357] Starting dynamic subtest: pipe-A-HDMI-A-2
[411.859421] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.002s)
[411.908577] Starting dynamic subtest: pipe-B-HDMI-A-1
[411.917403] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.004s)
[411.971201] Starting dynamic subtest: pipe-B-HDMI-A-2
[411.975333] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.003s)
[412.000646] Starting dynamic subtest: pipe-C-HDMI-A-1
[412.007329] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.004s)
[412.038141] Starting dynamic subtest: pipe-C-HDMI-A-2
[412.042347] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.002s)
[412.045622] Subtest zero-clock: SUCCESS (0.458s)
[412.155859] [055/133] (654s left) gem_ctx_isolation (preservation-s3)
[412.289224] Starting subtest: preservation-S3
[412.293956] Starting dynamic subtest: rcs0
[428.828172] Dynamic subtest rcs0: SUCCESS (1.594s)
[428.905101] Starting dynamic subtest: bcs0