[88.203880] Initializing watchdogs
[88.204107]   /dev/watchdog0
[88.242977] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[88.258149] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[88.266457] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[88.272269] [001/133] (960s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[88.491406] Starting subtest: psr-rgb565-draw-mmap-wc
[88.497155] Subtest psr-rgb565-draw-mmap-wc: SKIP (0.000s)
[88.639734] [002/133] (960s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[88.855102] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[90.648477] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.792s)
[90.946408] [003/133] (958s left) gem_exec_suspend (basic-s3-devices)
[91.082428] Starting subtest: basic-S3-devices
[91.084091] Starting dynamic subtest: smem
[100.894678] Dynamic subtest smem: SUCCESS (9.809s)
[100.896027] Subtest basic-S3-devices: SUCCESS (9.810s)
[108.172263] [004/133] (947s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[108.358342] Starting subtest: plane-ctm3x4-lut1d
[110.031991] Subtest plane-ctm3x4-lut1d: SKIP (1.680s)
[110.326340] [005/133] (945s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[110.540133] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[110.543323] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[110.677413] [006/133] (945s left) gem_softpin (evict-single-offset)
[110.792672] Starting subtest: evict-single-offset
[145.737804] Subtest evict-single-offset: SUCCESS (34.935s)
[145.871997] [007/133] (910s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[146.223138] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[146.225559] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[146.367481] [008/133] (910s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[146.553201] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[146.656778] [009/133] (909s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[146.867136] Starting subtest: cursor-rapid-movement-512x170
[146.872664] Subtest cursor-rapid-movement-512x170: SKIP (0.004s)
[147.014495] [010/133] (909s left) gem_busy (busy)
[147.150109] Starting subtest: busy
[147.154127] Starting dynamic subtest: all-engines
[147.221823] Dynamic subtest all-engines: SUCCESS (0.072s)
[147.255134] Starting dynamic subtest: rcs0
[147.257244] Dynamic subtest rcs0: SUCCESS (0.012s)
[147.280273] Starting dynamic subtest: bcs0
[147.281609] Dynamic subtest bcs0: SUCCESS (0.010s)
[147.300714] Starting dynamic subtest: vcs0
[147.302149] Dynamic subtest vcs0: SUCCESS (0.016s)
[147.322036] Starting dynamic subtest: vecs0
[147.323993] Dynamic subtest vecs0: SUCCESS (0.007s)
[147.326212] Subtest busy: SUCCESS (0.123s)
[147.666886] [011/133] (908s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[147.850159] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[147.853544] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[147.981521] [012/133] (908s left) gen3_render_tiledx_blits
[148.172164] [013/133] (908s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[148.373130] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[148.377656] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[148.569761] [014/133] (908s left) api_intel_allocator (reserve-simple)
[148.677564] Starting subtest: reserve-simple
[148.680411] Subtest reserve-simple: SUCCESS (0.006s)
[148.833187] [015/133] (908s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[149.031107] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[149.034318] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[149.165502] [016/133] (907s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[149.286058] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[149.288409] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[149.532154] [017/133] (907s left) gem_sync (basic-all)
[149.666220] Starting subtest: basic-all
[151.972602] Subtest basic-all: SUCCESS (2.309s)
[152.219076] [018/133] (905s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[152.403979] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[155.002179] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SUCCESS (2.593s)
[155.218172] [019/133] (902s left) gem_eio (create)
[155.343028] Starting subtest: create
[155.387287] Subtest create: SUCCESS (0.041s)
[155.632934] [020/133] (901s left) kms_psr (fbc-pr-cursor-plane-onoff)
[155.809721] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[155.906764] [021/133] (901s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[156.089115] Starting subtest: primary-yf-tiled-reflect-x-180
[156.093977] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.004s)
[156.213437] [022/133] (901s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[156.391308] Starting subtest: basic-busy-flip-before-cursor-varying-size
[156.401332] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[156.516371] [023/133] (901s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[156.700221] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[156.701395] Starting dynamic subtest: pipe-A-HDMI-A-1
[156.723050] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.003s)
[156.767224] Starting dynamic subtest: pipe-A-HDMI-A-2
[156.818403] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.004s)
[156.859524] Starting dynamic subtest: pipe-B-HDMI-A-1
[156.877277] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.003s)
[156.901446] Starting dynamic subtest: pipe-B-HDMI-A-2
[156.916264] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.003s)
[156.935873] Starting dynamic subtest: pipe-C-HDMI-A-1
[156.947663] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.003s)
[156.968571] Starting dynamic subtest: pipe-C-HDMI-A-2
[156.979931] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.005s)
[156.982229] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.040s)
[157.736809] [024/133] (900s left) syncobj_basic (bad-create-flags)
[157.834485] Starting subtest: bad-create-flags
[157.836916] Subtest bad-create-flags: SUCCESS (0.000s)
[157.971481] [025/133] (899s left) kms_cursor_legacy (single-move)
[158.158349] Starting subtest: single-move
[158.161100] Starting dynamic subtest: pipe-A
[163.583118] Dynamic subtest pipe-A: SUCCESS (5.417s)
[163.603957] Starting dynamic subtest: pipe-B
[168.990119] Dynamic subtest pipe-B: SUCCESS (5.411s)
[169.079928] Starting dynamic subtest: pipe-C
[174.393046] Dynamic subtest pipe-C: SUCCESS (5.397s)
[174.482678] Starting dynamic subtest: all-pipes
[179.790044] Dynamic subtest all-pipes: SUCCESS (5.400s)
[179.791401] Subtest single-move: SUCCESS (21.628s)
[179.942237] [026/133] (877s left) kms_plane_scaling (intel-max-src-size)
[180.133820] Starting subtest: intel-max-src-size
[180.157060] Starting dynamic subtest: pipe-A-HDMI-A-1
[180.238233] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.077s)
[180.314520] Starting dynamic subtest: pipe-A-HDMI-A-2
[180.395084] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.123s)
[180.397318] Subtest intel-max-src-size: SUCCESS (0.264s)
[180.571617] [027/133] (877s left) syncobj_wait (invalid-signal-illegal-handle)
[180.682269] Starting subtest: invalid-signal-illegal-handle
[180.684578] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[180.823262] [028/133] (877s left) gem_exec_gttfill (engines)
[180.952824] Starting subtest: engines
[180.954214] Starting dynamic subtest: rcs0
[207.858932] Dynamic subtest rcs0: SUCCESS (26.897s)
[207.883099] Starting dynamic subtest: bcs0
[237.515278] Dynamic subtest bcs0: SUCCESS (29.655s)
[237.539056] Starting dynamic subtest: vcs0
[264.950115] Dynamic subtest vcs0: SUCCESS (27.429s)
[264.975255] Starting dynamic subtest: vecs0
[292.640910] Dynamic subtest vecs0: SUCCESS (27.691s)
[292.642230] Subtest engines: SUCCESS (111.677s)
[292.893974] [029/133] (765s left) kms_addfb_basic (small-bo)
[293.241662] Starting subtest: small-bo
[293.244096] Subtest small-bo: SUCCESS (0.001s)
[293.386750] [030/133] (764s left) gem_tiled_fence_blits (basic)
[293.620689] Starting subtest: basic
[293.651284] Subtest basic: SUCCESS (0.032s)
[293.838945] [031/133] (764s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[294.212545] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[294.216530] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[294.355668] [032/133] (764s left) kms_chamelium_hpd (common-hpd-after-suspend)
[294.963672] Subtest common-hpd-after-suspend: SKIP (0.000s)
[295.284731] [033/133] (763s left) gem_exec_params (invalid-bsd1-flag-on-render)
[295.402253] Starting subtest: invalid-bsd1-flag-on-render
[295.403625] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.001s)
[295.554257] [034/133] (763s left) gem_create (create-clear)
[295.659154] Starting subtest: create-clear
[295.665078] Starting dynamic subtest: smem0
[328.157054] Dynamic subtest smem0: SUCCESS (32.485s)
[328.159342] Subtest create-clear: SUCCESS (32.486s)
[328.409569] [035/133] (730s left) sysfs_timeslice_duration (duration)
[328.521119] Starting subtest: duration
[328.523144] Starting dynamic subtest: vecs0
[328.603384] Dynamic subtest vecs0: SUCCESS (0.079s)
[328.636195] Starting dynamic subtest: vcs0
[328.685238] Dynamic subtest vcs0: SUCCESS (0.079s)
[328.713418] Starting dynamic subtest: bcs0
[328.778225] Dynamic subtest bcs0: SUCCESS (0.088s)
[328.804521] Starting dynamic subtest: rcs0
[328.855139] Dynamic subtest rcs0: SUCCESS (0.076s)
[328.857737] Subtest duration: SUCCESS (0.334s)
[328.992751] [036/133] (729s left) kms_psr (psr2-primary-render)
[329.175027] Subtest psr2-primary-render: SKIP (0.000s)
[329.276739] [037/133] (729s left) gem_mmap_wc (write-read)
[329.379170] Starting subtest: write-read
[329.387063] Subtest write-read: SUCCESS (0.011s)
[329.541579] [038/133] (729s left) gem_mmap_offset (mmap-boundaries)
[329.646071] Starting subtest: mmap-boundaries
[329.651078] Starting dynamic subtest: smem0
[330.542082] Dynamic subtest smem0: SUCCESS (0.891s)
[330.545240] Subtest mmap-boundaries: SUCCESS (0.892s)
[330.725625] [039/133] (728s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[330.924963] Starting subtest: 4-tiled-32bpp-rotate-270
[330.928599] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.000s)
[331.059511] [040/133] (728s left) kms_atomic (plane-cursor-legacy)
[331.236071] Starting subtest: plane-cursor-legacy
[331.238055] Starting dynamic subtest: pipe-A-HDMI-A-1
[331.807889] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.570s)
[331.809329] Subtest plane-cursor-legacy: SUCCESS (0.575s)
[332.120935] [041/133] (727s left) kms_chamelium_color (ctm-green-to-red)
[332.307089] Subtest ctm-green-to-red: SKIP (0.000s)
[332.409758] [042/133] (726s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[332.594910] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[332.598462] Starting dynamic subtest: pipe-A-valid-mode
[333.640600] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.043s)
[333.643243] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SUCCESS (1.047s)
[333.970905] [043/133] (725s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier)
[334.150601] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier
[334.154207] Subtest pixel-format-4-tiled-lnl-ccs-modifier: SKIP (0.000s)
[334.295979] [044/133] (725s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[334.479170] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[334.481087] Starting dynamic subtest: pipe-A-HDMI-A-1
[334.499195] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[334.546538] Starting dynamic subtest: pipe-A-HDMI-A-2
[334.576566] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s)
[334.617200] Starting dynamic subtest: pipe-B-HDMI-A-1
[334.647352] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[334.689590] Starting dynamic subtest: pipe-B-HDMI-A-2
[334.701332] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[334.724296] Starting dynamic subtest: pipe-C-HDMI-A-1
[334.737452] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[334.760111] Starting dynamic subtest: pipe-C-HDMI-A-2
[334.771785] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.002s)
[334.774208] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.029s)
[335.538211] [045/133] (724s left) gem_exec_schedule (out-order)
[335.687216] Starting subtest: out-order
[335.688413] Starting dynamic subtest: rcs0
[335.809149] Dynamic subtest rcs0: SUCCESS (0.116s)
[335.844273] Starting dynamic subtest: bcs0
[335.938184] Dynamic subtest bcs0: SUCCESS (0.129s)
[335.970243] Starting dynamic subtest: vcs0
[336.072454] Dynamic subtest vcs0: SUCCESS (0.136s)
[336.104167] Starting dynamic subtest: vecs0
[336.200402] Dynamic subtest vecs0: SUCCESS (0.124s)
[336.202176] Subtest out-order: SUCCESS (0.515s)
[336.594880] [046/133] (723s left) syncobj_wait (wait-any-interrupted)
[336.695545] Starting subtest: wait-any-interrupted
[336.804172] Subtest wait-any-interrupted: SUCCESS (0.106s)
[336.943149] [047/133] (722s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[337.123062] Starting subtest: 2x-long-flip-vs-cursor-legacy
[342.782367] Subtest 2x-long-flip-vs-cursor-legacy: SUCCESS (5.659s)
[343.152077] [048/133] (716s left) kms_chamelium_color (degamma)
[343.342082] Subtest degamma: SKIP (0.000s)
[343.439951] [049/133] (716s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[343.544218] Starting subtest: single-wait-all-for-submit-unsubmitted
[343.653686] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.106s)
[343.779140] [050/133] (716s left) gem_exec_gttfill (basic)
[343.905659] Starting subtest: basic
[353.837872] Subtest basic: SUCCESS (9.931s)
[354.088106] [051/133] (706s left) gen9_exec_parse (bb-secure)
[354.359882] Starting subtest: bb-secure
[354.366277] Subtest bb-secure: SUCCESS (0.004s)
[354.635411] [052/133] (705s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[354.827158] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[401.634233] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (46.806s)
[401.984877] [053/133] (658s left) gem_pxp (reject-modify-context-protection-off-2)
[404.637891] Starting subtest: reject-modify-context-protection-off-2
[404.640464] Subtest reject-modify-context-protection-off-2: SKIP (0.000s)
[404.771664] [054/133] (655s left) kms_invalid_mode (zero-clock)
[404.966281] Starting subtest: zero-clock
[404.969435] Starting dynamic subtest: pipe-A-HDMI-A-1
[405.428068] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.460s)
[405.471618] Starting dynamic subtest: pipe-A-HDMI-A-2
[405.474120] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.002s)
[405.517646] Starting dynamic subtest: pipe-B-HDMI-A-1
[405.519101] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.002s)
[405.563067] Starting dynamic subtest: pipe-B-HDMI-A-2
[405.565096] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.002s)
[405.598917] Starting dynamic subtest: pipe-C-HDMI-A-1
[405.600019] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.002s)
[405.622578] Starting dynamic subtest: pipe-C-HDMI-A-2
[405.623828] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.002s)
[405.625067] Subtest zero-clock: SUCCESS (0.494s)
[405.755886] [055/133] (654s left) gem_ctx_isolation (preservation-s3)
[405.881867] Starting subtest: preservation-S3
[405.889308] Starting dynamic subtest: rcs0
[422.811525] Dynamic subtest rcs0: SUCCESS (1.723s)
[422.854124] Starting dynamic subtest: bcs0