[90.263282] Initializing watchdogs
[90.263497]   /dev/watchdog0
[90.302492] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3184 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 605]
[90.316304] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[90.322502] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[90.328355] [001/133] (960s left) kms_chamelium_frames (dp-crc-single)
[90.898532] Subtest dp-crc-single: SKIP (0.000s)
[91.130279] [002/133] (959s left) kms_chamelium_frames (vga-frame-dump)
[91.657969] Subtest vga-frame-dump: SKIP (0.000s)
[91.876891] [003/133] (959s left) syncobj_wait (multi-wait-all-submitted-signaled)
[91.974118] Starting subtest: multi-wait-all-submitted-signaled
[92.082289] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.108s)
[92.199726] [004/133] (958s left) gem_exec_balancer (sequential)
[92.320853] Starting subtest: sequential
[96.465772] Subtest sequential: SUCCESS (4.144s)
[96.718937] [005/133] (954s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[96.834770] Starting subtest: x-tiled-to-vebox-y-tiled
[96.836957] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[97.066749] [006/133] (954s left) kms_color (invalid-gamma-lut-sizes)
[97.238672] Starting subtest: invalid-gamma-lut-sizes
[97.242639] Starting dynamic subtest: pipe-A
[97.594839] Dynamic subtest pipe-A: SUCCESS (0.363s)
[97.610709] Starting dynamic subtest: pipe-B
[97.611764] Dynamic subtest pipe-B: SUCCESS (0.001s)
[97.626976] Starting dynamic subtest: pipe-C
[97.628043] Dynamic subtest pipe-C: SUCCESS (0.001s)
[97.629025] Subtest invalid-gamma-lut-sizes: SUCCESS (0.367s)
[97.853554] [007/133] (953s left) gem_readwrite (read-bad-handle)
[97.949864] Starting subtest: read-bad-handle
[97.951946] Subtest read-bad-handle: SUCCESS (0.000s)
[98.089418] [008/133] (953s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping)
[98.256714] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping
[98.258535] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[98.369560] [009/133] (953s left) kms_vblank (invalid)
[98.536997] Starting subtest: invalid
[98.537914] Starting dynamic subtest: pipe-A-HDMI-A-1
[99.180311] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.643s)
[99.181329] Subtest invalid: SUCCESS (0.646s)
[99.444747] [010/133] (952s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[99.611277] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[99.614818] Starting dynamic subtest: pipe-A-HDMI-A-1
[99.618210] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[99.633248] Starting dynamic subtest: pipe-A-HDMI-A-2
[99.636689] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s)
[99.651559] Starting dynamic subtest: pipe-B-HDMI-A-1
[99.655023] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[99.670063] Starting dynamic subtest: pipe-B-HDMI-A-2
[99.673427] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[99.688310] Starting dynamic subtest: pipe-C-HDMI-A-1
[99.691632] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[99.706469] Starting dynamic subtest: pipe-C-HDMI-A-2
[99.709905] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[99.711593] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.017s)
[100.491544] [011/133] (951s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[100.670252] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[100.671974] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[100.807231] [012/133] (950s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[100.978762] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[101.066453] [013/133] (950s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[101.234539] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[101.236290] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[101.372079] [014/133] (950s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[101.551461] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[101.553305] Subtest psr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[101.691650] [015/133] (950s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[101.874150] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[101.876600] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[102.023582] [016/133] (949s left) sw_sync (sync_expired_merge)
[102.115608] Starting subtest: sync_expired_merge
[103.190257] Subtest sync_expired_merge: SUCCESS (1.074s)
[103.290781] [017/133] (948s left) gem_create (busy-create)
[103.396692] Starting subtest: busy-create
[103.397657] Starting dynamic subtest: smem0
[135.666214] Dynamic subtest smem0: SUCCESS (32.269s)
[135.667421] Subtest busy-create: SUCCESS (32.270s)
[135.895203] [018/133] (916s left) api_intel_bb (add-remove-objects)
[135.994858] Starting subtest: add-remove-objects
[136.006543] Subtest add-remove-objects: SUCCESS (0.016s)
[136.161135] [019/133] (916s left) syncobj_timeline (multi-wait-submitted-signaled)
[136.257519] Starting subtest: multi-wait-submitted-signaled
[136.260656] Subtest multi-wait-submitted-signaled: SUCCESS (0.003s)
[136.378618] [020/133] (915s left) gem_exec_create (basic)
[136.494064] Starting subtest: basic
[136.495160] Starting dynamic subtest: smem
[138.556923] Dynamic subtest smem: SUCCESS (2.062s)
[138.558105] Subtest basic: SUCCESS (2.064s)
[138.796510] [021/133] (913s left) gem_mmap_gtt (basic-small-copy)
[138.893459] Starting subtest: basic-small-copy
[141.548460] Subtest basic-small-copy: SUCCESS (2.654s)
[141.719543] [022/133] (910s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[142.020873] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[142.022704] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[142.174628] [023/133] (910s left) kms_vrr (seamless-rr-switch-drrs)
[142.346596] Starting subtest: seamless-rr-switch-drrs
[142.350215] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[142.460729] [024/133] (910s left) kms_psr2_su (frontbuffer-xrgb8888)
[142.551950] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[142.633696] [025/133] (910s left) perf_pmu (busy-idle)
[142.737246] Starting subtest: busy-idle
[142.738138] Starting dynamic subtest: rcs0
[143.378081] Dynamic subtest rcs0: SUCCESS (0.641s)
[143.395734] Starting dynamic subtest: bcs0
[144.014347] Dynamic subtest bcs0: SUCCESS (0.635s)
[144.032485] Starting dynamic subtest: vcs0
[144.653971] Dynamic subtest vcs0: SUCCESS (0.638s)
[144.672869] Starting dynamic subtest: vecs0
[145.291779] Dynamic subtest vecs0: SUCCESS (0.637s)
[145.293589] Subtest busy-idle: SUCCESS (2.555s)
[145.412167] [026/133] (907s left) gem_mmap_wc (bad-object)
[145.506306] Starting subtest: bad-object
[145.507302] Subtest bad-object: SUCCESS (0.000s)
[145.645933] [027/133] (907s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[145.815756] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[145.817835] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SKIP (0.000s)
[145.926298] [028/133] (906s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[146.102724] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[149.020636] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (2.916s)
[149.217201] [029/133] (903s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[149.384603] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[149.388015] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.000s)
[149.511764] [030/133] (903s left) kms_psr (psr2-cursor-blt)
[149.679588] Subtest psr2-cursor-blt: SKIP (0.000s)
[149.769237] [031/133] (903s left) kms_psr (fbc-psr-basic)
[149.933571] Subtest fbc-psr-basic: SKIP (0.000s)
[150.019573] [032/133] (903s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[150.757615] Starting subtest: syncobj-timeline-multiple-ext-nodes
[150.760541] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.003s)
[151.037826] [FACT gem_exec_fence (syncobj-timeline-multiple-ext-nodes)] new: kernel.kmod_is_loaded.vgem: true
[151.041541] [033/133] (902s left) i915_pm_rpm (system-suspend-execbuf)
[152.958000] Starting subtest: system-suspend-execbuf
[173.469081] Subtest system-suspend-execbuf: SUCCESS (6.436s)
[177.856277] [034/133] (879s left) gem_ccs (block-multicopy-compressed)
[177.970315] Subtest block-multicopy-compressed: SKIP (0.000s)
[178.077944] [035/133] (879s left) sw_sync (timeline_closed)
[178.173504] Starting subtest: timeline_closed
[178.175286] Subtest timeline_closed: SUCCESS (0.000s)
[178.303253] [036/133] (879s left) gem_exec_balancer (bonded-dual)
[178.417529] Starting subtest: bonded-dual
[182.561440] Subtest bonded-dual: SUCCESS (4.144s)
[182.821200] [037/133] (874s left) kms_addfb_basic (addfb25-bad-modifier)
[182.988829] Starting subtest: addfb25-bad-modifier
[182.989818] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[183.135136] [038/133] (874s left) kms_cursor_crc (cursor-sliding-128x128)
[183.315550] Starting subtest: cursor-sliding-128x128
[183.355051] Starting dynamic subtest: pipe-A-HDMI-A-1
[187.370660] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.007s)
[187.441724] Starting dynamic subtest: pipe-C-HDMI-A-1
[191.146108] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.721s)
[191.147480] Subtest cursor-sliding-128x128: SUCCESS (7.823s)
[191.449925] [039/133] (866s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[191.614958] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[191.615870] Starting dynamic subtest: pipe-A
[191.922419] Dynamic subtest pipe-A: SUCCESS (0.308s)
[191.945267] Starting dynamic subtest: pipe-B
[192.298655] Dynamic subtest pipe-B: SUCCESS (0.375s)
[192.320607] Starting dynamic subtest: pipe-C
[192.348930] Dynamic subtest pipe-C: SUCCESS (0.048s)
[192.350152] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (0.735s)
[192.779631] [040/133] (865s left) gem_exec_suspend (basic-s4-devices)
[192.892749] Starting subtest: basic-S4-devices
[192.893636] Starting dynamic subtest: smem
[203.281039] Dynamic subtest smem: SUCCESS (10.389s)
[203.282459] Subtest basic-S4-devices: SUCCESS (10.390s)
[210.568197] [041/133] (854s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[210.753540] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc
[210.755402] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[210.908777] [042/133] (854s left) kms_content_protection (dp-mst-type-1-suspend-resume)
[211.108231] Starting subtest: dp-mst-type-1-suspend-resume
[211.110058] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s)
[211.256698] [043/133] (853s left) dmabuf_sync_file (import-multiple-read-write)
[211.371886] Starting subtest: import-multiple-read-write
[211.384557] Subtest import-multiple-read-write: SUCCESS (0.014s)
[211.510052] [044/133] (853s left) gem_ctx_persistence (heartbeat-hostile)
[211.615621] Starting subtest: heartbeat-hostile
[212.812241] Subtest heartbeat-hostile: SUCCESS (1.197s)
[212.961665] [045/133] (852s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[213.146329] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[213.148033] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[213.307500] [046/133] (852s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[213.496431] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[213.498212] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[213.657454] [047/133] (851s left) i915_drm_fdinfo (most-busy-idle-check-all)
[213.763649] Starting subtest: most-busy-idle-check-all
[213.764745] Starting dynamic subtest: rcs0
[214.400439] Dynamic subtest rcs0: SUCCESS (0.636s)
[214.424909] Starting dynamic subtest: bcs0
[215.037161] Dynamic subtest bcs0: SUCCESS (0.634s)
[215.062156] Starting dynamic subtest: vcs0
[215.670483] Dynamic subtest vcs0: SUCCESS (0.632s)
[215.694601] Starting dynamic subtest: vecs0
[216.305545] Dynamic subtest vecs0: SUCCESS (0.633s)
[216.306977] Subtest most-busy-idle-check-all: SUCCESS (2.543s)
[216.442521] [048/133] (849s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[216.623832] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[216.625848] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[216.784059] [049/133] (848s left) gem_workarounds (suspend-resume-context)
[216.906860] Starting subtest: suspend-resume-context