[61.552939] Initializing watchdogs
[61.553002]   /dev/watchdog0
[61.572798] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[61.583367] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[61.587667] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.590109] [001/133] (960s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[61.781399] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[61.782284] Starting dynamic subtest: pipe-A-DP-3
[61.790549] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[61.797862] Starting dynamic subtest: pipe-B-DP-3
[61.806036] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[61.813336] Starting dynamic subtest: pipe-C-DP-3
[61.821428] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[61.828647] Starting dynamic subtest: pipe-D-DP-3
[61.837514] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[61.839524] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SKIP (0.004s)
[62.252986] [002/133] (959s left) gen7_exec_parse (load-register-reg)
[62.334320] Subtest load-register-reg: SKIP (0.000s)
[62.384392] [003/133] (959s left) gem_mmap (big-bo)
[62.454001] Subtest big-bo: SKIP (0.000s)
[62.520304] [004/133] (959s left) dumb_buffer (map-invalid-size)
[62.596954] Starting subtest: map-invalid-size
[62.597855] Subtest map-invalid-size: SUCCESS (0.000s)
[62.774965] [005/133] (959s left) gem_exec_reloc (basic-gtt-read-active)
[62.853256] Subtest basic-gtt-read-active: SKIP (0.000s)
[62.941378] [006/133] (959s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[63.118184] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[63.119136] Starting dynamic subtest: pipe-A-DP-3
[63.127389] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[63.134749] Starting dynamic subtest: pipe-B-DP-3
[63.143115] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[63.150390] Starting dynamic subtest: pipe-C-DP-3
[63.158594] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[63.165772] Starting dynamic subtest: pipe-D-DP-3
[63.175137] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[63.176965] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[63.589989] [007/133] (958s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[63.774813] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[63.819926] [008/133] (958s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping)
[63.995928] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping
[64.033285] Starting dynamic subtest: pipe-A-plane-0
[64.035177] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[64.042916] Starting dynamic subtest: pipe-A-plane-3
[64.045265] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[64.053629] Starting dynamic subtest: pipe-A-plane-5
[64.055389] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[64.269028] Starting dynamic subtest: pipe-B-plane-0
[64.271453] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[64.285243] Starting dynamic subtest: pipe-B-plane-3
[64.287347] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[64.300754] Starting dynamic subtest: pipe-B-plane-5
[64.302639] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[64.365187] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.367s)
[64.635115] [009/133] (957s left) gem_pxp (fail-invalid-protected-context)
[67.230360] Starting subtest: fail-invalid-protected-context
[67.232466] Subtest fail-invalid-protected-context: SKIP (0.000s)
[67.383393] [010/133] (955s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[67.696961] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[67.697983] Starting dynamic subtest: pipe-A-valid-mode
[70.368996] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.664s)
[70.370540] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SUCCESS (2.666s)
[70.664354] [011/133] (952s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[70.738208] Starting subtest: multi-wait-all-for-submit-available-signaled
[70.739165] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.001s)
[70.872289] [012/133] (951s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[71.050582] Starting subtest: basic-modeset-with-all-modifiers-formats
[71.275299] Starting dynamic subtest: pipe-A-DP-3-4-RGB565
[71.555600] Dynamic subtest pipe-A-DP-3-4-RGB565: SUCCESS (0.279s)
[71.587517] Starting dynamic subtest: pipe-A-DP-3-4-XRGB8888
[71.588748] Dynamic subtest pipe-A-DP-3-4-XRGB8888: SUCCESS (0.029s)
[71.603220] Starting dynamic subtest: pipe-A-DP-3-4-XRGB2101010
[71.618659] Dynamic subtest pipe-A-DP-3-4-XRGB2101010: SUCCESS (0.033s)
[71.628588] Starting dynamic subtest: pipe-A-DP-3-4-XRGB16161616F
[71.651800] Dynamic subtest pipe-A-DP-3-4-XRGB16161616F: SUCCESS (0.033s)
[71.661849] Starting dynamic subtest: pipe-A-DP-3-4-YUYV
[71.685176] Dynamic subtest pipe-A-DP-3-4-YUYV: SUCCESS (0.033s)
[71.695086] Starting dynamic subtest: pipe-A-DP-3-4-Y210
[71.718858] Dynamic subtest pipe-A-DP-3-4-Y210: SUCCESS (0.033s)
[71.730812] Starting dynamic subtest: pipe-A-DP-3-4-XYUV8888
[71.752112] Dynamic subtest pipe-A-DP-3-4-XYUV8888: SUCCESS (0.033s)
[71.766875] Starting dynamic subtest: pipe-A-DP-3-4-XV30
[71.785405] Dynamic subtest pipe-A-DP-3-4-XV30: SUCCESS (0.033s)
[71.800332] Starting dynamic subtest: pipe-A-DP-3-4-XV36
[71.818951] Dynamic subtest pipe-A-DP-3-4-XV36: SUCCESS (0.033s)
[71.839468] Starting dynamic subtest: pipe-A-DP-3-x-RGB565
[72.002179] Dynamic subtest pipe-A-DP-3-x-RGB565: SUCCESS (0.183s)
[72.010213] Starting dynamic subtest: pipe-A-DP-3-x-XRGB8888
[72.035562] Dynamic subtest pipe-A-DP-3-x-XRGB8888: SUCCESS (0.033s)
[72.044495] Starting dynamic subtest: pipe-A-DP-3-x-XRGB2101010
[72.069144] Dynamic subtest pipe-A-DP-3-x-XRGB2101010: SUCCESS (0.033s)
[72.085139] Starting dynamic subtest: pipe-A-DP-3-x-XRGB16161616F
[72.102630] Dynamic subtest pipe-A-DP-3-x-XRGB16161616F: SUCCESS (0.033s)
[72.118661] Starting dynamic subtest: pipe-A-DP-3-x-YUYV
[72.136207] Dynamic subtest pipe-A-DP-3-x-YUYV: SUCCESS (0.033s)
[72.152310] Starting dynamic subtest: pipe-A-DP-3-x-Y210
[72.169255] Dynamic subtest pipe-A-DP-3-x-Y210: SUCCESS (0.033s)
[72.185168] Starting dynamic subtest: pipe-A-DP-3-x-XYUV8888
[72.202606] Dynamic subtest pipe-A-DP-3-x-XYUV8888: SUCCESS (0.033s)
[72.218535] Starting dynamic subtest: pipe-A-DP-3-x-XV30
[72.235984] Dynamic subtest pipe-A-DP-3-x-XV30: SUCCESS (0.033s)
[72.251951] Starting dynamic subtest: pipe-A-DP-3-x-XV36
[72.269382] Dynamic subtest pipe-A-DP-3-x-XV36: SUCCESS (0.033s)
[72.285435] Starting dynamic subtest: pipe-A-DP-3-linear-RGB565
[72.470566] Dynamic subtest pipe-A-DP-3-linear-RGB565: SUCCESS (0.201s)
[72.478566] Starting dynamic subtest: pipe-A-DP-3-linear-XRGB8888
[72.504716] Dynamic subtest pipe-A-DP-3-linear-XRGB8888: SUCCESS (0.034s)
[72.514804] Starting dynamic subtest: pipe-A-DP-3-linear-XRGB2101010
[72.538306] Dynamic subtest pipe-A-DP-3-linear-XRGB2101010: SUCCESS (0.033s)
[72.554953] Starting dynamic subtest: pipe-A-DP-3-linear-XRGB16161616F
[72.571663] Dynamic subtest pipe-A-DP-3-linear-XRGB16161616F: SUCCESS (0.033s)
[72.588419] Starting dynamic subtest: pipe-A-DP-3-linear-YUYV
[72.605167] Dynamic subtest pipe-A-DP-3-linear-YUYV: SUCCESS (0.033s)
[72.621617] Starting dynamic subtest: pipe-A-DP-3-linear-Y210
[72.638372] Dynamic subtest pipe-A-DP-3-linear-Y210: SUCCESS (0.033s)
[72.654855] Starting dynamic subtest: pipe-A-DP-3-linear-XYUV8888
[72.671806] Dynamic subtest pipe-A-DP-3-linear-XYUV8888: SUCCESS (0.033s)
[72.683243] Starting dynamic subtest: pipe-A-DP-3-linear-XV30
[72.704926] Dynamic subtest pipe-A-DP-3-linear-XV30: SUCCESS (0.033s)
[72.712861] Starting dynamic subtest: pipe-A-DP-3-linear-XV36
[72.738383] Dynamic subtest pipe-A-DP-3-linear-XV36: SUCCESS (0.033s)
[72.994590] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (1.942s)
[73.329824] [013/133] (949s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[73.520132] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[74.601738] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (1.081s)
[74.794742] [014/133] (948s left) gem_watchdog (default-virtual)
[74.872356] Starting subtest: default-virtual
[82.205084] Subtest default-virtual: SUCCESS (7.325s)
[82.312568] [015/133] (940s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[82.493061] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[82.493977] Starting dynamic subtest: pipe-A-DP-3
[82.502238] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[82.510287] Starting dynamic subtest: pipe-B-DP-3
[82.518540] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[82.526349] Starting dynamic subtest: pipe-C-DP-3
[82.534471] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[82.542185] Starting dynamic subtest: pipe-D-DP-3
[82.551417] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[82.553493] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.004s)
[82.979369] [016/133] (940s left) kms_psr (pr-cursor-plane-move)
[83.165885] Subtest pr-cursor-plane-move: SKIP (0.000s)
[83.205325] [017/133] (939s left) gem_exec_fence (syncobj-invalid-flags)
[83.798829] Starting subtest: syncobj-invalid-flags
[83.799747] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[84.231015] [FACT gem_exec_fence (syncobj-invalid-flags)] new: kernel.kmod_is_loaded.vgem: true
[84.232637] [018/133] (938s left) gem_softpin (32b-excludes-last-page)
[84.316602] Starting subtest: 32b-excludes-last-page
[84.322198] Subtest 32b-excludes-last-page: SUCCESS (0.005s)
[84.535625] [019/133] (938s left) kms_flip (wf_vblank-ts-check)
[84.718999] Starting subtest: wf_vblank-ts-check
[84.722935] Starting dynamic subtest: A-DP3
[92.868739] Dynamic subtest A-DP3: SUCCESS (8.142s)
[92.878948] Starting dynamic subtest: B-DP3
[100.930117] Dynamic subtest B-DP3: SUCCESS (8.058s)
[100.938978] Starting dynamic subtest: C-DP3
[108.988440] Dynamic subtest C-DP3: SUCCESS (8.056s)
[108.997550] Starting dynamic subtest: D-DP3
[117.052083] Dynamic subtest D-DP3: SUCCESS (8.062s)
[117.053995] Subtest wf_vblank-ts-check: SUCCESS (32.326s)
[117.377236] [020/133] (905s left) kms_ccs (random-ccs-data-4-tiled-lnl-ccs)
[117.561461] Starting subtest: random-ccs-data-4-tiled-lnl-ccs
[117.563258] Subtest random-ccs-data-4-tiled-lnl-ccs: SKIP (0.000s)
[117.880873] [021/133] (905s left) kms_plane (pixel-format-linear-modifier-source-clamping)
[118.067055] Starting subtest: pixel-format-linear-modifier-source-clamping
[118.098599] Starting dynamic subtest: pipe-A-plane-0
[124.116565] Dynamic subtest pipe-A-plane-0: SUCCESS (6.017s)
[124.145182] Starting dynamic subtest: pipe-A-plane-3
[127.333348] Dynamic subtest pipe-A-plane-3: SUCCESS (3.216s)
[127.342697] Starting dynamic subtest: pipe-A-plane-5
[127.344763] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[127.599075] Starting dynamic subtest: pipe-B-plane-0
[133.067935] Dynamic subtest pipe-B-plane-0: SUCCESS (5.483s)
[133.079932] Starting dynamic subtest: pipe-B-plane-3
[136.251870] Dynamic subtest pipe-B-plane-3: SUCCESS (3.183s)
[136.264688] Starting dynamic subtest: pipe-B-plane-5
[136.266996] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[136.342463] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (18.273s)
[136.690639] [022/133] (886s left) kms_universal_plane (universal-plane-sanity)
[136.877992] Starting subtest: universal-plane-sanity
[136.878927] Starting dynamic subtest: pipe-A-DP-3
[137.499909] Dynamic subtest pipe-A-DP-3: SUCCESS (0.619s)
[137.519823] Starting dynamic subtest: pipe-B-DP-3
[137.969596] Dynamic subtest pipe-B-DP-3: SUCCESS (0.466s)
[137.978876] Starting dynamic subtest: pipe-C-DP-3
[138.446245] Dynamic subtest pipe-C-DP-3: SUCCESS (0.475s)
[138.457555] Starting dynamic subtest: pipe-D-DP-3
[138.896720] Dynamic subtest pipe-D-DP-3: SUCCESS (0.449s)
[138.897626] Subtest universal-plane-sanity: SUCCESS (2.019s)
[139.211304] [023/133] (884s left) gem_exec_reloc (basic-cpu-read)
[139.298313] Subtest basic-cpu-read: SKIP (0.000s)
[139.421425] [024/133] (884s left) i915_query (query-topology-kernel-writes)
[139.504048] Starting subtest: query-topology-kernel-writes
[139.504991] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[139.678626] [025/133] (884s left) gem_mmap_gtt (hang-busy)
[139.760032] Subtest hang-busy: SKIP (0.000s)
[139.837180] [026/133] (883s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[139.913092] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[139.913977] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[140.112397] [027/133] (883s left) kms_vrr (seamless-rr-switch-virtual)
[140.299911] Starting subtest: seamless-rr-switch-virtual
[140.302429] Subtest seamless-rr-switch-virtual: SKIP (0.000s)
[140.438294] [028/133] (883s left) gem_exec_store (basic)
[140.524566] Starting subtest: basic
[140.670447] Subtest basic: SUCCESS (0.145s)
[140.958061] [029/133] (882s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[141.149551] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[141.151242] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[141.314625] [030/133] (882s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[141.508589] Starting subtest: fbc-modesetfrombusy
[142.806928] Subtest fbc-modesetfrombusy: SUCCESS (1.300s)
[143.039573] [031/133] (881s left) api_intel_allocator (fork-simple-once)
[143.125164] Starting subtest: fork-simple-once
[143.164101] Subtest fork-simple-once: SUCCESS (0.040s)
[143.385413] [032/133] (880s left) gem_exec_schedule (preempt-queue-contexts)
[143.478468] Subtest preempt-queue-contexts: SKIP (0.000s)
[143.893896] [033/133] (880s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[144.083396] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[144.085164] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[144.287473] [034/133] (880s left) i915_pm_rps (thresholds-idle)
[144.376320] Starting subtest: thresholds-idle
[144.378189] Subtest thresholds-idle: SKIP (0.000s)
[144.510037] [035/133] (879s left) gem_exec_reloc (basic-wc-gtt)
[144.599811] Subtest basic-wc-gtt: SKIP (0.000s)
[144.664221] [036/133] (879s left) kms_pm_rpm (system-suspend-idle)
[146.998180] Starting subtest: system-suspend-idle
[166.574227] Subtest system-suspend-idle: SUCCESS (5.288s)
[166.951188] [037/133] (857s left) gem_ctx_exec (basic)
[167.036059] Starting subtest: basic
[167.041706] Subtest basic: SUCCESS (0.006s)
[167.256247] [038/133] (857s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[167.455855] Starting subtest: fbcpsr-tiling-y
[167.457532] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[167.657484] [039/133] (857s left) drm_read (short-buffer-nonblock)
[167.925036] Starting subtest: short-buffer-nonblock
[167.926023] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[168.169194] [040/133] (856s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[168.357643] Starting subtest: basic-max-pipe-crc-check
[168.359720] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[168.414825] [041/133] (856s left) kms_psr (psr2-sprite-mmap-cpu)
[168.611178] Subtest psr2-sprite-mmap-cpu: SKIP (0.000s)
[168.672236] [042/133] (856s left) perf_pmu (init-sema)
[168.746191] Starting subtest: init-sema
[168.747086] Starting dynamic subtest: rcs0
[168.749034] Dynamic subtest rcs0: SUCCESS (0.002s)
[168.759460] Starting dynamic subtest: bcs0
[168.760343] Dynamic subtest bcs0: SUCCESS (0.001s)
[168.770508] Starting dynamic subtest: vcs0
[168.771449] Dynamic subtest vcs0: SUCCESS (0.001s)
[168.781964] Starting dynamic subtest: vcs1
[168.783284] Dynamic subtest vcs1: SUCCESS (0.001s)
[168.793876] Starting dynamic subtest: vecs0
[168.795096] Dynamic subtest vecs0: SUCCESS (0.000s)
[168.805663] Starting dynamic subtest: vecs1
[168.806655] Dynamic subtest vecs1: SUCCESS (0.001s)
[168.816813] Starting dynamic subtest: ccs0
[168.817997] Dynamic subtest ccs0: SUCCESS (0.000s)
[168.819199] Subtest init-sema: SUCCESS (0.010s)
[168.936392] [043/133] (856s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[169.130301] Starting subtest: cursorB-vs-flipB-atomic
[169.132148] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[169.304987] [044/133] (855s left) kms_psr (fbc-psr-dpms)
[169.500806] Subtest fbc-psr-dpms: SKIP (0.000s)
[169.559887] [045/133] (855s left) kms_properties (plane-properties-legacy)
[169.752076] Starting subtest: plane-properties-legacy
[169.752995] Starting dynamic subtest: pipe-A-DP-3
[170.260307] Dynamic subtest pipe-A-DP-3: SUCCESS (0.496s)
[170.276889] Starting dynamic subtest: pipe-B-DP-3
[170.818347] Dynamic subtest pipe-B-DP-3: SUCCESS (0.545s)
[170.830172] Starting dynamic subtest: pipe-C-DP-3
[171.365423] Dynamic subtest pipe-C-DP-3: SUCCESS (0.535s)
[171.377695] Starting dynamic subtest: pipe-D-DP-3
[171.915173] Dynamic subtest pipe-D-DP-3: SUCCESS (0.538s)
[171.916018] Subtest plane-properties-legacy: SUCCESS (2.120s)
[172.182696] [046/133] (852s left) gem_sync (basic-many-each)
[172.278273] Starting subtest: basic-many-each
[174.702380] Subtest basic-many-each: SUCCESS (2.389s)
[174.964629] [047/133] (850s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[175.151113] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[175.152635] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[175.486911] [048/133] (849s left) gem_mmap_gtt (medium-copy-xy)
[175.575052] Subtest medium-copy-XY: SKIP (0.000s)
[175.656450] [049/133] (849s left) gem_cs_tlb (engines)
[175.745830] Starting subtest: engines
[175.746718] Starting dynamic subtest: rcs0
[177.922159] Dynamic subtest rcs0: SUCCESS (2.155s)
[177.932619] Starting dynamic subtest: bcs0
[180.090931] Dynamic subtest bcs0: SUCCESS (2.152s)
[180.101263] Starting dynamic subtest: vcs0
[182.255470] Dynamic subtest vcs0: SUCCESS (2.152s)
[182.266156] Starting dynamic subtest: vcs1
[184.418622] Dynamic subtest vcs1: SUCCESS (2.153s)
[184.429383] Starting dynamic subtest: vecs0
[186.580222] Dynamic subtest vecs0: SUCCESS (2.154s)
[186.590904] Starting dynamic subtest: vecs1
[188.741129] Dynamic subtest vecs1: SUCCESS (2.155s)
[188.751482] Starting dynamic subtest: ccs0
[190.899284] Dynamic subtest ccs0: SUCCESS (2.152s)
[190.900315] Subtest engines: SUCCESS (15.078s)
[191.066878] [050/133] (834s left) gem_userptr_blits (forbidden-operations)
[191.151990] Starting subtest: forbidden-operations
[191.153739] Subtest forbidden-operations: SKIP (0.000s)
[191.358755] [051/133] (834s left) gem_exec_fence (syncobj-wait)
[191.919502] Starting subtest: syncobj-wait
[192.042600] Subtest syncobj-wait: SUCCESS (0.123s)
[192.427761] [052/133] (833s left) kms_psr (fbc-psr2-primary-blt)
[192.611490] Subtest fbc-psr2-primary-blt: SKIP (0.000s)
[192.677466] [053/133] (832s left) syncobj_eventfd (binary-wait-signaled)
[192.761286] Starting subtest: binary-wait-signaled
[192.762212] Subtest binary-wait-signaled: SUCCESS (0.000s)
[192.928725] [054/133] (832s left) kms_draw_crc (draw-method-mmap-gtt)
[193.122308] Starting subtest: draw-method-mmap-gtt
[193.124044] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[193.316324] [055/133] (832s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[193.504105] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[193.504945] Starting dynamic subtest: pipe-A-valid-mode
[197.745927] Dynamic subtest pipe-A-valid-mode: SUCCESS (4.234s)
[197.747768] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SUCCESS (4.237s)
[198.062959] [056/133] (827s left) gem_exec_flush (basic-wb-ro-default)
[198.148171] Subtest basic-wb-ro-default: SKIP (0.000s)
[198.222632] [057/133] (827s left) kms_vblank (ts-continuation-modeset-rpm)
[198.413197] Starting subtest: ts-continuation-modeset-rpm
[198.414142] Starting dynamic subtest: pipe-A-DP-3
[200.307749] Dynamic subtest pipe-A-DP-3: SUCCESS (1.892s)
[200.331562] Starting dynamic subtest: pipe-D-DP-3
[201.156538] Dynamic subtest pipe-D-DP-3: SUCCESS (0.843s)
[201.157491] Subtest ts-continuation-modeset-rpm: SUCCESS (2.743s)
[201.436585] [058/133] (824s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[201.634792] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[201.636389] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[201.836525] [059/133] (824s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[202.028166] Starting subtest: cursorB-vs-flipB-legacy
[202.029958] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[202.195602] [060/133] (824s left) gem_exec_await (wide-contexts)
[202.446381] Starting subtest: wide-contexts
[224.665422] Subtest wide-contexts: SUCCESS (22.205s)
[224.895036] [061/133] (801s left) gem_lmem_swapping (verify)
[227.757865] Starting subtest: verify
[227.760876] Starting dynamic subtest: lmem0
[264.218457] Dynamic subtest lmem0: SUCCESS (36.443s)
[264.219370] Subtest verify: SUCCESS (36.445s)
[266.321200] [FACT gem_lmem_swapping (verify)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[266.322204] [FACT gem_lmem_swapping (verify)] deleted: kernel.kmod_is_loaded.i915: true
[266.324202] [062/133] (759s left) prime_vgem (busy)
[267.956985] Starting subtest: busy
[267.957892] Starting dynamic subtest: rcs0
[268.018779] Dynamic subtest rcs0: SUCCESS (0.063s)
[268.032300] Starting dynamic subtest: bcs0
[268.072442] Dynamic subtest bcs0: SUCCESS (0.053s)
[268.088877] Starting dynamic subtest: vcs0
[268.116960] Dynamic subtest vcs0: SUCCESS (0.043s)
[268.142370] Starting dynamic subtest: vcs1
[268.160411] Dynamic subtest vcs1: SUCCESS (0.041s)
[268.183836] Starting dynamic subtest: vecs0
[268.200763] Dynamic subtest vecs0: SUCCESS (0.039s)
[268.218556] Starting dynamic subtest: vecs1
[268.242804] Dynamic subtest vecs1: SUCCESS (0.041s)
[268.258307] Starting dynamic subtest: ccs0
[268.284258] Dynamic subtest ccs0: SUCCESS (0.040s)
[268.285215] Subtest busy: SUCCESS (0.330s)
[268.432867] [FACT prime_vgem (busy)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[268.435600] [FACT prime_vgem (busy)] new: kernel.kmod_is_loaded.i915: true
[268.438511] [063/133] (757s left) i915_module_load (reload)
[268.485801] Starting subtest: reload
[273.536354] Subtest reload: SUCCESS (5.052s)
[273.583051] [064/133] (752s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[273.855869] Starting subtest: fbc-rgb565-draw-blt
[276.620099] Subtest fbc-rgb565-draw-blt: SUCCESS (2.765s)
[276.868383] [065/133] (749s left) gem_exec_balancer (bonded-chain)
[276.963739] Starting subtest: bonded-chain
[290.707244] Subtest bonded-chain: SUCCESS (13.744s)
[291.149028] [066/133] (735s left) gem_mmap_gtt (basic-write-read)
[291.225084] Subtest basic-write-read: SKIP (0.000s)
[291.298333] [067/133] (735s left) gem_exec_reloc (basic-write-read-active)
[291.380475] Subtest basic-write-read-active: SKIP (0.000s)
[291.481039] [068/133] (735s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[291.678794] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[291.680447] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[291.893197] [069/133] (734s left) gem_lmem_swapping (heavy-verify-random-ccs)
[294.497203] Starting subtest: heavy-verify-random-ccs
[294.498001] Starting dynamic subtest: lmem0
[309.434546] Dynamic subtest lmem0: SUCCESS (14.935s)
[309.435409] Subtest heavy-verify-random-ccs: SUCCESS (14.936s)
[310.990873] [FACT gem_lmem_swapping (heavy-verify-random-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[310.991881] [FACT gem_lmem_swapping (heavy-verify-random-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[310.993752] [070/133] (715s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[312.690167] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[312.691948] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[312.891750] [FACT kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[312.894306] [FACT kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)] new: kernel.kmod_is_loaded.i915: true
[312.897059] [071/133] (713s left) kms_getfb (getfb-handle-closed)
[313.099308] Starting subtest: getfb-handle-closed
[313.100197] Subtest getfb-handle-closed: SUCCESS (0.000s)
[313.333957] [072/133] (713s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[313.540043] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[313.541703] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[313.713372] [073/133] (713s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[313.905173] Starting subtest: fbc-rgb565-draw-mmap-cpu
[316.302535] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (2.397s)
[316.546932] [074/133] (710s left) gem_exec_create (forked)
[316.642663] Starting subtest: forked
[316.643536] Starting dynamic subtest: smem
[336.784920] Dynamic subtest smem: SUCCESS (20.137s)
[336.802320] Starting dynamic subtest: lmem0
[356.948564] Dynamic subtest lmem0: SUCCESS (20.156s)
[356.949509] Subtest forked: SUCCESS (40.295s)
[357.224215] [075/133] (669s left) kms_chamelium_color (ctm-red-to-blue)
[357.413256] Subtest ctm-red-to-blue: SKIP (0.000s)
[357.474671] [076/133] (669s left) syncobj_wait (single-wait-for-submit-signaled)
[357.561392] Starting subtest: single-wait-for-submit-signaled
[357.562295] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[357.739887] [077/133] (669s left) kms_cursor_crc (cursor-offscreen-32x32)
[358.034260] Starting subtest: cursor-offscreen-32x32
[358.084592] Subtest cursor-offscreen-32x32: SKIP (0.050s)
[358.545110] [078/133] (668s left) prime_vgem (basic-fence-flip)
[358.635676] Starting subtest: basic-fence-flip
[358.765245] Subtest basic-fence-flip: SKIP (0.129s)
[358.961167] [079/133] (668s left) syncobj_wait (wait-any-snapshot)
[359.040668] Starting subtest: wait-any-snapshot
[359.123562] Subtest wait-any-snapshot: SUCCESS (0.082s)
[359.295972] [080/133] (668s left) gem_ctx_freq (sysfs)
[359.380626] Starting subtest: sysfs
[359.381539] Starting dynamic subtest: gt0
[365.039567] Dynamic subtest gt0: SUCCESS (5.655s)
[365.045349] Subtest sysfs: SUCCESS (5.659s)
[365.225884] [081/133] (662s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[365.588389] Starting subtest: cursor-rapid-movement-128x128
[365.593296] Starting dynamic subtest: pipe-A-DP-3
[366.083527] Dynamic subtest pipe-A-DP-3: SUCCESS (0.490s)
[366.134573] Starting dynamic subtest: pipe-D-DP-3
[366.540977] Dynamic subtest pipe-D-DP-3: SUCCESS (0.417s)
[366.542412] Subtest cursor-rapid-movement-128x128: SUCCESS (0.953s)
[367.057492] [082/133] (660s left) gem_fence_thrash (bo-copy)
[367.105608] Starting subtest: bo-copy
[367.143253] Subtest bo-copy: SKIP (0.037s)
[367.236370] [083/133] (660s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[367.318329] Starting subtest: multi-wait-available-submitted-signaled
[367.319259] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.001s)
[367.502843] [084/133] (660s left) kms_flip_tiling (flip-change-tiling)
[367.687514] Starting subtest: flip-change-tiling
[367.689807] Starting dynamic subtest: pipe-A-DP-3-4-to-4
[367.934530] Dynamic subtest pipe-A-DP-3-4-to-4: SUCCESS (0.244s)
[367.979135] Starting dynamic subtest: pipe-A-DP-3-4-to-x
[368.151150] Dynamic subtest pipe-A-DP-3-4-to-x: SUCCESS (0.212s)
[368.170836] Starting dynamic subtest: pipe-A-DP-3-4-to-linear
[368.334490] Dynamic subtest pipe-A-DP-3-4-to-linear: SUCCESS (0.178s)
[368.378999] Starting dynamic subtest: pipe-A-DP-3-x-to-4
[368.568080] Dynamic subtest pipe-A-DP-3-x-to-4: SUCCESS (0.229s)
[368.613861] Starting dynamic subtest: pipe-A-DP-3-x-to-x
[368.751231] Dynamic subtest pipe-A-DP-3-x-to-x: SUCCESS (0.178s)
[368.770758] Starting dynamic subtest: pipe-A-DP-3-x-to-linear
[368.951529] Dynamic subtest pipe-A-DP-3-x-to-linear: SUCCESS (0.196s)
[368.997583] Starting dynamic subtest: pipe-A-DP-3-linear-to-4
[369.167729] Dynamic subtest pipe-A-DP-3-linear-to-4: SUCCESS (0.212s)
[369.213598] Starting dynamic subtest: pipe-A-DP-3-linear-to-x
[369.385229] Dynamic subtest pipe-A-DP-3-linear-to-x: SUCCESS (0.213s)
[369.430722] Starting dynamic subtest: pipe-A-DP-3-linear-to-linear
[369.568298] Dynamic subtest pipe-A-DP-3-linear-to-linear: SUCCESS (0.178s)
[369.659548] Starting dynamic subtest: pipe-B-DP-3-4-to-4
[369.981331] Dynamic subtest pipe-B-DP-3-4-to-4: SUCCESS (0.357s)
[370.025312] Starting dynamic subtest: pipe-B-DP-3-4-to-x
[370.147159] Dynamic subtest pipe-B-DP-3-4-to-x: SUCCESS (0.162s)
[370.173618] Starting dynamic subtest: pipe-B-DP-3-4-to-linear
[370.297316] Dynamic subtest pipe-B-DP-3-4-to-linear: SUCCESS (0.148s)
[370.314030] Starting dynamic subtest: pipe-B-DP-3-x-to-4
[370.430405] Dynamic subtest pipe-B-DP-3-x-to-4: SUCCESS (0.131s)
[370.448880] Starting dynamic subtest: pipe-B-DP-3-x-to-x
[370.580921] Dynamic subtest pipe-B-DP-3-x-to-x: SUCCESS (0.149s)
[370.617838] Starting dynamic subtest: pipe-B-DP-3-x-to-linear
[370.747566] Dynamic subtest pipe-B-DP-3-x-to-linear: SUCCESS (0.164s)
[370.789342] Starting dynamic subtest: pipe-B-DP-3-linear-to-4
[370.914269] Dynamic subtest pipe-B-DP-3-linear-to-4: SUCCESS (0.164s)
[370.944876] Starting dynamic subtest: pipe-B-DP-3-linear-to-x
[371.064394] Dynamic subtest pipe-B-DP-3-linear-to-x: SUCCESS (0.148s)
[371.095430] Starting dynamic subtest: pipe-B-DP-3-linear-to-linear
[371.231297] Dynamic subtest pipe-B-DP-3-linear-to-linear: SUCCESS (0.164s)
[371.302862] Starting dynamic subtest: pipe-C-DP-3-4-to-4
[371.631542] Dynamic subtest pipe-C-DP-3-4-to-4: SUCCESS (0.361s)
[371.675320] Starting dynamic subtest: pipe-C-DP-3-4-to-x
[371.797258] Dynamic subtest pipe-C-DP-3-4-to-x: SUCCESS (0.162s)
[371.820425] Starting dynamic subtest: pipe-C-DP-3-4-to-linear
[371.947318] Dynamic subtest pipe-C-DP-3-4-to-linear: SUCCESS (0.148s)
[371.977772] Starting dynamic subtest: pipe-C-DP-3-x-to-4
[372.114233] Dynamic subtest pipe-C-DP-3-x-to-4: SUCCESS (0.164s)
[372.155639] Starting dynamic subtest: pipe-C-DP-3-x-to-x
[372.280750] Dynamic subtest pipe-C-DP-3-x-to-x: SUCCESS (0.164s)
[372.312029] Starting dynamic subtest: pipe-C-DP-3-x-to-linear
[372.430796] Dynamic subtest pipe-C-DP-3-x-to-linear: SUCCESS (0.148s)
[372.457271] Starting dynamic subtest: pipe-C-DP-3-linear-to-4
[372.580927] Dynamic subtest pipe-C-DP-3-linear-to-4: SUCCESS (0.148s)
[372.607687] Starting dynamic subtest: pipe-C-DP-3-linear-to-x
[372.730929] Dynamic subtest pipe-C-DP-3-linear-to-x: SUCCESS (0.148s)
[372.761452] Starting dynamic subtest: pipe-C-DP-3-linear-to-linear
[372.880949] Dynamic subtest pipe-C-DP-3-linear-to-linear: SUCCESS (0.148s)
[372.926830] Starting dynamic subtest: pipe-D-DP-3-4-to-4
[373.245362] Dynamic subtest pipe-D-DP-3-4-to-4: SUCCESS (0.329s)
[373.288807] Starting dynamic subtest: pipe-D-DP-3-4-to-x
[373.411205] Dynamic subtest pipe-D-DP-3-4-to-x: SUCCESS (0.162s)
[373.436894] Starting dynamic subtest: pipe-D-DP-3-4-to-linear
[373.561369] Dynamic subtest pipe-D-DP-3-4-to-linear: SUCCESS (0.148s)
[373.591899] Starting dynamic subtest: pipe-D-DP-3-x-to-4
[373.711285] Dynamic subtest pipe-D-DP-3-x-to-4: SUCCESS (0.148s)
[373.734293] Starting dynamic subtest: pipe-D-DP-3-x-to-x
[373.861123] Dynamic subtest pipe-D-DP-3-x-to-x: SUCCESS (0.148s)
[373.873312] Starting dynamic subtest: pipe-D-DP-3-x-to-linear
[373.994517] Dynamic subtest pipe-D-DP-3-x-to-linear: SUCCESS (0.132s)
[374.006626] Starting dynamic subtest: pipe-D-DP-3-linear-to-4
[374.127615] Dynamic subtest pipe-D-DP-3-linear-to-4: SUCCESS (0.132s)
[374.141398] Starting dynamic subtest: pipe-D-DP-3-linear-to-x
[374.260935] Dynamic subtest pipe-D-DP-3-linear-to-x: SUCCESS (0.132s)
[374.274217] Starting dynamic subtest: pipe-D-DP-3-linear-to-linear
[374.394666] Dynamic subtest pipe-D-DP-3-linear-to-linear: SUCCESS (0.132s)
[374.427758] Subtest flip-change-tiling: SUCCESS (6.738s)
[374.778685] [085/133] (653s left) gem_ccs (block-copy-uncompressed)
[374.869402] Starting subtest: block-copy-uncompressed
[374.871719] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[374.917521] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.047s)
[374.931029] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-lmem0
[374.933589] Dynamic subtest linear-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.015s)
[374.947275] Starting dynamic subtest: linear-uncompressed-compfmt0-lmem0-smem
[375.038282] Dynamic subtest linear-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.103s)
[375.051422] Starting dynamic subtest: linear-uncompressed-compfmt0-lmem0-lmem0
[375.144290] Dynamic subtest linear-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.105s)
[375.157774] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[375.160934] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.015s)
[375.174394] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-lmem0
[375.176506] Dynamic subtest xmajor-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.014s)
[375.189919] Starting dynamic subtest: xmajor-uncompressed-compfmt0-lmem0-smem
[375.280405] Dynamic subtest xmajor-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.103s)
[375.294423] Starting dynamic subtest: xmajor-uncompressed-compfmt0-lmem0-lmem0
[375.387837] Dynamic subtest xmajor-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.106s)
[375.401437] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[375.404956] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[375.428842] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-lmem0
[375.431936] Dynamic subtest tile4-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.025s)
[375.444196] Starting dynamic subtest: tile4-uncompressed-compfmt0-lmem0-smem
[375.538585] Dynamic subtest tile4-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.107s)
[375.551898] Starting dynamic subtest: tile4-uncompressed-compfmt0-lmem0-lmem0
[375.643144] Dynamic subtest tile4-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.103s)
[375.656763] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[375.659769] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.015s)
[375.673193] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-lmem0
[375.675364] Dynamic subtest tile64-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.014s)
[375.688880] Starting dynamic subtest: tile64-uncompressed-compfmt0-lmem0-smem
[375.788421] Dynamic subtest tile64-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.112s)
[375.802182] Starting dynamic subtest: tile64-uncompressed-compfmt0-lmem0-lmem0
[375.896068] Dynamic subtest tile64-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.106s)
[375.896982] Subtest block-copy-uncompressed: SUCCESS (1.027s)
[376.109638] [086/133] (651s left) kms_pm_rpm (dpms-lpsp)
[378.324729] Starting subtest: dpms-lpsp
[378.327046] Subtest dpms-lpsp: SKIP (0.001s)
[378.702247] [087/133] (649s left) kms_chamelium_hpd (common-hpd-after-suspend)
[378.969366] Subtest common-hpd-after-suspend: SKIP (0.000s)
[379.125584] [088/133] (649s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[379.309923] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[379.310846] Starting dynamic subtest: pipe-A
[379.883145] Dynamic subtest pipe-A: SUCCESS (0.572s)
[379.911891] Starting dynamic subtest: pipe-B
[380.529262] Dynamic subtest pipe-B: SUCCESS (0.644s)
[380.546316] Starting dynamic subtest: pipe-C
[381.159417] Dynamic subtest pipe-C: SUCCESS (0.629s)
[381.185076] Starting dynamic subtest: pipe-D
[381.805344] Dynamic subtest pipe-D: SUCCESS (0.644s)
[381.806218] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (2.495s)
[382.184669] [089/133] (646s left) kms_cursor_edge_walk (64x64-left-edge)
[382.367726] Starting subtest: 64x64-left-edge
[382.370145] Starting dynamic subtest: pipe-A-DP-3
[385.839165] Dynamic subtest pipe-A-DP-3: SUCCESS (3.468s)
[385.856836] Starting dynamic subtest: pipe-D-DP-3
[389.184214] Dynamic subtest pipe-D-DP-3: SUCCESS (3.341s)
[389.185203] Subtest 64x64-left-edge: SUCCESS (6.814s)
[389.503922] [090/133] (638s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[389.718848] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[390.985673] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.267s)
[391.190963] [091/133] (637s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[391.384130] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[391.385854] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[391.559220] [092/133] (636s left) kms_lease (lease-uevent)
[391.748368] Starting subtest: lease-uevent
[392.766453] Subtest lease-uevent: SUCCESS (1.019s)
[392.919440] [093/133] (635s left) gem_exec_schedule (u-semaphore-resolve)
[393.019626] Starting subtest: u-semaphore-resolve
[393.103300] Subtest u-semaphore-resolve: SUCCESS (0.084s)
[393.585952] [094/133] (635s left) kms_force_connector_basic (prune-stale-modes)
[393.691625] Starting subtest: prune-stale-modes
[393.714608] Subtest prune-stale-modes: SUCCESS (0.023s)
[394.088625] [095/133] (634s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[394.273751] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[394.276190] Starting dynamic subtest: pipe-A-DP-3
[394.279503] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[394.292020] Starting dynamic subtest: pipe-B-DP-3
[394.295417] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[394.307562] Starting dynamic subtest: pipe-C-DP-3
[394.310929] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[394.323069] Starting dynamic subtest: pipe-D-DP-3
[394.326331] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[394.328022] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.007s)
[394.751461] [096/133] (634s left) kms_content_protection (content-type-change)
[395.006534] Starting subtest: content-type-change
[395.012989] Subtest content-type-change: SKIP (0.003s)
[395.244487] [097/133] (633s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[395.435064] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[395.436826] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[395.593966] [098/133] (633s left) i915_pm_rps (min-max-config-loaded)
[395.679831] Starting subtest: min-max-config-loaded
[395.681596] Subtest min-max-config-loaded: SKIP (0.000s)
[395.843762] [099/133] (633s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[396.031868] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[398.760302] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (2.730s)
[399.009996] [100/133] (630s left) gem_ctx_persistence (legacy-engines-cleanup)
[399.097476] Starting subtest: legacy-engines-cleanup
[399.099884] Starting dynamic subtest: render
[399.206651] Dynamic subtest render: SUCCESS (0.108s)
[399.231942] Starting dynamic subtest: bsd1
[399.259626] Dynamic subtest bsd1: SUCCESS (0.050s)
[399.296351] Starting dynamic subtest: bsd2
[399.312505] Dynamic subtest bsd2: SUCCESS (0.050s)
[399.333769] Starting dynamic subtest: blt
[399.369408] Dynamic subtest blt: SUCCESS (0.055s)
[399.392240] Starting dynamic subtest: vebox
[399.418494] Dynamic subtest vebox: SUCCESS (0.047s)
[399.419531] Subtest legacy-engines-cleanup: SUCCESS (0.322s)
[399.637654] [101/133] (629s left) perf (rc6-disable)
[400.065888] Starting subtest: rc6-disable
[400.255889] Subtest rc6-disable: SUCCESS (0.189s)
[400.377009] [102/133] (628s left) kms_color (legacy-gamma-reset)
[400.561798] Starting subtest: legacy-gamma-reset
[400.562655] Starting dynamic subtest: pipe-A-DP-3
[400.794460] Dynamic subtest pipe-A-DP-3: SUCCESS (0.232s)
[400.809144] Starting dynamic subtest: pipe-B-DP-3
[400.819717] Dynamic subtest pipe-B-DP-3: SUCCESS (0.024s)
[400.835178] Starting dynamic subtest: pipe-C-DP-3
[400.843588] Dynamic subtest pipe-C-DP-3: SUCCESS (0.020s)
[400.857520] Starting dynamic subtest: pipe-D-DP-3
[400.865441] Dynamic subtest pipe-D-DP-3: SUCCESS (0.021s)
[400.866376] Subtest legacy-gamma-reset: SUCCESS (0.304s)
[401.124416] [103/133] (628s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[401.322074] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[401.323611] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[401.496634] [104/133] (628s left) gem_exec_alignment (forked)
[401.586384] Starting subtest: forked
[446.531667] Subtest forked: SUCCESS (44.951s)
[447.042209] [105/133] (582s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[447.280599] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[447.344754] [106/133] (582s left) gem_exec_fence (concurrent)
[447.572726] Starting subtest: concurrent
[447.576459] Subtest concurrent: SKIP (0.000s)
[448.362686] [107/133] (581s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[448.547448] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[448.611256] [108/133] (581s left) prime_self_import (reimport-vs-gem_close-race)
[448.659884] Starting subtest: reimport-vs-gem_close-race
[453.752325] Subtest reimport-vs-gem_close-race: SUCCESS (5.092s)
[453.969616] [109/133] (575s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[454.167776] Starting subtest: plane-downscale-factor-0-5-with-rotation
[454.168580] Starting dynamic subtest: pipe-A
[454.531528] Dynamic subtest pipe-A: SUCCESS (0.363s)
[454.561620] Starting dynamic subtest: pipe-B
[455.010724] Dynamic subtest pipe-B: SUCCESS (0.477s)
[455.041235] Starting dynamic subtest: pipe-C
[455.490399] Dynamic subtest pipe-C: SUCCESS (0.477s)
[455.512390] Starting dynamic subtest: pipe-D
[455.954400] Dynamic subtest pipe-D: SUCCESS (0.462s)
[455.955408] Subtest plane-downscale-factor-0-5-with-rotation: SUCCESS (1.787s)
[456.295738] [110/133] (573s left) kms_invalid_mode (uint-max-clock)
[456.493165] Starting subtest: uint-max-clock
[456.494030] Starting dynamic subtest: pipe-A-DP-3
[456.576662] Dynamic subtest pipe-A-DP-3: SUCCESS (0.083s)
[456.595928] Starting dynamic subtest: pipe-B-DP-3
[456.597202] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s)
[456.614275] Starting dynamic subtest: pipe-C-DP-3
[456.615263] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[456.628885] Starting dynamic subtest: pipe-D-DP-3
[456.629811] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s)
[456.630615] Subtest uint-max-clock: SUCCESS (0.095s)
[456.861941] [111/133] (573s left) syncobj_timeline (signal-array)
[456.947072] Starting subtest: signal-array
[456.948119] Subtest signal-array: SUCCESS (0.000s)
[457.110352] [112/133] (573s left) kms_big_fb (linear-8bpp-rotate-0)
[457.312464] Starting subtest: linear-8bpp-rotate-0
[459.018508] Subtest linear-8bpp-rotate-0: SUCCESS (1.683s)
[459.205400] [113/133] (571s left) gem_pxp (verify-pxp-stale-buf-execution)
[461.814602] Starting subtest: verify-pxp-stale-buf-execution
[461.816986] Subtest verify-pxp-stale-buf-execution: SKIP (0.000s)
[461.963233] [114/133] (568s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[462.146432] Starting subtest: 2x-long-cursor-vs-flip-atomic
[462.149443] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.002s)
[462.318470] [115/133] (568s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[462.510422] Starting subtest: x-tiled-32bpp-rotate-270
[462.563271] Subtest x-tiled-32bpp-rotate-270: SKIP (0.052s)
[462.797005] [116/133] (567s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[462.988291] Starting subtest: primary-x-tiled-reflect-x-180
[473.475098] Subtest primary-x-tiled-reflect-x-180: SUCCESS (10.486s)
[473.884871] [117/133] (556s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[474.079317] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[474.080999] Subtest psr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[474.286330] [118/133] (556s left) kms_atomic_transition (modeset-transition)
[474.471310] Starting subtest: modeset-transition
[474.472151] Starting dynamic subtest: 1x-outputs
[477.077095] Dynamic subtest 1x-outputs: SUCCESS (2.604s)
[477.082860] Subtest modeset-transition: SUCCESS (2.607s)
[477.370300] [119/133] (553s left) i915_drm_fdinfo (busy)
[477.438995] Starting subtest: busy
[477.439977] Starting dynamic subtest: rcs0
[477.465307] Dynamic subtest rcs0: SKIP (0.025s)
[477.478853] Starting dynamic subtest: bcs0
[477.481179] Dynamic subtest bcs0: SKIP (0.000s)
[477.493797] Starting dynamic subtest: vcs0
[477.496233] Dynamic subtest vcs0: SKIP (0.000s)
[477.508841] Starting dynamic subtest: vcs1
[477.511182] Dynamic subtest vcs1: SKIP (0.000s)
[477.523539] Starting dynamic subtest: vecs0
[477.525915] Dynamic subtest vecs0: SKIP (0.000s)
[477.541676] Starting dynamic subtest: vecs1
[477.543949] Dynamic subtest vecs1: SKIP (0.000s)
[477.556377] Starting dynamic subtest: ccs0
[477.558774] Dynamic subtest ccs0: SKIP (0.000s)
[477.561089] Subtest busy: SKIP (0.035s)
[477.607527] [120/133] (553s left) api_intel_bb (object-noreloc-keep-cache-simple)
[477.682653] Starting subtest: object-noreloc-keep-cache-simple
[477.709377] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.028s)
[477.925498] [121/133] (552s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[478.115139] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[478.116927] Subtest psr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[478.302889] [122/133] (552s left) gem_userptr_blits (stress-mm-invalidate-close)
[478.394647] Starting subtest: stress-mm-invalidate-close
[480.543220] Subtest stress-mm-invalidate-close: SUCCESS (2.148s)
[480.749128] [123/133] (550s left) gem_exec_capture (userptr)
[480.834355] Starting subtest: userptr
[481.795374] Subtest userptr: SUCCESS (0.962s)
[481.983747] [124/133] (549s left) gem_softpin (allocator-nopin)
[482.068010] Starting subtest: allocator-nopin
[482.308176] Subtest allocator-nopin: SUCCESS (0.240s)
[482.538198] [125/133] (548s left) syncobj_timeline (wait-delayed-signal)
[482.616324] Starting subtest: wait-delayed-signal
[482.719860] Subtest wait-delayed-signal: SUCCESS (0.103s)
[482.860349] [126/133] (548s left) gem_ctx_bad_destroy (invalid-pad)
[482.937765] Starting subtest: invalid-pad
[482.938618] Subtest invalid-pad: SUCCESS (0.000s)
[483.094429] [127/133] (548s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[483.291948] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[483.293722] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[483.486359] [128/133] (547s left) kms_dp_link_training (uhbr-mst)
[483.671605] Starting subtest: uhbr-mst
[483.673336] Subtest uhbr-mst: SKIP (0.000s)
[483.809351] [129/133] (547s left) vgem_basic (unload)
[483.855996] Starting subtest: unload
[512.851736] Subtest unload: SUCCESS (28.991s)
[513.047004] [130/133] (518s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[513.129681] Starting subtest: y-tiled-ccs-to-x-tiled
[513.131593] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[513.408705] [131/133] (518s left) kms_scaling_modes (scaling-mode-none)
[513.593241] Starting subtest: scaling-mode-none
[513.598169] Subtest scaling-mode-none: SKIP (0.001s)
[513.753839] [132/133] (518s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[513.949449] Starting subtest: y-tiled-addfb-size-offset-overflow
[513.951215] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[514.158977] [133/133] (517s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[514.358570] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[514.373854] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.014s)
[514.542829] Closing watchdogs
results: parsing output: 0/ for test: kms_ccs
results: parsing output: 1/ for test: gen7_exec_parse
results: parsing output: 2/ for test: gem_mmap
results: parsing output: 3/ for test: dumb_buffer
results: parsing output: 4/ for test: gem_exec_reloc
results: parsing output: 5/ for test: kms_ccs
results: parsing output: 6/ for test: kms_psr2_sf
results: parsing output: 7/ for test: kms_plane
results: parsing output: 8/ for test: gem_pxp
results: parsing output: 9/ for test: kms_flip_scaled_crc
results: parsing output: 10/ for test: syncobj_timeline
results: parsing output: 11/ for test: kms_async_flips
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: gem_watchdog
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: gem_exec_fence
results: parsing output: 17/ for test: gem_softpin
results: parsing output: 18/ for test: kms_flip
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: kms_plane
results: parsing output: 21/ for test: kms_universal_plane
results: parsing output: 22/ for test: gem_exec_reloc
results: parsing output: 23/ for test: i915_query
results: parsing output: 24/ for test: gem_mmap_gtt
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: kms_vrr
results: parsing output: 27/ for test: gem_exec_store
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: api_intel_allocator
results: parsing output: 31/ for test: gem_exec_schedule
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: i915_pm_rps
results: parsing output: 34/ for test: gem_exec_reloc
results: parsing output: 35/ for test: kms_pm_rpm
results: parsing output: 36/ for test: gem_ctx_exec
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: drm_read
results: parsing output: 39/ for test: kms_multipipe_modeset
results: parsing output: 40/ for test: kms_psr
results: parsing output: 41/ for test: perf_pmu
results: parsing output: 42/ for test: kms_cursor_legacy
results: parsing output: 43/ for test: kms_psr
results: parsing output: 44/ for test: kms_properties
results: parsing output: 45/ for test: gem_sync
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: gem_mmap_gtt
results: parsing output: 48/ for test: gem_cs_tlb
results: parsing output: 49/ for test: gem_userptr_blits
results: parsing output: 50/ for test: gem_exec_fence
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: syncobj_eventfd
results: parsing output: 53/ for test: kms_draw_crc
results: parsing output: 54/ for test: kms_flip_scaled_crc
results: parsing output: 55/ for test: gem_exec_flush
results: parsing output: 56/ for test: kms_vblank
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_cursor_legacy
results: parsing output: 59/ for test: gem_exec_await
results: parsing output: 60/ for test: gem_lmem_swapping
results: parsing output: 61/ for test: prime_vgem
results: parsing output: 62/ for test: i915_module_load
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: gem_exec_balancer
results: parsing output: 65/ for test: gem_mmap_gtt
results: parsing output: 66/ for test: gem_exec_reloc
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: gem_lmem_swapping
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_getfb
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: gem_exec_create
results: parsing output: 74/ for test: kms_chamelium_color
results: parsing output: 75/ for test: syncobj_wait
results: parsing output: 76/ for test: kms_cursor_crc
results: parsing output: 77/ for test: prime_vgem
results: parsing output: 78/ for test: syncobj_wait
results: parsing output: 79/ for test: gem_ctx_freq
results: parsing output: 80/ for test: kms_cursor_crc
results: parsing output: 81/ for test: gem_fence_thrash
results: parsing output: 82/ for test: syncobj_timeline
results: parsing output: 83/ for test: kms_flip_tiling
results: parsing output: 84/ for test: gem_ccs
results: parsing output: 85/ for test: kms_pm_rpm
results: parsing output: 86/ for test: kms_chamelium_hpd
results: parsing output: 87/ for test: kms_plane_scaling
results: parsing output: 88/ for test: kms_cursor_edge_walk
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_lease
results: parsing output: 92/ for test: gem_exec_schedule
results: parsing output: 93/ for test: kms_force_connector_basic
results: parsing output: 94/ for test: kms_ccs
results: parsing output: 95/ for test: kms_content_protection
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: i915_pm_rps
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: gem_ctx_persistence
results: parsing output: 100/ for test: perf
results: parsing output: 101/ for test: kms_color
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_exec_alignment
results: parsing output: 104/ for test: kms_psr2_sf
results: parsing output: 105/ for test: gem_exec_fence
results: parsing output: 106/ for test: kms_psr2_sf
results: parsing output: 107/ for test: prime_self_import
results: parsing output: 108/ for test: kms_plane_scaling
results: parsing output: 109/ for test: kms_invalid_mode
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: gem_pxp
results: parsing output: 113/ for test: kms_cursor_legacy
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: kms_rotation_crc
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_atomic_transition
results: parsing output: 118/ for test: i915_drm_fdinfo
results: parsing output: 119/ for test: api_intel_bb
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: gem_userptr_blits
results: parsing output: 122/ for test: gem_exec_capture
results: parsing output: 123/ for test: gem_softpin
results: parsing output: 124/ for test: syncobj_timeline
results: parsing output: 125/ for test: gem_ctx_bad_destroy
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_dp_link_training
results: parsing output: 128/ for test: vgem_basic
results: parsing output: 129/ for test: gem_render_copy
results: parsing output: 130/ for test: kms_scaling_modes
results: parsing output: 131/ for test: kms_big_fb
results: parsing output: 132/ for test: kms_flip
Done.