[90.940812] Initializing watchdogs
[90.940994]   /dev/watchdog0
[90.981866] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[90.996641] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[91.003960] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[91.012308] [001/132] (960s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[91.226156] Starting subtest: primary-x-tiled-reflect-x-0
[91.235181] Subtest primary-x-tiled-reflect-x-0: SKIP (0.003s)
[91.380075] [002/132] (960s left) kms_frontbuffer_tracking (fbc-tiling-4)
[91.600893] Starting subtest: fbc-tiling-4
[91.607277] Subtest fbc-tiling-4: SKIP (0.000s)
[91.760497] [003/132] (959s left) kms_cursor_crc (cursor-onscreen-max-size)
[91.977939] Starting subtest: cursor-onscreen-max-size
[91.989463] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[92.114622] [004/132] (959s left) kms_pm_rpm (system-suspend-idle)
[94.080749] Starting subtest: system-suspend-idle
[110.897697] Subtest system-suspend-idle: SUCCESS (2.283s)
[124.375967] [005/132] (940s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[124.593754] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[124.601670] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[124.728331] [006/132] (940s left) gem_mmap_gtt (cpuset-basic-small-copy)
[124.839544] Starting subtest: cpuset-basic-small-copy
[129.330237] Subtest cpuset-basic-small-copy: SUCCESS (4.494s)
[129.468733] [007/132] (935s left) kms_psr (psr2-cursor-mmap-cpu)
[129.830969] Subtest psr2-cursor-mmap-cpu: SKIP (0.000s)
[129.953723] [008/132] (935s left) gem_softpin (evict-prime)
[130.139105] Starting subtest: evict-prime
[130.143350] Starting dynamic subtest: rcs0
[131.262307] Dynamic subtest rcs0: SUCCESS (1.128s)
[131.321838] Starting dynamic subtest: bcs0
[132.369859] Dynamic subtest bcs0: SUCCESS (1.105s)
[132.400648] Starting dynamic subtest: vcs0
[133.482719] Dynamic subtest vcs0: SUCCESS (1.111s)
[133.524589] Starting dynamic subtest: vecs0
[134.592713] Dynamic subtest vecs0: SUCCESS (1.108s)
[134.637675] Starting dynamic subtest: all
[135.699874] Dynamic subtest all: SUCCESS (1.105s)
[135.705902] Subtest evict-prime: SUCCESS (5.565s)
[135.843697] [009/132] (929s left) kms_psr (fbc-psr-primary-mmap-cpu)
[136.029702] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.000s)
[136.140255] [010/132] (929s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[136.273852] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[136.277482] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.002s)
[136.440761] [011/132] (929s left) gem_exec_params (cliprects_ptr-dirt)
[136.552218] Starting subtest: cliprects_ptr-dirt
[136.556046] Subtest cliprects_ptr-dirt: SUCCESS (0.001s)
[136.694554] [012/132] (928s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[136.884650] Starting subtest: bad-pixel-format-yf-tiled-ccs
[136.888531] Starting dynamic subtest: pipe-A-HDMI-A-1
[136.926680] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[136.968143] Starting dynamic subtest: pipe-A-HDMI-A-2
[137.005196] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.001s)
[137.038917] Starting dynamic subtest: pipe-B-HDMI-A-1
[137.067812] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[137.092098] Starting dynamic subtest: pipe-B-HDMI-A-2
[137.120679] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.001s)
[137.142885] Starting dynamic subtest: pipe-C-HDMI-A-1
[137.176055] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[137.198311] Starting dynamic subtest: pipe-C-HDMI-A-2
[137.231042] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[137.234332] Subtest bad-pixel-format-yf-tiled-ccs: SUCCESS (0.019s)
[137.900292] [013/132] (927s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[138.085672] Starting subtest: cursorA-vs-flipB-varying-size
[149.563142] Subtest cursorA-vs-flipB-varying-size: SUCCESS (11.412s)
[150.284559] [014/132] (915s left) kms_getfb (getfb2-handle-zero)
[150.889511] Starting subtest: getfb2-handle-zero
[150.895586] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[150.982443] [015/132] (915s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[151.165732] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[151.168856] Starting dynamic subtest: pipe-A-HDMI-A-1
[151.184951] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[151.228577] Starting dynamic subtest: pipe-A-HDMI-A-2
[151.253698] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s)
[151.295819] Starting dynamic subtest: pipe-B-HDMI-A-1
[151.310806] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[151.334244] Starting dynamic subtest: pipe-B-HDMI-A-2
[151.347800] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[151.370295] Starting dynamic subtest: pipe-C-HDMI-A-1
[151.382922] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[151.405093] Starting dynamic subtest: pipe-C-HDMI-A-2
[151.418027] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[151.424689] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.023s)
[152.192997] [016/132] (914s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[152.394710] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[155.204661] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SUCCESS (2.813s)
[155.405596] [017/132] (911s left) sysfs_heartbeat_interval (precise)
[155.527337] Starting subtest: precise
[155.533006] Starting dynamic subtest: vecs0
[157.010693] Dynamic subtest vecs0: SUCCESS (1.479s)
[157.040825] Starting dynamic subtest: vcs0
[158.460912] Dynamic subtest vcs0: SUCCESS (1.448s)
[158.488752] Starting dynamic subtest: bcs0
[159.922089] Dynamic subtest bcs0: SUCCESS (1.461s)
[159.952989] Starting dynamic subtest: rcs0
[161.379113] Dynamic subtest rcs0: SUCCESS (1.452s)
[161.383369] Subtest precise: SUCCESS (5.851s)
[161.524166] [018/132] (905s left) syncobj_timeline (device-signal-unordered)
[161.635651] Starting subtest: device-signal-unordered
[161.638956] Subtest device-signal-unordered: SUCCESS (0.003s)
[161.771185] [019/132] (904s left) gem_partial_pwrite_pread (write)
[161.893962] Starting subtest: write
[176.175492] Subtest write: SUCCESS (14.283s)
[176.339226] [020/132] (890s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[176.549761] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[179.020748] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (2.476s)
[179.291442] [021/132] (887s left) api_intel_allocator (simple-allocator)
[179.407747] Starting subtest: simple-allocator
[179.413761] Starting dynamic subtest: basic
[179.417143] Dynamic subtest basic: SUCCESS (0.007s)
[179.441298] Starting dynamic subtest: parallel-one
[179.835113] Dynamic subtest parallel-one: SUCCESS (0.417s)
[179.859168] Starting dynamic subtest: print
[179.863193] Dynamic subtest print: SUCCESS (0.000s)
[179.890093] Starting dynamic subtest: reuse
[179.894031] Dynamic subtest reuse: SUCCESS (0.000s)
[179.917517] Starting dynamic subtest: reserve
[179.920867] Dynamic subtest reserve: SUCCESS (0.000s)
[179.944547] Starting dynamic subtest: fork-reopen-allocator
[179.949094] Dynamic subtest fork-reopen-allocator: SUCCESS (0.030s)
[179.953222] Subtest simple-allocator: SUCCESS (0.464s)
[180.039932] [022/132] (886s left) i915_drm_fdinfo (all-busy-idle-check-all)
[180.154633] Starting subtest: all-busy-idle-check-all
[180.778497] Subtest all-busy-idle-check-all: SUCCESS (0.622s)
[180.903810] [023/132] (886s left) gem_ctx_param (invalid-set-no-zeromap)
[181.014940] Starting subtest: invalid-set-no-zeromap
[181.018361] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[181.139717] [024/132] (886s left) gem_ppgtt (shrink-vs-evict-any)
[181.253288] Starting subtest: shrink-vs-evict-any
[186.310989] Subtest shrink-vs-evict-any: SUCCESS (5.057s)
[186.432520] [025/132] (880s left) i915_pm_rps (min-max-config-idle)
[186.555177] Starting subtest: min-max-config-idle
[186.925582] Subtest min-max-config-idle: SUCCESS (0.370s)
[187.058575] [026/132] (880s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[187.269626] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[189.817216] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SUCCESS (2.555s)
[190.025098] [027/132] (877s left) kms_atomic_transition (plane-all-transition)
[190.210923] Starting subtest: plane-all-transition
[190.214663] Starting dynamic subtest: pipe-A-HDMI-A-1
[194.732913] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.517s)
[195.059964] Starting dynamic subtest: pipe-A-HDMI-A-2
[200.324126] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (5.317s)
[200.726840] Starting dynamic subtest: pipe-B-HDMI-A-1
[205.141107] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (4.558s)
[205.429176] Starting dynamic subtest: pipe-B-HDMI-A-2
[210.336153] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (4.960s)
[210.566291] Subtest plane-all-transition: SUCCESS (20.354s)
[210.934803] [028/132] (856s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[211.112825] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[211.119297] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[211.368859] [029/132] (856s left) gem_readwrite (beyond-eob)
[211.483392] Starting subtest: beyond-EOB
[211.489869] Subtest beyond-EOB: SUCCESS (0.000s)
[211.633551] [030/132] (856s left) kms_atomic_interruptible (legacy-setmode)
[211.843106] Starting subtest: legacy-setmode
[211.848068] Starting dynamic subtest: pipe-A-HDMI-A-1
[218.639929] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.797s)
[218.643318] Subtest legacy-setmode: SUCCESS (6.804s)
[218.987216] [031/132] (848s left) i915_hangman (gt-engine-error)
[219.143551] Starting subtest: gt-engine-error
[219.149647] Starting dynamic subtest: rcs0
[219.221118] Dynamic subtest rcs0: SUCCESS (0.083s)
[219.281135] Starting dynamic subtest: bcs0
[219.288053] Dynamic subtest bcs0: SKIP (0.004s)
[219.341434] Starting dynamic subtest: vcs0
[219.354686] Dynamic subtest vcs0: SUCCESS (0.113s)
[219.409025] Starting dynamic subtest: vecs0
[219.458385] Dynamic subtest vecs0: SUCCESS (0.100s)
[219.461568] Subtest gt-engine-error: SUCCESS (0.322s)
[219.637213] [032/132] (848s left) gem_close_race (basic-process)
[219.785703] Starting subtest: basic-process
[219.857441] Subtest basic-process: SUCCESS (0.073s)
[220.121566] [033/132] (847s left) gem_mmap_gtt (medium-copy-xy)
[220.232785] Starting subtest: medium-copy-XY
[225.693117] Subtest medium-copy-XY: SUCCESS (5.455s)
[225.842983] [034/132] (842s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[226.228878] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[226.235468] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[226.384136] [035/132] (841s left) dmabuf_sync_file (import-multiple-read-only)
[226.640706] Starting subtest: import-multiple-read-only
[226.655449] Subtest import-multiple-read-only: SUCCESS (0.017s)
[226.788490] [FACT dmabuf_sync_file (import-multiple-read-only)] new: kernel.kmod_is_loaded.vgem: true
[226.796431] [036/132] (841s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[227.022567] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[229.008653] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SUCCESS (2.004s)
[229.256763] [037/132] (839s left) kms_cursor_legacy (forked-move)
[229.464661] Starting subtest: forked-move
[229.469532] Starting dynamic subtest: pipe-A
[234.937028] Dynamic subtest pipe-A: SUCCESS (5.476s)
[234.970294] Starting dynamic subtest: pipe-B
[240.365682] Dynamic subtest pipe-B: SUCCESS (5.425s)
[240.394633] Starting dynamic subtest: pipe-C
[245.795721] Dynamic subtest pipe-C: SUCCESS (5.427s)
[245.895183] Starting dynamic subtest: all-pipes
[251.219169] Dynamic subtest all-pipes: SUCCESS (5.419s)
[251.224678] Subtest forked-move: SUCCESS (21.762s)
[251.377894] [038/132] (817s left) kms_flip (2x-flip-vs-suspend)
[251.571921] Starting subtest: 2x-flip-vs-suspend
[251.578983] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2