[85.825912] Initializing watchdogs
[85.826149]   /dev/watchdog0
[85.865840] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[85.880672] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[85.887796] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[85.893194] [001/133] (960s left) perf (polling-parameterized)
[86.153297] Starting subtest: polling-parameterized
[106.192031] Subtest polling-parameterized: SUCCESS (20.028s)
[106.281173] [002/133] (940s left) gem_exec_balancer (invalid-bonds)
[106.408664] Starting subtest: invalid-bonds
[106.417417] Subtest invalid-bonds: SUCCESS (0.009s)
[106.709740] [003/133] (939s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[106.816777] Starting subtest: multi-wait-for-submit-available-signaled
[106.821651] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.003s)
[106.959938] [004/133] (939s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[107.161360] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[107.163623] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[107.295535] [005/133] (939s left) gem_mmap (basic)
[107.398368] Starting subtest: basic
[107.405571] Subtest basic: SUCCESS (0.001s)
[107.531301] [006/133] (939s left) gem_exec_reloc (basic-softpin)
[107.648190] Starting subtest: basic-softpin
[107.653432] Subtest basic-softpin: SUCCESS (0.007s)
[107.846465] [007/133] (939s left) gem_exec_schedule (implicit-read-write)
[107.984881] Starting subtest: implicit-read-write
[107.993136] Starting dynamic subtest: rcs0
[108.124321] Dynamic subtest rcs0: SUCCESS (0.131s)
[108.141998] Starting dynamic subtest: bcs0
[108.252233] Dynamic subtest bcs0: SUCCESS (0.130s)
[108.288914] Starting dynamic subtest: vcs0
[108.381877] Dynamic subtest vcs0: SUCCESS (0.123s)
[108.409817] Starting dynamic subtest: vecs0
[108.494583] Dynamic subtest vecs0: SUCCESS (0.115s)
[108.495956] Subtest implicit-read-write: SUCCESS (0.504s)
[108.883824] [008/133] (938s left) gem_ctx_engines (independent)
[109.007142] Starting subtest: independent
[109.009100] Starting dynamic subtest: rcs0
[109.206692] Dynamic subtest rcs0: SUCCESS (0.196s)
[109.254875] Starting dynamic subtest: bcs0
[109.456462] Dynamic subtest bcs0: SUCCESS (0.243s)
[109.487149] Starting dynamic subtest: vcs0
[109.649079] Dynamic subtest vcs0: SUCCESS (0.195s)
[109.685410] Starting dynamic subtest: vecs0
[109.855995] Dynamic subtest vecs0: SUCCESS (0.200s)
[109.885161] Starting dynamic subtest: all-engines
[110.460931] Dynamic subtest all-engines: SUCCESS (0.614s)
[110.464129] Subtest independent: SUCCESS (1.456s)
[110.745227] [009/133] (936s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[110.946200] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[110.950072] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[111.080330] [010/133] (936s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[111.284297] Starting subtest: x-tiled-16bpp-rotate-0
[115.008176] Subtest x-tiled-16bpp-rotate-0: SUCCESS (3.718s)
[115.316508] [011/133] (931s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[115.510065] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.000s)
[115.600152] [012/133] (931s left) gem_exec_schedule (u-submit-early-slice)
[115.737991] Starting subtest: u-submit-early-slice
[115.741382] Starting dynamic subtest: rcs0
[115.794527] Dynamic subtest rcs0: SUCCESS (0.055s)
[115.818695] Starting dynamic subtest: bcs0
[115.849621] Dynamic subtest bcs0: SUCCESS (0.052s)
[115.870031] Starting dynamic subtest: vcs0
[115.900916] Dynamic subtest vcs0: SUCCESS (0.052s)
[115.922265] Starting dynamic subtest: vecs0
[115.943818] Dynamic subtest vecs0: SUCCESS (0.047s)
[115.945059] Subtest u-submit-early-slice: SUCCESS (0.209s)
[116.335732] [013/133] (930s left) fbdev (write)
[116.442662] Starting subtest: write
[117.227536] Subtest write: SUCCESS (0.784s)
[117.346322] [014/133] (930s left) sysfs_preempt_timeout (idempotent)
[117.462201] Starting subtest: idempotent
[117.465109] Starting dynamic subtest: vecs0
[117.466895] Dynamic subtest vecs0: SUCCESS (0.003s)
[117.496112] Starting dynamic subtest: vcs0
[117.497104] Dynamic subtest vcs0: SUCCESS (0.002s)
[117.515837] Starting dynamic subtest: bcs0
[117.517056] Dynamic subtest bcs0: SUCCESS (0.002s)
[117.535225] Starting dynamic subtest: rcs0
[117.536715] Dynamic subtest rcs0: SUCCESS (0.002s)
[117.537947] Subtest idempotent: SUCCESS (0.014s)
[117.605887] [015/133] (929s left) kms_content_protection (lic-type-0-hdcp14)
[117.800826] Starting subtest: lic-type-0-hdcp14
[117.842092] Subtest lic-type-0-hdcp14: SKIP (0.039s)
[117.979166] [016/133] (929s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[118.185102] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[118.425197] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.238s)
[118.678476] [017/133] (928s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[118.881119] Starting subtest: yf-tiled-32bpp-rotate-0
[123.920292] Subtest yf-tiled-32bpp-rotate-0: SUCCESS (5.038s)
[124.316925] [018/133] (923s left) gem_exec_async (forked-writes)
[124.441140] Starting subtest: forked-writes
[124.445136] Starting dynamic subtest: rcs0
[124.506088] Dynamic subtest rcs0: SUCCESS (0.059s)
[124.527172] Starting dynamic subtest: bcs0
[124.568697] Dynamic subtest bcs0: SUCCESS (0.061s)
[124.587773] Starting dynamic subtest: vcs0
[124.631534] Dynamic subtest vcs0: SUCCESS (0.064s)
[124.649791] Starting dynamic subtest: vecs0
[124.696180] Dynamic subtest vecs0: SUCCESS (0.061s)
[124.697233] Subtest forked-writes: SUCCESS (0.254s)
[124.953089] [019/133] (922s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[125.138170] Starting subtest: plane-lut1d-post-ctm3x4
[126.312092] Subtest plane-lut1d-post-ctm3x4: SKIP (1.178s)
[126.608379] [020/133] (921s left) gem_mmap_gtt (basic-wc)
[126.715063] Starting subtest: basic-wc
[127.341931] Subtest basic-wc: SUCCESS (0.631s)
[127.476170] [021/133] (920s left) gen7_exec_parse (load-register-reg)
[127.585094] Subtest load-register-reg: SKIP (0.000s)
[127.686372] [022/133] (920s left) gem_exec_suspend (basic-s3-devices)
[127.809610] Starting subtest: basic-S3-devices
[127.811146] Starting dynamic subtest: smem
[138.484803] Dynamic subtest smem: SUCCESS (10.677s)
[138.486162] Subtest basic-S3-devices: SUCCESS (10.679s)
[148.762313] [023/133] (909s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[148.962239] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[149.053094] [024/133] (909s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[149.241098] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[149.247173] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[149.385850] [025/133] (908s left) kms_feature_discovery (chamelium)
[149.565802] Starting subtest: chamelium
[149.568716] Subtest chamelium: SKIP (0.000s)
[149.693371] [026/133] (908s left) perf (whitelisted-registers-userspace-config)
[149.882089] Starting subtest: whitelisted-registers-userspace-config
[149.885113] Subtest whitelisted-registers-userspace-config: SUCCESS (0.002s)
[149.971492] [027/133] (908s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[150.159102] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[151.147259] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (1.010s)
[151.453752] [028/133] (907s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[151.636801] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[151.638537] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SKIP (0.000s)
[151.763966] [029/133] (906s left) gem_softpin (evict-snoop-interruptible)
[151.877132] Starting subtest: evict-snoop-interruptible
[151.879878] Subtest evict-snoop-interruptible: SKIP (0.000s)
[152.014500] [030/133] (906s left) kms_psr (fbc-pr-sprite-render)
[152.195624] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[152.290432] [031/133] (906s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[152.478447] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[152.484411] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[153.149286] [032/133] (905s left) gem_exec_store (pages)
[153.278926] Starting subtest: pages
[153.279869] Starting dynamic subtest: rcs0
[153.364824] Dynamic subtest rcs0: SUCCESS (0.090s)
[153.386490] Starting dynamic subtest: bcs0
[153.464311] Dynamic subtest bcs0: SUCCESS (0.091s)
[153.484165] Starting dynamic subtest: vcs0
[153.547245] Dynamic subtest vcs0: SUCCESS (0.085s)
[153.569190] Starting dynamic subtest: vecs0
[153.625983] Dynamic subtest vecs0: SUCCESS (0.081s)
[153.627266] Subtest pages: SUCCESS (0.357s)
[153.872689] [033/133] (905s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[154.070861] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[154.073187] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[154.200849] [034/133] (904s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[154.388234] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[157.914986] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SUCCESS (3.564s)
[158.125306] [035/133] (900s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[158.310050] Subtest psr2-overlay-plane-move-continuous-sf: SKIP (0.000s)
[158.394472] [036/133] (900s left) kms_dirtyfb (default-dirtyfb-ioctl)
[158.579167] Starting subtest: default-dirtyfb-ioctl
[158.583541] Starting dynamic subtest: A-HDMI-A-1
[160.263121] Dynamic subtest A-HDMI-A-1: SUCCESS (1.696s)
[160.297544] Starting dynamic subtest: A-HDMI-A-2
[161.880834] Dynamic subtest A-HDMI-A-2: SUCCESS (1.622s)
[161.882266] Subtest default-dirtyfb-ioctl: SUCCESS (3.328s)
[162.255108] [037/133] (896s left) syncobj_wait (invalid-signal-illegal-handle)
[162.359821] Starting subtest: invalid-signal-illegal-handle
[162.362448] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[162.491164] [038/133] (896s left) syncobj_wait (wait-all-delayed-signal)
[162.593941] Starting subtest: wait-all-delayed-signal
[162.701392] Subtest wait-all-delayed-signal: SUCCESS (0.106s)
[162.837446] [039/133] (896s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[163.120218] Starting subtest: basic-test-pattern-with-chamelium
[163.124323] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[163.254207] [040/133] (896s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[163.396081] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[163.397161] Starting dynamic subtest: pipe-A-HDMI-A-1
[163.412161] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[163.454481] Starting dynamic subtest: pipe-A-HDMI-A-2
[163.484425] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s)
[163.521348] Starting dynamic subtest: pipe-B-HDMI-A-1
[163.551482] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[163.588408] Starting dynamic subtest: pipe-B-HDMI-A-2
[163.604375] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s)
[163.623674] Starting dynamic subtest: pipe-C-HDMI-A-1
[163.632327] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[163.651530] Starting dynamic subtest: pipe-C-HDMI-A-2
[163.660297] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[163.661988] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.034s)
[164.428792] [041/133] (895s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[164.589702] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[164.591633] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[164.725975] [042/133] (894s left) gem_ctx_param (invalid-get-no-zeromap)
[164.824673] Starting subtest: invalid-get-no-zeromap
[164.826077] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[164.958791] [043/133] (894s left) prime_mmap (test_forked)
[165.063109] Starting subtest: test_forked
[165.065066] Starting dynamic subtest: test_forked-smem
[165.099977] Dynamic subtest test_forked-smem: SUCCESS (0.036s)
[165.101975] Subtest test_forked: SUCCESS (0.038s)
[165.224967] [044/133] (894s left) kms_vrr (flip-dpms)
[165.352099] Starting subtest: flip-dpms
[165.357964] Subtest flip-dpms: SKIP (0.000s)
[165.505803] [045/133] (894s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[165.643330] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[165.645285] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[165.772527] [046/133] (894s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[166.301216] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[166.579705] [047/133] (893s left) kms_pwrite_crc
[167.970691] [048/133] (892s left) gem_partial_pwrite_pread (write-display)
[168.091136] Starting subtest: write-display
[182.692893] Subtest write-display: SUCCESS (14.541s)
[182.837875] [049/133] (877s left) dmabuf_sync_file (import-multiple-read-write)
[183.049085] Starting subtest: import-multiple-read-write
[183.058900] Subtest import-multiple-read-write: SUCCESS (0.012s)
[183.185343] [FACT dmabuf_sync_file (import-multiple-read-write)] new: kernel.kmod_is_loaded.vgem: true
[183.189395] [050/133] (877s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[183.333158] Starting subtest: 2x-long-cursor-vs-flip-atomic
[235.892696] Subtest 2x-long-cursor-vs-flip-atomic: SUCCESS (52.430s)
[236.197176] [051/133] (824s left) gem_eio (wait-wedge-1us)
[236.338120] Starting subtest: wait-wedge-1us
[236.514337] Subtest wait-wedge-1us: SUCCESS (0.176s)
[236.698773] [052/133] (823s left) perf (polling)
[236.894197] Starting subtest: polling
[236.896169] Starting dynamic subtest: 0-rcs0
[246.940138] Dynamic subtest 0-rcs0: SUCCESS (10.037s)
[246.942181] Subtest polling: SUCCESS (10.041s)
[247.054939] [053/133] (813s left) kms_frontbuffer_tracking (psr-1p-rte)
[247.203855] Starting subtest: psr-1p-rte
[247.206876] Subtest psr-1p-rte: SKIP (0.000s)
[247.368647] [054/133] (813s left) kms_cursor_edge_walk (256x256-left-edge)
[247.502105] Starting subtest: 256x256-left-edge
[247.508267] Starting dynamic subtest: pipe-A-HDMI-A-1
[251.399558] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.891s)
[251.447082] Starting dynamic subtest: pipe-C-HDMI-A-1
[254.845242] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.437s)
[254.846936] Subtest 256x256-left-edge: SUCCESS (7.343s)
[255.210535] [055/133] (805s left) gem_tiling_max_stride
[255.528533] [056/133] (805s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[255.675316] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[258.615661] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (2.945s)
[258.810452] [057/133] (802s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[258.913140] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[259.017315] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.103s)
[259.158918] [058/133] (801s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[259.319978] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[259.323125] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[259.476808] [059/133] (801s left) kms_joiner (basic-big-joiner)
[259.621228] Starting subtest: basic-big-joiner
[259.625140] Subtest basic-big-joiner: SKIP (0.000s)
[259.759718] [060/133] (801s left) gem_render_copy_redux (flink)
[259.876682] Starting subtest: flink
[262.824613] Subtest flink: SUCCESS (2.942s)
[262.994615] [061/133] (798s left) kms_psr (pr-sprite-blt)
[263.140093] Subtest pr-sprite-blt: SKIP (0.000s)
[263.252756] [062/133] (798s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[263.394694] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[263.396648] Starting dynamic subtest: smem
[263.765752] Dynamic subtest smem: SUCCESS (0.374s)
[263.766742] Subtest y-tiled-ccs-to-yf-tiled-ccs: SUCCESS (0.377s)
[264.032805] [063/133] (797s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[264.189192] Starting subtest: y-tiled-addfb-size-offset-overflow
[264.191153] Subtest y-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[264.374567] [064/133] (797s left) i915_suspend (fence-restore-tiled2untiled)
[264.508975] Starting subtest: fence-restore-tiled2untiled
[284.527752] Subtest fence-restore-tiled2untiled: SUCCESS (4.755s)
[289.710314] [065/133] (777s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[289.859374] Starting subtest: primary-4-tiled-reflect-x-0
[289.862984] Subtest primary-4-tiled-reflect-x-0: SKIP (0.005s)
[290.018322] [066/133] (776s left) api_intel_allocator (gem-pool)
[290.119137] Starting subtest: gem-pool
[290.132534] Subtest gem-pool: SUCCESS (0.014s)
[290.310443] [067/133] (776s left) gem_lmem_swapping (parallel-random)
[290.422879] Subtest parallel-random: SKIP (0.000s)
[290.545336] [068/133] (776s left) syncobj_timeline (transfer-timeline-point)
[290.656373] Starting subtest: transfer-timeline-point
[290.660195] Subtest transfer-timeline-point: SUCCESS (0.002s)
[290.817728] [069/133] (776s left) gem_exec_flush (basic-uc-rw-default)
[290.945199] Starting subtest: basic-uc-rw-default
[296.518310] Subtest basic-uc-rw-default: SUCCESS (5.419s)
[296.778645] [070/133] (770s left) gem_exec_flush (basic-wb-set-default)
[296.905097] Starting subtest: basic-wb-set-default
[302.391635] Subtest basic-wb-set-default: SUCCESS (5.414s)
[302.654482] [071/133] (764s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[302.793296] Starting subtest: addfb25-x-tiled-mismatch-legacy
[302.795125] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[302.938036] [072/133] (764s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[303.081230] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[303.084532] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[303.254084] [073/133] (764s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[303.393715] Starting subtest: flip-vs-cursor-toggle
[327.764771] Subtest flip-vs-cursor-toggle: SUCCESS (24.303s)
[328.057766] [074/133] (739s left) kms_atomic_transition (plane-all-modeset-transition)
[328.203049] Starting subtest: plane-all-modeset-transition
[328.209085] Starting dynamic subtest: pipe-A-HDMI-A-1
[372.534679] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (44.304s)
[372.738206] Starting dynamic subtest: pipe-A-HDMI-A-2
[416.726568] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (44.016s)
[416.929438] Starting dynamic subtest: pipe-B-HDMI-A-1
[457.558686] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (40.649s)
[457.749071] Starting dynamic subtest: pipe-B-HDMI-A-2
[498.374357] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (40.640s)
[498.534143] Subtest plane-all-modeset-transition: SUCCESS (170.288s)
[498.871887] [075/133] (568s left) gem_eio (wait-10ms)
[499.025112] Starting subtest: wait-10ms
[499.111370] Subtest wait-10ms: SUCCESS (0.088s)
[499.306193] [076/133] (568s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[499.454129] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[499.457438] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[499.635891] [077/133] (568s left) kms_flip (bo-too-big)
[499.773198] Starting subtest: bo-too-big
[499.774564] Starting dynamic subtest: A-HDMI-A1
[500.896656] Dynamic subtest A-HDMI-A1: SUCCESS (1.122s)
[500.926046] Starting dynamic subtest: B-HDMI-A1
[501.734437] Dynamic subtest B-HDMI-A1: SUCCESS (0.821s)
[501.758661] Starting dynamic subtest: C-HDMI-A1
[502.524284] Dynamic subtest C-HDMI-A1: SUCCESS (0.793s)
[502.553667] Starting dynamic subtest: A-HDMI-A2
[503.333907] Dynamic subtest A-HDMI-A2: SUCCESS (0.806s)
[503.368009] Starting dynamic subtest: B-HDMI-A2
[504.137849] Dynamic subtest B-HDMI-A2: SUCCESS (0.798s)
[504.165863] Starting dynamic subtest: C-HDMI-A2
[504.981470] Dynamic subtest C-HDMI-A2: SUCCESS (0.842s)
[504.989289] Subtest bo-too-big: SUCCESS (5.215s)
[505.588910] [078/133] (562s left) gem_userptr_blits (mmap-offset-banned)
[505.722913] Starting subtest: mmap-offset-banned
[505.728272] Starting dynamic subtest: gtt
[505.730417] Dynamic subtest gtt: SUCCESS (0.001s)
[505.768475] Starting dynamic subtest: wb
[505.769740] Dynamic subtest wb: SUCCESS (0.001s)
[505.792737] Starting dynamic subtest: wc
[505.796136] Dynamic subtest wc: SUCCESS (0.000s)
[505.819210] Starting dynamic subtest: uc
[505.821568] Dynamic subtest uc: SUCCESS (0.001s)
[505.822852] Subtest mmap-offset-banned: SUCCESS (0.013s)
[505.907358] [079/133] (562s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[506.012393] Starting subtest: wait-all-for-submit-delayed-submit
[506.117263] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.104s)
[506.259225] [080/133] (561s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[506.399137] Starting subtest: primary-yf-tiled-reflect-x-0
[506.402034] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.003s)
[506.568885] [081/133] (561s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[506.713249] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[506.829316] [082/133] (561s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[506.997349] Starting subtest: 4-tiled-32bpp-rotate-90
[507.000616] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.000s)
[507.140300] [083/133] (561s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[507.282155] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[507.292127] Starting dynamic subtest: pipe-A-HDMI-A-1
[507.307103] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[507.358249] Starting dynamic subtest: pipe-A-HDMI-A-2
[507.387536] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s)
[507.432527] Starting dynamic subtest: pipe-B-HDMI-A-1
[507.461512] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[507.505549] Starting dynamic subtest: pipe-B-HDMI-A-2
[507.523844] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s)
[507.546955] Starting dynamic subtest: pipe-C-HDMI-A-1
[507.556201] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[507.581094] Starting dynamic subtest: pipe-C-HDMI-A-2
[507.588893] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[507.590484] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.054s)
[508.385505] [084/133] (560s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[508.493812] Starting subtest: etime-multi-wait-for-submit-submitted
[508.606061] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.106s)
[508.757715] [085/133] (559s left) kms_chamelium_color (ctm-0-50)
[508.891179] Subtest ctm-0-50: SKIP (0.000s)
[508.996301] [086/133] (559s left) kms_plane (plane-position-hole-dpms)
[509.142154] Starting subtest: plane-position-hole-dpms
[509.933205] Starting dynamic subtest: pipe-A-plane-1
[510.870152] Dynamic subtest pipe-A-plane-1: SUCCESS (0.936s)
[510.896495] Starting dynamic subtest: pipe-A-plane-2
[511.758903] Dynamic subtest pipe-A-plane-2: SUCCESS (0.890s)
[511.790743] Starting dynamic subtest: pipe-A-plane-3
[512.671899] Dynamic subtest pipe-A-plane-3: SUCCESS (0.905s)
[512.708805] Starting dynamic subtest: pipe-A-plane-4
[512.720238] Dynamic subtest pipe-A-plane-4: SUCCESS (0.015s)
[513.204466] Starting dynamic subtest: pipe-B-plane-1
[514.007182] Dynamic subtest pipe-B-plane-1: SUCCESS (0.852s)
[514.050262] Starting dynamic subtest: pipe-B-plane-2
[514.880780] Dynamic subtest pipe-B-plane-2: SUCCESS (0.866s)
[514.932127] Starting dynamic subtest: pipe-B-plane-3
[515.727788] Dynamic subtest pipe-B-plane-3: SUCCESS (0.849s)
[515.781213] Starting dynamic subtest: pipe-B-plane-4
[515.792264] Dynamic subtest pipe-B-plane-4: SUCCESS (0.010s)
[515.797326] Subtest plane-position-hole-dpms: SUCCESS (6.598s)
[516.078543] [087/133] (552s left) gem_exec_schedule (deep)
[516.351087] Starting subtest: deep
[516.353968] Starting dynamic subtest: rcs0
[529.596234] Dynamic subtest rcs0: SUCCESS (13.235s)
[529.679057] Starting dynamic subtest: bcs0
[544.122250] Dynamic subtest bcs0: SUCCESS (14.509s)
[544.154687] Starting dynamic subtest: vcs0
[557.571677] Dynamic subtest vcs0: SUCCESS (13.451s)
[557.652349] Starting dynamic subtest: vecs0
[571.465837] Dynamic subtest vecs0: SUCCESS (13.872s)
[571.469400] Subtest deep: SUCCESS (55.119s)
[572.618254] [088/133] (496s left) syncobj_basic (bad-create-flags)
[572.729664] Starting subtest: bad-create-flags
[572.730764] Subtest bad-create-flags: SUCCESS (0.000s)
[572.871457] [089/133] (496s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[573.455411] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[573.720538] [090/133] (495s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[573.871067] Starting subtest: map-fixed-invalidate-overlap-busy
[573.873071] Starting dynamic subtest: gtt
[577.792339] Dynamic subtest gtt: SUCCESS (3.921s)
[577.822189] Starting dynamic subtest: wb
[581.539843] Dynamic subtest wb: SUCCESS (3.742s)
[581.567317] Starting dynamic subtest: wc
[585.319688] Dynamic subtest wc: SUCCESS (3.776s)
[585.347177] Starting dynamic subtest: uc
[589.098775] Dynamic subtest uc: SUCCESS (3.776s)
[589.103582] Subtest map-fixed-invalidate-overlap-busy: SUCCESS (15.231s)
[589.271176] [091/133] (479s left) perf_pmu (enable-race)
[589.381207] Starting subtest: enable-race
[589.382521] Starting dynamic subtest: rcs0
[602.020571] Dynamic subtest rcs0: SUCCESS (12.639s)
[602.048805] Starting dynamic subtest: bcs0
[614.680080] Dynamic subtest bcs0: SUCCESS (12.651s)
[614.702813] Starting dynamic subtest: vcs0
[627.313113] Dynamic subtest vcs0: SUCCESS (12.630s)
[627.338366] Starting dynamic subtest: vecs0
[639.942764] Dynamic subtest vecs0: SUCCESS (12.622s)
[639.947037] Subtest enable-race: SUCCESS (50.560s)
[640.095110] [092/133] (429s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[640.226267] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[640.231143] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SKIP (0.000s)
[640.376855] [093/133] (429s left) syncobj_basic (illegal-fd-to-handle)
[640.482765] Starting subtest: illegal-fd-to-handle
[640.485633] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[640.624912] [094/133] (428s left) gem_render_copy (linear-to-vebox-y-tiled)
[640.747109] Starting subtest: linear-to-vebox-y-tiled
[640.749046] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[641.008532] [095/133] (428s left) gem_userptr_blits (dmabuf-sync)
[641.143441] Starting subtest: dmabuf-sync
[641.151916] Subtest dmabuf-sync: SKIP (0.008s)
[641.380889] [096/133] (428s left) kms_vrr (seamless-rr-switch-vrr)
[641.510099] Starting subtest: seamless-rr-switch-vrr
[641.515517] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[641.688521] [097/133] (428s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[641.832180] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[644.480442] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SUCCESS (2.648s)
[644.710813] [098/133] (425s left) gem_ctx_persistence (idempotent)
[644.829119] Starting subtest: idempotent
[644.830151] Subtest idempotent: SUCCESS (0.000s)
[644.993277] [099/133] (425s left) kms_frontbuffer_tracking (fbc-stridechange)
[645.139204] Starting subtest: fbc-stridechange
[647.181350] Subtest fbc-stridechange: SUCCESS (2.045s)
[647.459323] [100/133] (422s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[647.618059] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[647.622308] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[647.777329] [101/133] (422s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[647.925201] Starting subtest: cursor-rapid-movement-256x85
[647.968115] Starting dynamic subtest: pipe-A-HDMI-A-1
[648.876466] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.908s)
[648.993080] Starting dynamic subtest: pipe-C-HDMI-A-1
[649.559358] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.610s)
[649.565283] Subtest cursor-rapid-movement-256x85: SUCCESS (1.640s)
[649.909418] [102/133] (420s left) gem_softpin (allocator-evict)
[650.033360] Starting subtest: allocator-evict
[650.034894] Starting dynamic subtest: rcs0
[678.238304] Dynamic subtest rcs0: SUCCESS (28.198s)
[678.269920] Starting dynamic subtest: bcs0
[704.581882] Dynamic subtest bcs0: SUCCESS (26.333s)
[704.611135] Starting dynamic subtest: vcs0
[731.906577] Dynamic subtest vcs0: SUCCESS (27.311s)
[731.939854] Starting dynamic subtest: vecs0
[758.264121] Dynamic subtest vecs0: SUCCESS (26.347s)
[758.271349] Subtest allocator-evict: SUCCESS (108.211s)
[758.433498] [103/133] (311s left) gem_exec_reloc (basic-wc-active)
[758.664313] Starting subtest: basic-wc-active
[758.804325] Subtest basic-wc-active: SUCCESS (0.137s)
[758.990214] [104/133] (311s left) i915_hangman (error-state-basic)
[759.133189] Starting subtest: error-state-basic
[759.145788] Subtest error-state-basic: SUCCESS (0.012s)
[759.320617] [105/133] (311s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[759.453185] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[759.457189] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[759.626222] [106/133] (311s left) kms_psr (psr2-cursor-mmap-gtt)
[759.777152] Subtest psr2-cursor-mmap-gtt: SKIP (0.000s)
[759.899144] [107/133] (310s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[760.047044] Starting subtest: plane-upscale-20x20-with-pixel-format
[760.049073] Starting dynamic subtest: pipe-A
[761.124059] Dynamic subtest pipe-A: SUCCESS (1.077s)
[761.158359] Starting dynamic subtest: pipe-B
[762.275582] Dynamic subtest pipe-B: SUCCESS (1.145s)
[762.332553] Starting dynamic subtest: pipe-C
[762.705474] Dynamic subtest pipe-C: SUCCESS (0.426s)
[762.707109] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (2.661s)
[763.230544] [108/133] (307s left) gem_wait (invalid-flags)
[763.350276] Starting subtest: invalid-flags
[763.353292] Subtest invalid-flags: SUCCESS (0.000s)
[763.666391] [109/133] (307s left) i915_pm_rpm (gem-execbuf)
[765.531693] Starting subtest: gem-execbuf
[765.532892] Starting dynamic subtest: smem0
[766.983740] Dynamic subtest smem0: SUCCESS (1.446s)
[766.985112] Subtest gem-execbuf: SUCCESS (1.451s)
[767.315543] [110/133] (303s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[767.465313] Starting subtest: nonblocking-crc-frame-sequence
[767.467144] Starting dynamic subtest: pipe-A-HDMI-A-1
[768.520352] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.050s)
[768.589300] Starting dynamic subtest: pipe-B-HDMI-A-2
[769.246380] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.716s)
[769.289271] Starting dynamic subtest: pipe-C-HDMI-A-1
[769.972058] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.715s)
[769.975189] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.505s)
[770.281205] [111/133] (300s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[770.452285] Starting subtest: fbcpsr-tiling-4
[770.456447] Subtest fbcpsr-tiling-4: SKIP (0.000s)
[770.601310] [112/133] (300s left) kms_pm_dc (dc6-dpms)
[771.754091] Starting subtest: dc6-dpms
[771.759277] Subtest dc6-dpms: SKIP (0.000s)
[771.918544] [113/133] (299s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[772.060138] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[772.063130] Starting dynamic subtest: pipe-A-HDMI-A-1
[772.071062] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[772.124082] Starting dynamic subtest: pipe-A-HDMI-A-2
[772.133051] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s)
[772.185040] Starting dynamic subtest: pipe-B-HDMI-A-1
[772.195729] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[772.226261] Starting dynamic subtest: pipe-B-HDMI-A-2
[772.229464] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[772.255482] Starting dynamic subtest: pipe-C-HDMI-A-1
[772.258893] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[772.284823] Starting dynamic subtest: pipe-C-HDMI-A-2
[772.288318] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[772.290077] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SKIP (0.038s)
[773.115806] [114/133] (298s left) gem_exec_parallel (contexts)
[773.241869] Starting subtest: contexts
[773.244197] Starting dynamic subtest: rcs0
[777.527149] Dynamic subtest rcs0: SUCCESS (4.291s)
[777.570627] Starting dynamic subtest: bcs0
[782.201220] Dynamic subtest bcs0: SUCCESS (4.675s)
[782.233648] Starting dynamic subtest: vcs0
[796.722148] Dynamic subtest vcs0: SUCCESS (14.525s)
[796.756867] Starting dynamic subtest: vecs0
[800.780055] Dynamic subtest vecs0: SUCCESS (4.058s)
[800.783932] Subtest contexts: SUCCESS (27.564s)
[801.051406] [115/133] (270s left) kms_atomic (crtc-invalid-params-fence)
[801.196242] Starting subtest: crtc-invalid-params-fence
[801.200768] Starting dynamic subtest: pipe-A-HDMI-A-1
[801.888174] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.691s)
[801.890262] Subtest crtc-invalid-params-fence: SUCCESS (0.699s)
[802.263227] [116/133] (269s left) kms_frontbuffer_tracking (fbc-suspend)
[802.428081] Starting subtest: fbc-suspend