[57.848710] Initializing watchdogs
[57.848755]   /dev/watchdog0
[57.863327] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.867719] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.870136] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.872904] [001/155] (960s left) gem_exec_reloc (basic-write-read)
[57.956214] Subtest basic-write-read: SKIP (0.000s)
[58.032237] [002/155] (960s left) kms_invalid_mode (uint-max-clock)
[58.130292] Starting subtest: uint-max-clock
[58.132583] Starting dynamic subtest: pipe-A-eDP-1
[58.419768] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.291s)
[58.428688] Starting dynamic subtest: pipe-B-eDP-1
[58.430540] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[58.437520] Starting dynamic subtest: pipe-C-eDP-1
[58.439791] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[58.447203] Starting dynamic subtest: pipe-D-eDP-1
[58.449135] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[58.451079] Subtest uint-max-clock: SUCCESS (0.295s)
[59.231191] [003/155] (959s left) kms_plane_scaling (planes-downscale-factor-0-75)
[59.318076] Starting subtest: planes-downscale-factor-0-75
[59.320371] Starting dynamic subtest: pipe-A
[59.340515] Dynamic subtest pipe-A: SKIP (0.018s)
[59.348848] Starting dynamic subtest: pipe-B
[59.375856] Dynamic subtest pipe-B: SKIP (0.036s)
[59.383225] Starting dynamic subtest: pipe-C
[59.410886] Dynamic subtest pipe-C: SKIP (0.035s)
[59.418789] Starting dynamic subtest: pipe-D
[59.445753] Dynamic subtest pipe-D: SKIP (0.035s)
[59.450143] Subtest planes-downscale-factor-0-75: SKIP (0.124s)
[59.545697] [004/155] (958s left) kms_plane_multiple (2x-tiling-none)
[59.636334] Starting subtest: 2x-tiling-none
[59.640928] Subtest 2x-tiling-none: SKIP (0.000s)
[59.708565] [005/155] (958s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-indfb-pgflip-blt)
[59.800716] Starting subtest: psrhdr-1p-primscrn-indfb-pgflip-blt
[59.805225] Subtest psrhdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[59.902688] [006/155] (958s left) syncobj_timeline (multi-wait-signaled)
[59.956954] Starting subtest: multi-wait-signaled
[59.959668] Subtest multi-wait-signaled: SUCCESS (0.001s)
[60.067083] [007/155] (958s left) kms_color (legacy-gamma-reset)
[60.151979] Starting subtest: legacy-gamma-reset
[60.154451] Starting dynamic subtest: pipe-A-eDP-1
[60.531799] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.378s)
[60.540871] Starting dynamic subtest: pipe-B-eDP-1
[60.542732] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.011s)
[60.550157] Starting dynamic subtest: pipe-C-eDP-1
[60.554761] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[60.562051] Starting dynamic subtest: pipe-D-eDP-1
[60.566619] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[60.569116] Subtest legacy-gamma-reset: SUCCESS (0.413s)
[61.363864] [008/155] (957s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[61.472736] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[66.201056] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (4.729s)
[66.318588] [009/155] (952s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-blt)
[66.419110] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-blt
[66.423322] Subtest hdr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[66.531737] [010/155] (952s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[66.639625] Starting subtest: y-tiled-addfb-size-offset-overflow
[66.644048] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[66.732055] [011/155] (952s left) kms_chamelium_frames (hdmi-crc-single)
[67.111832] Subtest hdmi-crc-single: SKIP (0.000s)
[67.915649] [012/155] (950s left) kms_pm_rpm (fences-dpms)
[69.475107] Starting subtest: fences-dpms
[69.480315] Subtest fences-dpms: SKIP (0.000s)
[70.197323] [013/155] (948s left) gem_spin_batch (user-each)
[70.257082] Starting subtest: user-each
[73.617840] Subtest user-each: SUCCESS (3.357s)
[74.365183] [014/155] (944s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[74.464029] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[74.468615] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[74.555463] [015/155] (944s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[74.679435] Starting subtest: cursorA-vs-flipB-legacy
[74.683819] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[74.834467] [016/155] (944s left) gem_render_copy (linear-to-vebox-yf-tiled)
[74.901426] Starting subtest: linear-to-vebox-yf-tiled
[74.905905] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[75.094900] [017/155] (943s left) gem_ctx_exec (basic-nohangcheck)
[75.151691] Starting subtest: basic-nohangcheck
[75.400846] Subtest basic-nohangcheck: SUCCESS (0.250s)
[75.528199] [018/155] (943s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[75.624507] Starting subtest: 2x-plain-flip-ts-check-interruptible
[75.636453] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.011s)
[75.746858] [019/155] (943s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[75.844467] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[75.846885] Starting dynamic subtest: pipe-A-eDP-1
[75.872656] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[75.882122] Starting dynamic subtest: pipe-B-eDP-1
[75.906062] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[75.913298] Starting dynamic subtest: pipe-C-eDP-1
[75.937493] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[75.944857] Starting dynamic subtest: pipe-D-eDP-1
[75.969211] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[75.973640] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.002s)
[78.132172] [020/155] (940s left) gem_basic (create-close)
[78.189769] Starting subtest: create-close
[78.194111] Subtest create-close: SUCCESS (0.000s)
[78.275111] [021/155] (940s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[78.364138] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[78.375685] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.010s)
[78.451930] [022/155] (940s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[78.547412] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[78.551695] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[78.646928] [023/155] (940s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[78.745653] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[78.749879] Subtest hdr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[78.838293] [024/155] (940s left) gem_ctx_shared (q-smoketest-all)
[78.901916] Starting subtest: Q-smoketest-all
[111.305213] Subtest Q-smoketest-all: SUCCESS (32.349s)
[112.366314] [025/155] (906s left) kms_cursor_crc (cursor-random-128x42)
[112.586465] Starting subtest: cursor-random-128x42
[112.634738] Subtest cursor-random-128x42: SKIP (0.043s)
[112.827185] [026/155] (906s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[112.923393] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-mmap-wc
[112.927575] Subtest hdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[113.026080] [027/155] (906s left) kms_dp_linktrain_fallback (dsc-fallback)
[113.117765] Starting subtest: dsc-fallback
[113.124179] Subtest dsc-fallback: SKIP (0.000s)
[113.184967] [028/155] (906s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[113.231737] Subtest no-spare-fences-busy: SKIP (0.000s)
[113.298775] [029/155] (906s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[113.385992] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[113.389511] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[113.519495] [030/155] (905s left) kms_feature_discovery (display-4x)
[113.613366] Starting subtest: display-4x
[113.617441] Subtest display-4x: SKIP (0.000s)
[113.699299] [031/155] (905s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[113.800435] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[113.803860] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[113.906480] [032/155] (905s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[113.998196] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[114.001658] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[114.097742] [033/155] (905s left) kms_big_fb (linear-16bpp-rotate-270)
[114.201061] Starting subtest: linear-16bpp-rotate-270
[114.219887] Subtest linear-16bpp-rotate-270: SKIP (0.018s)
[114.331573] [034/155] (905s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-onoff)
[114.429477] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-onoff
[114.432928] Subtest fbchdr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[114.508264] [035/155] (905s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[114.556187] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[114.558083] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[114.647713] [036/155] (905s left) kms_cursor_crc (cursor-onscreen-128x42)
[114.856631] Starting subtest: cursor-onscreen-128x42
[114.902293] Subtest cursor-onscreen-128x42: SKIP (0.042s)
[115.112719] [037/155] (904s left) kms_frontbuffer_tracking (psrhdr-shrfb-scaledprimary)
[115.204307] Starting subtest: psrhdr-shrfb-scaledprimary
[115.208322] Subtest psrhdr-shrfb-scaledprimary: SKIP (0.000s)
[115.281353] [038/155] (904s left) gem_media_fill (media-fill)
[115.344301] Subtest media-fill: SKIP (0.000s)
[115.461756] [039/155] (904s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[115.555579] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[115.559080] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.000s)
[115.637265] [040/155] (904s left) vgem_basic (bad-handle)
[115.747292] Starting subtest: bad-handle
[115.749067] Subtest bad-handle: SUCCESS (0.000s)
[115.801224] [FACT vgem_basic (bad-handle)] new: kernel.kmod_is_loaded.vgem: true
[115.803868] [041/155] (904s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-onoff)
[115.891223] Starting subtest: fbchdr-1p-primscrn-spr-indfb-onoff
[115.894678] Subtest fbchdr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[115.985651] [042/155] (903s left) kms_pm_backlight (basic-brightness)
[116.077865] Starting subtest: basic-brightness
[116.125373] Starting dynamic subtest: eDP-1
[116.624706] Dynamic subtest eDP-1: SUCCESS (0.497s)
[116.627214] Subtest basic-brightness: SUCCESS (0.548s)
[117.472180] [043/155] (902s left) gem_ctx_bad_destroy (invalid-pad)
[117.528638] Starting subtest: invalid-pad
[117.530975] Subtest invalid-pad: SUCCESS (0.000s)
[117.599222] [044/155] (902s left) gem_exec_balancer (parallel-out-fence)
[117.845310] Starting subtest: parallel-out-fence
[118.991074] Subtest parallel-out-fence: SUCCESS (1.144s)
[119.094594] [045/155] (900s left) kms_vrr (max-min)
[119.185529] Starting subtest: max-min
[119.192509] Subtest max-min: SKIP (0.000s)
[119.260047] [046/155] (900s left) prime_vgem (sync)
[119.343676] Starting subtest: sync
[119.346154] Starting dynamic subtest: rcs0
[119.392156] Dynamic subtest rcs0: SUCCESS (0.048s)
[119.400214] Starting dynamic subtest: bcs0
[119.445258] Dynamic subtest bcs0: SUCCESS (0.052s)
[119.454122] Starting dynamic subtest: vcs0
[119.492745] Dynamic subtest vcs0: SUCCESS (0.047s)
[119.501532] Starting dynamic subtest: vcs1
[119.537425] Dynamic subtest vcs1: SUCCESS (0.044s)
[119.545935] Starting dynamic subtest: vecs0
[119.584261] Dynamic subtest vecs0: SUCCESS (0.046s)
[119.592535] Starting dynamic subtest: ccs0
[119.628958] Dynamic subtest ccs0: SUCCESS (0.044s)
[119.631199] Subtest sync: SUCCESS (0.286s)
[119.759762] [047/155] (900s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[119.876641] Starting subtest: short-flip-after-cursor-atomic-transitions
[120.840552] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.965s)
[121.711514] [048/155] (898s left) kms_plane_lowres (tiling-none)
[121.805827] Starting subtest: tiling-none
[121.808153] Starting dynamic subtest: pipe-A-eDP-1
[121.812621] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[122.109178] Starting dynamic subtest: pipe-B-eDP-1
[122.113896] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[122.122336] Starting dynamic subtest: pipe-C-eDP-1
[122.126992] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[122.135597] Starting dynamic subtest: pipe-D-eDP-1
[122.140619] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[122.145198] Subtest tiling-none: SKIP (0.299s)
[122.941971] [049/155] (897s left) gen9_exec_parse (bb-start-far)
[123.006698] Subtest bb-start-far: SKIP (0.000s)
[123.079983] [050/155] (897s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[123.176519] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[123.180650] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[123.255232] [051/155] (897s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-mmap-wc)
[123.351072] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-mmap-wc
[123.355209] Subtest hdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[123.441930] [052/155] (896s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-indfb-pgflip-blt)
[123.549212] Starting subtest: psrhdr-2p-scndscrn-indfb-pgflip-blt
[123.553394] Subtest psrhdr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[123.661576] [053/155] (896s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[123.778212] Starting subtest: cursorB-vs-flipB-varying-size
[123.782763] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[123.932870] [054/155] (896s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[124.029087] Starting subtest: psr-rgb101010-draw-render
[131.327378] Subtest psr-rgb101010-draw-render: SUCCESS (7.302s)
[131.476499] [055/155] (888s left) gem_exec_fence (syncobj-timeline-signal)
[132.011226] Starting subtest: syncobj-timeline-signal
[132.018578] Subtest syncobj-timeline-signal: SUCCESS (0.009s)
[133.389599] [056/155] (887s left) gem_exec_flush (basic-uc-ro-default)
[133.454409] Starting subtest: basic-uc-ro-default
[138.942670] Subtest basic-uc-ro-default: SUCCESS (5.454s)
[139.090029] [057/155] (881s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[139.199406] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[145.955744] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.761s)
[146.089757] [058/155] (874s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-mmap-cpu)
[146.185742] Starting subtest: fbchdr-rgb101010-draw-mmap-cpu
[146.189712] Subtest fbchdr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[146.274358] [059/155] (874s left) vgem_basic (dmabuf-mmap)
[146.317902] Starting subtest: dmabuf-mmap
[146.323279] Subtest dmabuf-mmap: SUCCESS (0.009s)
[146.392942] [060/155] (874s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[146.493998] Starting subtest: pr-primary-plane-update-sf-dmg-area
[146.498491] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[146.563760] [061/155] (874s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-mmap-cpu)
[146.668333] Starting subtest: psrhdr-rgb565-draw-mmap-cpu
[146.672556] Subtest psrhdr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[146.756028] [062/155] (873s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[146.872494] Starting subtest: 2x-flip-vs-cursor-legacy
[146.877208] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[147.028049] [063/155] (873s left) gem_exec_flush (basic-wb-rw-default)
[147.093500] Starting subtest: basic-wb-rw-default
[152.582539] Subtest basic-wb-rw-default: SUCCESS (5.465s)
[152.761530] [064/155] (868s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[152.865080] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[160.223978] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.364s)
[160.349887] [065/155] (860s left) fbdev (eof)
[160.387592] Starting subtest: eof
[160.389952] Subtest eof: SUCCESS (0.000s)
[160.470123] [066/155] (860s left) kms_busy (extended-pageflip-hang-oldfb)
[160.562600] Starting subtest: extended-pageflip-hang-oldfb
[160.564942] Starting dynamic subtest: pipe-A
[160.979519] Dynamic subtest pipe-A: SUCCESS (0.414s)
[160.987954] Starting dynamic subtest: pipe-D
[162.156873] Dynamic subtest pipe-D: SUCCESS (1.177s)
[162.159151] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.596s)
[163.003976] [067/155] (857s left) gem_userptr_blits (coherency-sync)
[163.072821] Starting subtest: coherency-sync
[163.403756] Subtest coherency-sync: SKIP (0.295s)
[163.505798] [068/155] (857s left) syncobj_timeline (wait-all-interrupted)
[163.630509] Starting subtest: wait-all-interrupted
[163.735450] Subtest wait-all-interrupted: SUCCESS (0.102s)
[163.841167] [069/155] (857s left) kms_atomic (plane-primary-legacy)
[163.950972] Starting subtest: plane-primary-legacy
[163.953189] Starting dynamic subtest: pipe-A-eDP-1
[164.417286] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.465s)
[164.419723] Subtest plane-primary-legacy: SUCCESS (0.467s)
[165.254329] [070/155] (855s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-onoff)
[165.351092] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-onoff
[165.355255] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[165.448330] [071/155] (855s left) i915_pm_rpm (sysfs-read)
[167.471057] Starting subtest: sysfs-read
[168.634117] Subtest sysfs-read: SUCCESS (1.161s)
[169.012329] [072/155] (852s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[169.107133] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[175.854666] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.753s)
[175.991637] [073/155] (845s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[176.090676] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[180.126904] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (4.043s)
[181.322450] [074/155] (839s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[181.430314] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[181.456179] Starting dynamic subtest: pipe-A-plane-0
[181.744587] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[181.753529] Starting dynamic subtest: pipe-A-plane-3
[181.978135] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s)
[181.986906] Starting dynamic subtest: pipe-A-plane-5
[181.991401] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[183.100462] Starting dynamic subtest: pipe-B-plane-0
[183.392327] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[183.401657] Starting dynamic subtest: pipe-B-plane-3
[183.625711] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[183.637654] Starting dynamic subtest: pipe-B-plane-5
[183.642313] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[183.949036] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.518s)
[184.791029] [075/155] (836s left) kms_color (ctm-0-25)
[184.883218] Starting subtest: ctm-0-25
[184.885189] Starting dynamic subtest: pipe-A-eDP-1
[188.496424] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.614s)
[188.506295] Starting dynamic subtest: pipe-B-eDP-1
[192.821118] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.323s)
[192.830091] Starting dynamic subtest: pipe-C-eDP-1
[196.947243] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.127s)
[196.956366] Starting dynamic subtest: pipe-D-eDP-1
[200.936540] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.989s)
[200.938881] Subtest ctm-0-25: SUCCESS (16.056s)
[201.761688] [076/155] (819s left) i915_drm_fdinfo (virtual-busy-all)
[201.812066] Starting subtest: virtual-busy-all
[201.816434] Subtest virtual-busy-all: SKIP (0.000s)
[201.883885] [077/155] (819s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-blt)
[201.985829] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-blt
[201.989935] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[202.093930] [078/155] (819s left) kms_psr (fbc-psr-cursor-plane-move)
[202.192061] Starting subtest: fbc-psr-cursor-plane-move
[202.194390] Starting dynamic subtest: eDP-1
[202.198534] Dynamic subtest eDP-1: SKIP (0.000s)
[202.202701] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[202.280870] [079/155] (819s left) kms_addfb_basic (bad-pitch-0)
[202.356754] Starting subtest: bad-pitch-0
[202.359040] Subtest bad-pitch-0: SUCCESS (0.000s)
[202.501249] [080/155] (818s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[202.603254] Starting subtest: yf-tiled-32bpp-rotate-0
[202.607941] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[202.702346] [081/155] (818s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-blt)
[202.804371] Starting subtest: fbcpsrhdr-rgb565-draw-blt
[202.807943] Subtest fbcpsrhdr-rgb565-draw-blt: SKIP (0.000s)
[202.907059] [082/155] (818s left) kms_psr (psr-sprite-mmap-gtt)
[202.999667] Starting subtest: psr-sprite-mmap-gtt
[203.002381] Starting dynamic subtest: eDP-1
[204.468720] Dynamic subtest eDP-1: SKIP (1.467s)
[204.473730] Subtest psr-sprite-mmap-gtt: SKIP (1.468s)
[204.625975] [083/155] (816s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[204.684373] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[204.791328] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.106s)
[204.872878] [084/155] (816s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[204.976933] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[204.981236] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[205.077849] [085/155] (816s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[205.178731] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[205.182746] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[205.296783] [086/155] (816s left) gem_close_race (basic-process)
[205.373174] Starting subtest: basic-process
[205.418067] Subtest basic-process: SUCCESS (0.044s)
[205.612747] [087/155] (816s left) gem_exec_whisper (basic-forked-all)
[205.668758] Starting subtest: basic-forked-all
[219.263734] Subtest basic-forked-all: SUCCESS (13.590s)
[219.461900] [088/155] (802s left) gem_workarounds (suspend-resume-context)
[219.544828] Starting subtest: suspend-resume-context
[235.855868] Subtest suspend-resume-context: SUCCESS (1.327s)
[236.005023] [089/155] (785s left) gem_exec_schedule (manyslice)
[236.092308] Starting subtest: manyslice
[236.094138] Starting dynamic subtest: rcs0
[240.749693] Dynamic subtest rcs0: SUCCESS (4.595s)
[240.762184] Starting dynamic subtest: bcs0
[247.402332] Dynamic subtest bcs0: SUCCESS (6.640s)
[247.415746] Starting dynamic subtest: vcs0
[252.994974] Dynamic subtest vcs0: SUCCESS (5.584s)
[253.005501] Starting dynamic subtest: vcs1
[258.579015] Dynamic subtest vcs1: SUCCESS (5.578s)
[258.590611] Starting dynamic subtest: vecs0
[264.656151] Dynamic subtest vecs0: SUCCESS (6.072s)
[264.667867] Starting dynamic subtest: ccs0
[270.315091] Dynamic subtest ccs0: SUCCESS (5.656s)
[270.317264] Subtest manyslice: SUCCESS (34.135s)
[270.572445] [090/155] (751s left) kms_prop_blob (invalid-get-prop)
[270.618804] Starting subtest: invalid-get-prop
[270.621110] Subtest invalid-get-prop: SUCCESS (0.000s)
[270.739901] [091/155] (751s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[270.845246] Starting subtest: psr2-plane-move-sf-dmg-area
[270.847702] Starting dynamic subtest: pipe-A-eDP-1
[275.422542] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.582s)
[275.433224] Starting dynamic subtest: pipe-B-eDP-1
[280.754314] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.331s)
[280.756765] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.915s)
[281.648888] [092/155] (740s left) gem_pread (exhaustion)
[281.707996] Subtest exhaustion: SKIP (0.000s)
[281.767126] [093/155] (740s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[281.864410] Starting subtest: 4-tiled-64bpp-rotate-180
[283.510096] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.645s)
[283.663943] [094/155] (738s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[283.770647] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[283.774133] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[283.876407] [095/155] (738s left) i915_query (query-regions-unallocated)
[283.931176] Starting subtest: query-regions-unallocated
[283.933015] Subtest query-regions-unallocated: SUCCESS (0.000s)
[284.045239] [096/155] (738s left) gem_mmap_offset (partial-remap)
[284.090121] Starting subtest: partial-remap
[284.092183] Starting dynamic subtest: smem0
[284.099533] Dynamic subtest smem0: SUCCESS (0.003s)
[284.101150] Subtest partial-remap: SUCCESS (0.004s)
[284.199953] [097/155] (737s left) gem_flink_basic (basic)
[284.261327] Starting subtest: basic
[284.263142] Subtest basic: SUCCESS (0.000s)
[284.375016] [098/155] (737s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[284.475680] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[284.477615] Starting dynamic subtest: pipe-A-eDP-1
[284.496447] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[284.506682] Starting dynamic subtest: pipe-B-eDP-1
[284.525064] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[284.534284] Starting dynamic subtest: pipe-C-eDP-1
[284.552336] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[284.561446] Starting dynamic subtest: pipe-D-eDP-1
[284.579548] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[284.583166] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[286.797394] [099/155] (735s left) kms_psr (psr-cursor-blt)
[286.889502] Starting subtest: psr-cursor-blt
[286.891792] Starting dynamic subtest: eDP-1
[288.589741] Dynamic subtest eDP-1: SUCCESS (1.701s)
[288.591917] Subtest psr-cursor-blt: SUCCESS (1.702s)
[289.455764] [100/155] (732s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[289.572820] Starting subtest: 2x-long-cursor-vs-flip-legacy
[289.577435] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.001s)
[289.720177] [101/155] (732s left) gem_basic (bad-close)
[289.779250] Starting subtest: bad-close
[289.783301] Subtest bad-close: SUCCESS (0.000s)
[289.876165] [102/155] (732s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[289.994236] Starting subtest: basic-busy-flip-before-cursor-legacy
[289.998517] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[290.138406] [103/155] (732s left) api_intel_bb (misplaced-blitter)
[290.187192] Starting subtest: misplaced-blitter
[290.192410] Subtest misplaced-blitter: SUCCESS (0.007s)
[290.324419] [104/155] (732s left) gem_exec_fence (syncobj-unused-fence)
[290.750998] Starting subtest: syncobj-unused-fence
[290.755833] Subtest syncobj-unused-fence: SUCCESS (0.004s)
[292.388995] [105/155] (730s left) gem_exec_balancer (bonded-pair)
[292.445658] Starting subtest: bonded-pair
[292.450404] Subtest bonded-pair: SKIP (0.000s)
[292.763884] [106/155] (729s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[292.871164] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt
[292.875020] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[292.961411] [107/155] (729s left) perf_pmu (busy-accuracy-2)
[292.999878] Starting subtest: busy-accuracy-2
[293.002233] Starting dynamic subtest: rcs0
[296.046226] Dynamic subtest rcs0: SUCCESS (3.042s)
[296.059868] Starting dynamic subtest: bcs0
[299.155373] Dynamic subtest bcs0: SUCCESS (3.055s)
[299.166886] Starting dynamic subtest: vcs0
[302.200083] Dynamic subtest vcs0: SUCCESS (3.043s)
[302.212607] Starting dynamic subtest: vcs1
[305.249809] Dynamic subtest vcs1: SUCCESS (3.046s)
[305.263948] Starting dynamic subtest: vecs0
[308.298167] Dynamic subtest vecs0: SUCCESS (3.045s)
[308.310151] Starting dynamic subtest: ccs0
[311.361224] Dynamic subtest ccs0: SUCCESS (3.059s)
[311.363456] Subtest busy-accuracy-2: SUCCESS (18.305s)
[311.429380] [108/155] (711s left) gem_reg_read (timestamp-moving)
[311.486438] Starting subtest: timestamp-moving
[312.487958] Subtest timestamp-moving: SUCCESS (1.001s)
[312.581363] [109/155] (710s left) kms_chamelium_color (ctm-negative)
[312.680285] Subtest ctm-negative: SKIP (0.000s)
[312.726755] [110/155] (709s left) kms_content_protection (legacy)
[312.879402] Starting subtest: legacy
[312.883906] Subtest legacy: SKIP (0.000s)
[313.028245] [111/155] (709s left) kms_legacy_colorkey (invalid-plane)
[313.120273] Starting subtest: invalid-plane
[313.122585] Starting dynamic subtest: zero-id
[313.124797] Dynamic subtest zero-id: SUCCESS (0.000s)
[313.135362] Starting dynamic subtest: outrange-id
[313.137246] Dynamic subtest outrange-id: SUCCESS (0.000s)
[313.139181] Subtest invalid-plane: SUCCESS (0.001s)
[313.191237] [112/155] (709s left) kms_psr (psr2-cursor-plane-move)
[313.291309] Starting subtest: psr2-cursor-plane-move
[313.293623] Starting dynamic subtest: eDP-1
[315.039422] Dynamic subtest eDP-1: SUCCESS (1.746s)
[315.042037] Subtest psr2-cursor-plane-move: SUCCESS (1.747s)
[315.924364] [113/155] (706s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[316.030249] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[316.034651] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[316.110791] [114/155] (706s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[316.197159] Starting subtest: primary-y-tiled-reflect-x-90
[316.201652] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[316.286344] [115/155] (706s left) kms_properties (get_properties-sanity-atomic)
[316.369380] Starting subtest: get_properties-sanity-atomic
[316.371703] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[316.450310] [116/155] (706s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[316.547989] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[320.971721] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.428s)
[322.122864] [117/155] (700s left) gem_mmap_wc (read)
[322.170808] Subtest read: SKIP (0.000s)
[322.241171] [118/155] (700s left) kms_cursor_crc (cursor-suspend)
[322.381868] Starting subtest: cursor-suspend
[322.384087] Starting dynamic subtest: pipe-A-eDP-1
[355.330787] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.162s)
[355.341494] Starting dynamic subtest: pipe-D-eDP-1
[389.304512] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.783s)
[389.307012] Subtest cursor-suspend: SUCCESS (6.948s)
[390.158672] [119/155] (632s left) prime_vgem (coherency-gtt)
[390.232287] Starting subtest: coherency-gtt
[390.237040] Subtest coherency-gtt: SKIP (0.000s)
[390.341545] [120/155] (632s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[390.435536] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf
[390.439983] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[390.532531] [121/155] (632s left) api_intel_bb (bb-with-allocator)
[390.596358] Starting subtest: bb-with-allocator
[390.601282] Subtest bb-with-allocator: SUCCESS (0.006s)
[390.718288] [122/155] (632s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[390.823982] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[390.827906] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[390.919658] [123/155] (632s left) gem_exec_schedule (promotion)
[390.982149] Starting subtest: promotion
[390.984375] Starting dynamic subtest: rcs0
[391.093463] Dynamic subtest rcs0: SUCCESS (0.119s)
[391.104360] Starting dynamic subtest: vcs0
[391.177905] Dynamic subtest vcs0: SUCCESS (0.083s)
[391.189104] Starting dynamic subtest: vcs1
[391.264638] Dynamic subtest vcs1: SUCCESS (0.085s)
[391.281074] Starting dynamic subtest: vecs0
[391.350282] Dynamic subtest vecs0: SUCCESS (0.085s)
[391.364436] Starting dynamic subtest: ccs0
[391.443558] Dynamic subtest ccs0: SUCCESS (0.093s)
[391.445867] Subtest promotion: SUCCESS (0.471s)
[392.360210] [124/155] (630s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[392.451932] Starting subtest: crc-primary-basic-yf-tiled-ccs
[392.454262] Starting dynamic subtest: pipe-A-eDP-1
[392.477869] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[392.489202] Starting dynamic subtest: pipe-B-eDP-1
[392.511057] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[392.520817] Starting dynamic subtest: pipe-C-eDP-1
[392.542482] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[392.552691] Starting dynamic subtest: pipe-D-eDP-1
[392.574614] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[392.578972] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.005s)
[394.697790] [125/155] (628s left) dumb_buffer (create-valid-dumb)
[394.766624] Starting subtest: create-valid-dumb
[394.768906] Subtest create-valid-dumb: SUCCESS (0.000s)
[394.858713] [126/155] (628s left) gem_exec_params (cliprects_ptr-dirt)
[394.910568] Starting subtest: cliprects_ptr-dirt
[394.912447] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[395.006197] [127/155] (628s left) i915_hangman (error-state-basic)
[395.087852] Starting subtest: error-state-basic
[395.242697] Subtest error-state-basic: SUCCESS (0.154s)
[395.322930] [128/155] (628s left) kms_psr (fbc-psr2-primary-page-flip)
[395.417797] Starting subtest: fbc-psr2-primary-page-flip
[395.419973] Starting dynamic subtest: eDP-1
[395.423965] Dynamic subtest eDP-1: SKIP (0.000s)
[395.428018] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[395.507633] [129/155] (628s left) kms_flip (absolute-wf_vblank-interruptible)
[395.609476] Starting subtest: absolute-wf_vblank-interruptible
[395.611813] Starting dynamic subtest: A-eDP1
[404.403174] Dynamic subtest A-eDP1: SUCCESS (8.756s)
[404.417200] Starting dynamic subtest: B-eDP1
[413.147631] Dynamic subtest B-eDP1: SUCCESS (8.737s)
[413.160107] Starting dynamic subtest: C-eDP1
[421.885805] Dynamic subtest C-eDP1: SUCCESS (8.722s)
[421.896201] Starting dynamic subtest: D-eDP1
[430.630649] Dynamic subtest D-eDP1: SUCCESS (8.733s)
[430.632999] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.962s)
[431.790735] [130/155] (591s left) gem_exec_whisper (basic-queues-forked)
[431.860389] Starting subtest: basic-queues-forked
[456.287090] Subtest basic-queues-forked: SUCCESS (24.364s)
[456.423956] [131/155] (567s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[456.524595] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[456.526924] Starting dynamic subtest: pipe-A-default-mode
[457.666562] Dynamic subtest pipe-A-default-mode: SKIP (1.139s)
[457.671037] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.140s)
[457.812517] [132/155] (565s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[457.919937] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[457.922181] Starting dynamic subtest: pipe-A-eDP-1
[459.287398] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.366s)
[459.567630] Starting dynamic subtest: pipe-B-eDP-1
[460.609181] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.052s)
[460.883012] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.963s)
[461.732261] [133/155] (561s left) gem_ctx_param (invalid-set-ringsize)
[461.778493] Starting subtest: invalid-set-ringsize
[461.780709] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[461.856087] [134/155] (561s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[461.954129] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu
[461.957948] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[462.071351] [135/155] (561s left) kms_frontbuffer_tracking (hdr-2p-primscrn-indfb-pgflip-blt)
[462.171701] Starting subtest: hdr-2p-primscrn-indfb-pgflip-blt
[462.176196] Subtest hdr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[462.286398] [136/155] (561s left) gem_userptr_blits (readonly-pwrite-unsync)
[462.358494] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[462.497904] [137/155] (561s left) gem_ppgtt (blt-vs-render-ctxn)
[462.559210] Starting subtest: blt-vs-render-ctxN
[495.320671] Subtest blt-vs-render-ctxN: SUCCESS (32.746s)
[495.443665] [138/155] (528s left) gem_wait (wait)
[495.550377] Starting subtest: wait
[495.553251] Starting dynamic subtest: all-engines
[497.229851] Dynamic subtest all-engines: SUCCESS (1.676s)
[497.242364] Starting dynamic subtest: rcs0
[498.276135] Dynamic subtest rcs0: SUCCESS (1.045s)
[498.289674] Starting dynamic subtest: bcs0
[499.324289] Dynamic subtest bcs0: SUCCESS (1.046s)
[499.341048] Starting dynamic subtest: vcs0
[500.371417] Dynamic subtest vcs0: SUCCESS (1.043s)
[500.385366] Starting dynamic subtest: vcs1
[501.416596] Dynamic subtest vcs1: SUCCESS (1.042s)
[501.430243] Starting dynamic subtest: vecs0
[502.462410] Dynamic subtest vecs0: SUCCESS (1.043s)
[502.476132] Starting dynamic subtest: ccs0
[503.510355] Dynamic subtest ccs0: SUCCESS (1.045s)
[503.513017] Subtest wait: SUCCESS (7.957s)
[503.715374] [139/155] (520s left) perf_pmu (init-sema)
[503.758842] Starting subtest: init-sema
[503.761233] Starting dynamic subtest: rcs0
[503.763584] Dynamic subtest rcs0: SUCCESS (0.002s)
[503.774717] Starting dynamic subtest: bcs0
[503.776545] Dynamic subtest bcs0: SUCCESS (0.000s)
[503.786390] Starting dynamic subtest: vcs0
[503.788267] Dynamic subtest vcs0: SUCCESS (0.001s)
[503.798459] Starting dynamic subtest: vcs1
[503.800360] Dynamic subtest vcs1: SUCCESS (0.001s)
[503.810304] Starting dynamic subtest: vecs0
[503.813430] Dynamic subtest vecs0: SUCCESS (0.000s)
[503.823801] Starting dynamic subtest: ccs0
[503.825964] Dynamic subtest ccs0: SUCCESS (0.001s)
[503.828199] Subtest init-sema: SUCCESS (0.009s)
[503.889681] [140/155] (520s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[503.987998] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[503.999355] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.010s)
[504.080172] [141/155] (519s left) kms_plane_scaling (2x-scaler-multi-pipe)
[504.173431] Starting subtest: 2x-scaler-multi-pipe
[504.177921] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[504.275674] [142/155] (519s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[504.370718] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[504.375158] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[504.481585] [143/155] (519s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-pwrite)
[504.575679] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-pwrite
[504.580062] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[504.684048] [144/155] (519s left) gem_ctx_persistence (userptr)
[504.746786] Starting subtest: userptr
[504.934354] Subtest userptr: SUCCESS (0.187s)
[505.016197] [145/155] (519s left) drm_read (invalid-buffer)
[505.180189] Starting subtest: invalid-buffer
[505.182266] Subtest invalid-buffer: SUCCESS (0.000s)
[505.315969] [146/155] (518s left) kms_3d (basic)
[505.370473] Starting subtest: basic
[507.626691] Subtest basic: SUCCESS (2.257s)
[508.096404] [147/155] (516s left) syncobj_timeline (multi-wait-all-available-signaled)
[508.165175] Starting subtest: multi-wait-all-available-signaled
[508.167592] Subtest multi-wait-all-available-signaled: SUCCESS (0.000s)
[508.245982] [148/155] (516s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[508.348262] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[508.352347] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[508.442300] [149/155] (515s left) kms_sequence (queue-busy)
[508.526958] Starting subtest: queue-busy
[508.529192] Starting dynamic subtest: pipe-A-eDP-1
[510.452410] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.925s)
[510.464564] Starting dynamic subtest: pipe-B-eDP-1
[513.039817] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.585s)
[513.051468] Starting dynamic subtest: pipe-C-eDP-1
[515.609073] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.567s)
[515.621541] Starting dynamic subtest: pipe-D-eDP-1
[518.205013] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.591s)
[518.207212] Subtest queue-busy: SUCCESS (9.673s)
[519.063573] [150/155] (505s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[519.162181] Starting subtest: x-tiled-16bpp-rotate-0
[520.541258] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.379s)
[520.684470] [151/155] (503s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[520.769263] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[520.771149] Starting dynamic subtest: pipe-A-eDP-1
[520.789735] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[520.800438] Starting dynamic subtest: pipe-B-eDP-1
[520.817400] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[520.827415] Starting dynamic subtest: pipe-C-eDP-1
[520.845251] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[520.855162] Starting dynamic subtest: pipe-D-eDP-1
[520.873030] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[520.876616] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[523.060827] [152/155] (501s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-render)
[523.159002] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-render
[523.163047] Subtest psrhdr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[523.262869] [153/155] (501s left) gem_softpin (32b-excludes-last-page)
[523.330129] Starting subtest: 32b-excludes-last-page
[523.334955] Subtest 32b-excludes-last-page: SUCCESS (0.003s)
[523.447154] [154/155] (501s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[523.491791] Starting subtest: multi-wait-all-for-submit-unsubmitted
[523.600559] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.108s)
[523.677341] [155/155] (500s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[523.788914] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[523.793377] Subtest hdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[523.882443] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_reloc
results: parsing output: 1/ for test: kms_invalid_mode
results: parsing output: 2/ for test: kms_plane_scaling
results: parsing output: 3/ for test: kms_plane_multiple
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: kms_color
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: kms_chamelium_frames
results: parsing output: 11/ for test: kms_pm_rpm
results: parsing output: 12/ for test: gem_spin_batch
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_cursor_legacy
results: parsing output: 15/ for test: gem_render_copy
results: parsing output: 16/ for test: gem_ctx_exec
results: parsing output: 17/ for test: kms_flip
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: gem_basic
results: parsing output: 20/ for test: kms_flip
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: gem_ctx_shared
results: parsing output: 24/ for test: kms_cursor_crc
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_dp_linktrain_fallback
results: parsing output: 27/ for test: gem_fenced_exec_thrash
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_feature_discovery
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: syncobj_timeline
results: parsing output: 35/ for test: kms_cursor_crc
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_media_fill
results: parsing output: 38/ for test: kms_flip_scaled_crc
results: parsing output: 39/ for test: vgem_basic
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_pm_backlight
results: parsing output: 42/ for test: gem_ctx_bad_destroy
results: parsing output: 43/ for test: gem_exec_balancer
results: parsing output: 44/ for test: kms_vrr
results: parsing output: 45/ for test: prime_vgem
results: parsing output: 46/ for test: kms_cursor_legacy
results: parsing output: 47/ for test: kms_plane_lowres
results: parsing output: 48/ for test: gen9_exec_parse
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_cursor_legacy
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_exec_fence
results: parsing output: 55/ for test: gem_exec_flush
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: vgem_basic
results: parsing output: 59/ for test: kms_psr2_sf
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_cursor_legacy
results: parsing output: 62/ for test: gem_exec_flush
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: fbdev
results: parsing output: 65/ for test: kms_busy
results: parsing output: 66/ for test: gem_userptr_blits
results: parsing output: 67/ for test: syncobj_timeline
results: parsing output: 68/ for test: kms_atomic
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: i915_pm_rpm
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_plane
results: parsing output: 74/ for test: kms_color
results: parsing output: 75/ for test: i915_drm_fdinfo
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_psr
results: parsing output: 78/ for test: kms_addfb_basic
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: syncobj_timeline
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: gem_close_race
results: parsing output: 86/ for test: gem_exec_whisper
results: parsing output: 87/ for test: gem_workarounds
results: parsing output: 88/ for test: gem_exec_schedule
results: parsing output: 89/ for test: kms_prop_blob
results: parsing output: 90/ for test: kms_psr2_sf
results: parsing output: 91/ for test: gem_pread
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: i915_query
results: parsing output: 95/ for test: gem_mmap_offset
results: parsing output: 96/ for test: gem_flink_basic
results: parsing output: 97/ for test: kms_ccs
results: parsing output: 98/ for test: kms_psr
results: parsing output: 99/ for test: kms_cursor_legacy
results: parsing output: 100/ for test: gem_basic
results: parsing output: 101/ for test: kms_cursor_legacy
results: parsing output: 102/ for test: api_intel_bb
results: parsing output: 103/ for test: gem_exec_fence
results: parsing output: 104/ for test: gem_exec_balancer
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: perf_pmu
results: parsing output: 107/ for test: gem_reg_read
results: parsing output: 108/ for test: kms_chamelium_color
results: parsing output: 109/ for test: kms_content_protection
results: parsing output: 110/ for test: kms_legacy_colorkey
results: parsing output: 111/ for test: kms_psr
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_rotation_crc
results: parsing output: 114/ for test: kms_properties
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: gem_mmap_wc
results: parsing output: 117/ for test: kms_cursor_crc
results: parsing output: 118/ for test: prime_vgem
results: parsing output: 119/ for test: kms_psr2_sf
results: parsing output: 120/ for test: api_intel_bb
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: gem_exec_schedule
results: parsing output: 123/ for test: kms_ccs
results: parsing output: 124/ for test: dumb_buffer
results: parsing output: 125/ for test: gem_exec_params
results: parsing output: 126/ for test: i915_hangman
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: kms_flip
results: parsing output: 129/ for test: gem_exec_whisper
results: parsing output: 130/ for test: kms_flip_scaled_crc
results: parsing output: 131/ for test: kms_atomic_transition
results: parsing output: 132/ for test: gem_ctx_param
results: parsing output: 133/ for test: kms_frontbuffer_tracking
results: parsing output: 134/ for test: kms_frontbuffer_tracking
results: parsing output: 135/ for test: gem_userptr_blits
results: parsing output: 136/ for test: gem_ppgtt
results: parsing output: 137/ for test: gem_wait
results: parsing output: 138/ for test: perf_pmu
results: parsing output: 139/ for test: kms_flip
results: parsing output: 140/ for test: kms_plane_scaling
results: parsing output: 141/ for test: kms_frontbuffer_tracking
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: gem_ctx_persistence
results: parsing output: 144/ for test: drm_read
results: parsing output: 145/ for test: kms_3d
results: parsing output: 146/ for test: syncobj_timeline
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: kms_sequence
results: parsing output: 149/ for test: kms_big_fb
results: parsing output: 150/ for test: kms_ccs
results: parsing output: 151/ for test: kms_frontbuffer_tracking
results: parsing output: 152/ for test: gem_softpin
results: parsing output: 153/ for test: syncobj_wait
results: parsing output: 154/ for test: kms_frontbuffer_tracking
Done.