[59.019244] Initializing watchdogs
[59.019288]   /dev/watchdog0
[59.033036] [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]
[59.037293] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.039484] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.042300] [001/131] (960s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[59.152069] Starting subtest: plane-downscale-factor-0-5-with-rotation
[59.154409] Starting dynamic subtest: pipe-A
[59.163296] Dynamic subtest pipe-A: SKIP (0.005s)
[59.171579] Starting dynamic subtest: pipe-B
[59.183484] Dynamic subtest pipe-B: SKIP (0.019s)
[59.189994] Starting dynamic subtest: pipe-C
[59.201391] Dynamic subtest pipe-C: SKIP (0.019s)
[59.207647] Starting dynamic subtest: pipe-D
[59.219264] Dynamic subtest pipe-D: SKIP (0.019s)
[59.223601] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.063s)
[59.305670] [002/131] (960s left) gem_exec_reloc (basic-gtt-cpu)
[59.375546] Subtest basic-gtt-cpu: SKIP (0.000s)
[59.435389] [003/131] (960s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[59.547155] Starting subtest: cursorA-vs-flipA-toggle
[70.697951] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.178s)
[71.577109] [004/131] (948s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[71.694375] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[71.797921] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.103s)
[72.102922] [005/131] (947s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[72.194812] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[72.196977] Starting dynamic subtest: pipe-A-eDP-1
[72.216938] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[72.225192] Starting dynamic subtest: pipe-B-eDP-1
[72.245428] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[72.251747] Starting dynamic subtest: pipe-C-eDP-1
[72.271651] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[72.278234] Starting dynamic subtest: pipe-D-eDP-1
[72.297971] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[72.300266] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.003s)
[74.306107] [006/131] (945s left) gem_ctx_shared (q-smoketest)
[74.371965] Starting subtest: Q-smoketest
[74.374464] Starting dynamic subtest: rcs0
[79.932375] Dynamic subtest rcs0: SUCCESS (5.512s)
[79.939207] Starting dynamic subtest: bcs0
[85.437882] Dynamic subtest bcs0: SUCCESS (5.505s)
[85.445694] Starting dynamic subtest: vcs0
[90.902753] Dynamic subtest vcs0: SUCCESS (5.467s)
[90.910635] Starting dynamic subtest: vcs1
[96.393455] Dynamic subtest vcs1: SUCCESS (5.483s)
[96.404126] Starting dynamic subtest: vecs0
[101.853822] Dynamic subtest vecs0: SUCCESS (5.467s)
[101.860888] Starting dynamic subtest: ccs0
[107.359421] Dynamic subtest ccs0: SUCCESS (5.503s)
[107.361417] Subtest Q-smoketest: SUCCESS (32.938s)
[107.495564] [007/131] (912s left) kms_addfb_basic (too-high)
[107.606973] Starting subtest: too-high
[107.609438] Subtest too-high: SUCCESS (0.000s)
[107.714326] [008/131] (912s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[107.817887] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[107.822684] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[107.914053] [009/131] (911s left) prime_busy (before-wait)
[107.973461] Starting subtest: before-wait
[107.978549] Starting dynamic subtest: rcs0
[108.016459] Dynamic subtest rcs0: SUCCESS (0.040s)
[108.025310] Starting dynamic subtest: bcs0
[108.080119] Dynamic subtest bcs0: SUCCESS (0.064s)
[108.089092] Starting dynamic subtest: vcs0
[108.120602] Dynamic subtest vcs0: SUCCESS (0.040s)
[108.128341] Starting dynamic subtest: vcs1
[108.161510] Dynamic subtest vcs1: SUCCESS (0.041s)
[108.169678] Starting dynamic subtest: vecs0
[108.202663] Dynamic subtest vecs0: SUCCESS (0.041s)
[108.209710] Starting dynamic subtest: ccs0
[108.243437] Dynamic subtest ccs0: SUCCESS (0.041s)
[108.351474] Subtest before-wait: SUCCESS (0.376s)
[108.421167] [010/131] (911s left) drm_read (empty-block)
[108.582496] Starting subtest: empty-block
[109.583403] Subtest empty-block: SUCCESS (1.001s)
[109.735227] [011/131] (910s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[114.757449] Starting subtest: psr2-cursor-plane-move-continuous-sf
[114.759643] Starting dynamic subtest: pipe-A-eDP-1
[125.824816] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.066s)
[125.834797] Starting dynamic subtest: pipe-B-eDP-1
[136.839866] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.014s)
[136.842195] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (22.083s)
[137.629197] [012/131] (882s left) gem_exec_balancer (full-pulse)
[137.697920] Starting subtest: full-pulse
[142.814226] Subtest full-pulse: SUCCESS (5.116s)
[143.150819] [013/131] (876s left) gem_exec_schedule (preempt-queue)
[143.223179] Subtest preempt-queue: SKIP (0.000s)
[143.506888] [014/131] (876s left) gem_busy (close-race)
[143.569897] Starting subtest: close-race
[166.929922] Subtest close-race: SUCCESS (23.357s)
[167.333926] [FACT gem_busy (close-race)] new: kernel.kmod_is_loaded.vgem: true
[167.339015] [015/131] (852s left) kms_selftest (drm_dp_mst_helper)
[167.425477] Starting subtest: drm_dp_mst_helper
[167.448175] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[167.571586] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.123s)
[167.579531] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[167.682100] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.110s)
[167.690262] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[167.800247] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.120s)
[167.802223] Subtest drm_dp_mst_helper: SUCCESS (0.375s)
[167.989398] [016/131] (852s left) gem_exec_basic (basic)
[168.043774] Starting subtest: basic
[168.046083] Starting dynamic subtest: rcs0-smem
[168.048509] Dynamic subtest rcs0-smem: SUCCESS (0.004s)
[168.057997] Starting dynamic subtest: bcs0-smem
[168.060050] Dynamic subtest bcs0-smem: SUCCESS (0.003s)
[168.067718] Starting dynamic subtest: vcs0-smem
[168.069995] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[168.077688] Starting dynamic subtest: vcs1-smem
[168.080053] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[168.088036] Starting dynamic subtest: vecs0-smem
[168.090744] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[168.100356] Starting dynamic subtest: ccs0-smem
[168.102602] Dynamic subtest ccs0-smem: SUCCESS (0.003s)
[168.104842] Subtest basic: SUCCESS (0.017s)
[169.917406] [017/131] (850s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[170.016946] Starting subtest: primary-yf-tiled-reflect-x-270
[170.021595] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[170.120665] [018/131] (850s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[170.173361] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[170.175576] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[170.283590] [019/131] (849s left) kms_psr (psr2-primary-mmap-cpu)
[170.384152] Starting subtest: psr2-primary-mmap-cpu
[170.386521] Starting dynamic subtest: eDP-1
[172.107658] Dynamic subtest eDP-1: SUCCESS (1.723s)
[172.109910] Subtest psr2-primary-mmap-cpu: SUCCESS (1.723s)
[172.980547] [020/131] (847s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[173.087469] Starting subtest: 4-tiled-32bpp-rotate-180
[174.720407] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.633s)
[174.952142] [021/131] (845s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[175.063147] Starting subtest: extended-modeset-hang-newfb-with-reset
[175.065383] Starting dynamic subtest: pipe-A
[189.050948] Dynamic subtest pipe-A: SUCCESS (13.983s)
[189.060247] Starting dynamic subtest: pipe-D
[204.931833] Dynamic subtest pipe-D: SUCCESS (15.881s)
[204.934211] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (29.868s)
[205.723267] [022/131] (814s left) gem_busy (semaphore)
[205.905126] Subtest semaphore: SKIP (0.000s)
[206.133718] [023/131] (814s left) perf (missing-sample-flags)
[206.261753] Starting subtest: missing-sample-flags
[206.264118] Subtest missing-sample-flags: SUCCESS (0.000s)
[206.304934] [024/131] (814s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[206.395102] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[210.379787] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.988s)
[211.520053] [025/131] (808s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[211.638950] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[213.031928] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.391s)
[213.836298] [026/131] (806s left) kms_color (ctm-0-50)
[213.934873] Starting subtest: ctm-0-50
[213.937084] Starting dynamic subtest: pipe-A-eDP-1
[217.313639] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.377s)
[217.323964] Starting dynamic subtest: pipe-B-eDP-1
[221.388079] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.072s)
[221.399065] Starting dynamic subtest: pipe-C-eDP-1
[225.377110] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.991s)
[225.388322] Starting dynamic subtest: pipe-D-eDP-1
[229.280315] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.902s)
[229.282840] Subtest ctm-0-50: SUCCESS (15.343s)
[230.130050] [027/131] (790s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[230.188096] Starting subtest: invalid-multi-wait-unsubmitted
[230.190318] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[230.300172] [028/131] (790s left) kms_getfb (getfb-handle-closed)
[230.397140] Starting subtest: getfb-handle-closed
[230.399473] Subtest getfb-handle-closed: SUCCESS (0.000s)
[230.519335] [029/131] (790s left) perf_pmu (render-node-busy)
[230.586742] Starting subtest: render-node-busy
[230.589215] Starting dynamic subtest: rcs0
[231.192539] Dynamic subtest rcs0: SUCCESS (0.605s)
[231.203629] Starting dynamic subtest: bcs0
[231.748468] Dynamic subtest bcs0: SUCCESS (0.555s)
[231.759961] Starting dynamic subtest: vcs0
[232.917193] Dynamic subtest vcs0: SUCCESS (1.165s)
[232.926592] Starting dynamic subtest: vcs1
[234.899357] Dynamic subtest vcs1: SUCCESS (1.981s)
[234.911607] Starting dynamic subtest: vecs0
[236.884403] Dynamic subtest vecs0: SUCCESS (1.983s)
[236.895038] Starting dynamic subtest: ccs0
[237.457358] Dynamic subtest ccs0: SUCCESS (0.573s)
[237.459806] Subtest render-node-busy: SUCCESS (6.871s)
[237.534770] [030/131] (783s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[237.637302] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[237.641367] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[237.755441] [031/131] (783s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[237.838183] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[237.840505] Starting dynamic subtest: pipe-A-eDP-1
[237.911318] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.070s)
[238.208650] Starting dynamic subtest: pipe-B-eDP-1
[239.029477] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.829s)
[239.308059] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.466s)
[240.176480] [032/131] (780s left) kms_addfb_basic (bad-pitch-1024)
[240.245376] Starting subtest: bad-pitch-1024
[240.247625] Subtest bad-pitch-1024: SUCCESS (0.000s)
[240.407419] [033/131] (780s left) prime_mmap (test_aperture_limit)
[240.461079] Starting subtest: test_aperture_limit
[240.463058] Starting dynamic subtest: test_aperture_limit-smem
[240.469903] Dynamic subtest test_aperture_limit-smem: SKIP (0.007s)
[240.474385] Subtest test_aperture_limit: SKIP (0.008s)
[240.577224] [034/131] (780s left) kms_cursor_crc (cursor-random-128x128)
[240.798182] Starting subtest: cursor-random-128x128
[240.803159] Starting dynamic subtest: pipe-A-eDP-1
[244.541251] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.739s)
[244.567151] Starting dynamic subtest: pipe-D-eDP-1
[248.873472] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.314s)
[248.875901] Subtest cursor-random-128x128: SUCCESS (8.075s)
[249.733203] [035/131] (771s left) gem_gpgpu_fill (offset-16x16)
[249.788420] Starting subtest: offset-16x16
[249.793479] Subtest offset-16x16: SUCCESS (0.008s)
[249.920445] [036/131] (771s left) kms_flip (flip-vs-suspend-interruptible)
[250.017647] Starting subtest: flip-vs-suspend-interruptible
[250.019934] Starting dynamic subtest: A-eDP1
[299.798348] Dynamic subtest A-eDP1: SUCCESS (4.582s)
[299.808690] Starting dynamic subtest: B-eDP1
[348.793373] Dynamic subtest B-eDP1: SUCCESS (4.275s)
[348.803466] Starting dynamic subtest: C-eDP1
[397.799440] Dynamic subtest C-eDP1: SUCCESS (4.326s)
[397.814218] Starting dynamic subtest: D-eDP1
[446.763877] Dynamic subtest D-eDP1: SUCCESS (4.287s)
[446.783744] Subtest flip-vs-suspend-interruptible: SUCCESS (17.479s)
[447.889573] [037/131] (573s left) intel_sysfs_debugfs (i915-sysfs-read-all-entries)
[447.952766] Starting subtest: i915-sysfs-read-all-entries
[448.144901] Subtest i915-sysfs-read-all-entries: SUCCESS (0.193s)
[448.307548] [038/131] (572s left) kms_vblank (wait-busy)
[448.413004] Starting subtest: wait-busy
[448.415408] Starting dynamic subtest: pipe-A-eDP-1
[450.279643] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.884s)
[450.294722] Starting dynamic subtest: pipe-D-eDP-1
[452.801842] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.537s)
[452.804148] Subtest wait-busy: SUCCESS (4.425s)
[453.579730] [039/131] (567s left) kms_pm_rpm (modeset-pc8-residency-stress)
[455.514153] Starting subtest: modeset-pc8-residency-stress
[455.519938] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[455.877337] [040/131] (565s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[455.980811] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[462.398938] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.442s)
[462.545372] [041/131] (558s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[462.593983] Starting subtest: yf-tiled-ccs-to-yf-tiled
[462.598888] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[462.775048] [042/131] (558s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-25)
[462.860998] Starting subtest: planes-upscale-20x20-downscale-factor-0-25
[462.863679] Starting dynamic subtest: pipe-A
[462.879954] Dynamic subtest pipe-A: SKIP (0.013s)
[462.889970] Starting dynamic subtest: pipe-B
[462.905022] Dynamic subtest pipe-B: SKIP (0.024s)
[462.916887] Starting dynamic subtest: pipe-C
[462.927104] Dynamic subtest pipe-C: SKIP (0.023s)
[462.936932] Starting dynamic subtest: pipe-D
[462.950744] Dynamic subtest pipe-D: SKIP (0.022s)
[462.955751] Subtest planes-upscale-20x20-downscale-factor-0-25: SKIP (0.085s)
[463.058788] [043/131] (558s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[463.156755] Starting subtest: x-tiled-32bpp-rotate-0
[464.932023] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.778s)
[465.087455] [044/131] (556s left) gem_exec_fence (syncobj-timeline-signal)
[465.647508] Starting subtest: syncobj-timeline-signal
[465.655705] Subtest syncobj-timeline-signal: SUCCESS (0.009s)
[467.357463] [045/131] (553s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[467.450996] Starting subtest: fbcpsr-slowdraw
[492.539022] Subtest fbcpsr-slowdraw: SUCCESS (25.098s)
[492.697302] [046/131] (528s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[492.798546] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[492.802831] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[492.909765] [047/131] (528s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[492.968706] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[492.971006] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[493.076829] [048/131] (528s left) gem_exec_schedule (u-independent)
[493.152870] Starting subtest: u-independent
[493.155606] Starting dynamic subtest: rcs0
[494.309899] Dynamic subtest rcs0: SUCCESS (1.171s)
[494.322816] Starting dynamic subtest: vcs0
[496.326488] Dynamic subtest vcs0: SUCCESS (2.015s)
[496.339233] Starting dynamic subtest: vcs1
[498.364683] Dynamic subtest vcs1: SUCCESS (2.036s)
[498.377267] Starting dynamic subtest: vecs0
[500.345299] Dynamic subtest vecs0: SUCCESS (1.979s)
[500.356993] Starting dynamic subtest: ccs0
[502.310565] Dynamic subtest ccs0: SUCCESS (1.964s)
[502.313537] Subtest u-independent: SUCCESS (9.174s)
[502.611909] [049/131] (518s left) kms_psr (pr-cursor-plane-onoff)
[502.723272] Starting subtest: pr-cursor-plane-onoff
[502.727706] Subtest pr-cursor-plane-onoff: SKIP (0.000s)
[502.793081] [050/131] (518s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[502.897020] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[502.901990] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[503.006529] [051/131] (518s left) gen9_exec_parse (basic-rejected-ctx-param)
[503.060855] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[503.141214] [052/131] (518s left) kms_cursor_crc (async-cursor-crc-framebuffer-change)
[503.255277] Starting subtest: async-cursor-crc-framebuffer-change
[503.257874] Starting dynamic subtest: pipe-A-eDP-1
[503.840972] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.584s)
[503.851544] Starting dynamic subtest: pipe-D-eDP-1
[505.030418] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.187s)
[505.032959] Subtest async-cursor-crc-framebuffer-change: SUCCESS (1.774s)
[505.861763] [053/131] (515s left) kms_flip (plain-flip-fb-recreate-interruptible)
[505.970109] Starting subtest: plain-flip-fb-recreate-interruptible
[505.972809] Starting dynamic subtest: A-eDP1
[514.860144] Dynamic subtest A-eDP1: SUCCESS (8.892s)
[514.870666] Starting dynamic subtest: B-eDP1
[523.680117] Dynamic subtest B-eDP1: SUCCESS (8.822s)
[523.690817] Starting dynamic subtest: C-eDP1
[532.587893] Dynamic subtest C-eDP1: SUCCESS (8.909s)
[532.597940] Starting dynamic subtest: D-eDP1
[541.409117] Dynamic subtest D-eDP1: SUCCESS (8.823s)
[541.414811] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.456s)
[542.568526] [054/131] (479s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[542.667977] Starting subtest: fbc-dirtyfb-ioctl
[542.670424] Starting dynamic subtest: A-eDP-1
[545.287491] Dynamic subtest A-eDP-1: SUCCESS (2.618s)
[545.289749] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.619s)
[546.116855] [055/131] (475s left) i915_drm_fdinfo (most-busy-idle-check-all)
[546.159763] Starting subtest: most-busy-idle-check-all
[546.161819] Starting dynamic subtest: rcs0
[546.166811] Dynamic subtest rcs0: SKIP (0.004s)
[546.176219] Starting dynamic subtest: bcs0
[546.181305] Dynamic subtest bcs0: SKIP (0.000s)
[546.191044] Starting dynamic subtest: vcs0
[546.195263] Dynamic subtest vcs0: SKIP (0.000s)
[546.205225] Starting dynamic subtest: vcs1
[546.210032] Dynamic subtest vcs1: SKIP (0.000s)
[546.219094] Starting dynamic subtest: vecs0
[546.223792] Dynamic subtest vecs0: SKIP (0.000s)
[546.232989] Starting dynamic subtest: ccs0
[546.238040] Dynamic subtest ccs0: SKIP (0.000s)
[546.242987] Subtest most-busy-idle-check-all: SKIP (0.009s)
[546.280700] [056/131] (475s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[546.410138] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[546.416031] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[546.515140] [057/131] (475s left) kms_flip (2x-busy-flip)
[546.600208] Starting subtest: 2x-busy-flip
[546.610749] Subtest 2x-busy-flip: SKIP (0.010s)
[546.729119] [058/131] (475s left) gem_ctx_param (basic-default)
[546.786092] Starting subtest: basic-default
[546.788659] Subtest basic-default: SUCCESS (0.000s)
[546.862205] [059/131] (475s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[546.964951] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[551.577164] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.615s)
[552.691918] [060/131] (469s left) syncobj_timeline (single-wait-available-submitted)
[552.751268] Starting subtest: single-wait-available-submitted
[552.754014] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[552.863284] [061/131] (469s left) gem_partial_pwrite_pread (writes-after-reads)
[552.923361] Subtest writes-after-reads: SKIP (0.000s)
[552.984351] [062/131] (469s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[558.037151] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[558.042231] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.002s)
[558.891257] [063/131] (463s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[558.993948] Starting subtest: x-tiled-addfb-size-offset-overflow
[558.996048] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[559.075446] [064/131] (462s left) gem_pread (bench)
[559.126053] Subtest bench: SKIP (0.000s)
[559.188395] [065/131] (462s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[559.264829] Starting subtest: basic-batch-kernel-default-cmd
[559.270254] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[559.445468] [066/131] (462s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[559.544658] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[559.555018] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.010s)
[559.651644] [067/131] (462s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[559.904262] Starting subtest: cursor-rapid-movement-512x512
[559.910246] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[560.045748] [068/131] (462s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[560.149963] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[560.152646] Starting dynamic subtest: pipe-A-eDP-1
[560.582695] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.397s)
[560.594097] Starting dynamic subtest: pipe-B-eDP-1
[561.979596] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.397s)
[561.990532] Starting dynamic subtest: pipe-C-eDP-1
[563.372110] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.395s)
[563.383026] Starting dynamic subtest: pipe-D-eDP-1
[564.701913] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.323s)
[564.704397] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.516s)
[565.880570] [069/131] (456s left) kms_chamelium_frames (hdmi-aspect-ratio)
[566.269557] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[567.086304] [070/131] (455s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu)
[567.182946] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu
[573.776255] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (6.596s)
[573.910492] [071/131] (448s left) kms_flip (dpms-vs-vblank-race-interruptible)
[574.011450] Starting subtest: dpms-vs-vblank-race-interruptible
[574.014014] Starting dynamic subtest: A-eDP1
[578.971754] Dynamic subtest A-eDP1: SUCCESS (4.956s)
[578.983814] Starting dynamic subtest: B-eDP1
[583.560059] Dynamic subtest B-eDP1: SUCCESS (4.587s)
[583.570065] Starting dynamic subtest: C-eDP1
[588.142850] Dynamic subtest C-eDP1: SUCCESS (4.581s)
[588.153622] Starting dynamic subtest: D-eDP1
[592.738807] Dynamic subtest D-eDP1: SUCCESS (4.594s)
[592.741536] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (18.727s)
[593.610315] [072/131] (428s left) kms_psr (pr-cursor-mmap-cpu)
[593.713236] Starting subtest: pr-cursor-mmap-cpu
[593.717841] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[593.785549] [073/131] (428s left) api_intel_bb (intel-bb-blit-x)
[593.841255] Starting subtest: intel-bb-blit-x
[597.295890] Subtest intel-bb-blit-x: SUCCESS (3.457s)
[597.443412] [074/131] (425s left) i915_query (query-topology-matches-eu-total)
[597.496060] Starting subtest: query-topology-matches-eu-total
[597.498881] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[597.590713] [075/131] (424s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[597.682012] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[597.684588] Starting dynamic subtest: pipe-A-eDP-1
[597.707804] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[597.717985] Starting dynamic subtest: pipe-B-eDP-1
[597.742405] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[597.752051] Starting dynamic subtest: pipe-C-eDP-1
[597.776774] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[597.786052] Starting dynamic subtest: pipe-D-eDP-1
[597.812230] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[597.816796] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[599.872621] [076/131] (422s left) gem_eio (execbuf)
[600.098394] Starting subtest: execbuf
[600.443608] Subtest execbuf: SUCCESS (0.344s)
[600.619663] [077/131] (421s left) i915_pm_rps (min-max-config-loaded)
[600.684282] Starting subtest: min-max-config-loaded
[600.689708] Subtest min-max-config-loaded: SKIP (0.001s)
[600.776425] [078/131] (421s left) kms_lease (lessee-list)
[600.872595] Starting subtest: lessee-list
[600.875508] Starting dynamic subtest: pipe-A-eDP-1
[600.877803] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[600.888118] Starting dynamic subtest: pipe-B-eDP-1
[600.890168] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[600.899281] Starting dynamic subtest: pipe-C-eDP-1
[600.901400] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[600.910557] Starting dynamic subtest: pipe-D-eDP-1
[600.912383] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[600.914153] Subtest lessee-list: SUCCESS (0.009s)
[600.990413] [079/131] (421s left) device_reset (unbind-reset-rebind)
[601.038554] Starting subtest: unbind-reset-rebind
[605.754706] Subtest unbind-reset-rebind: SUCCESS (4.711s)
[605.796726] [080/131] (416s left) syncobj_wait (wait-any-snapshot)
[605.861822] Starting subtest: wait-any-snapshot
[605.941661] Subtest wait-any-snapshot: SUCCESS (0.082s)
[606.019790] [081/131] (416s left) gen9_exec_parse (unaligned-jump)
[606.081366] Subtest unaligned-jump: SKIP (0.000s)
[606.147363] [082/131] (416s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[606.259136] Starting subtest: flip-vs-cursor-atomic
[613.275962] Subtest flip-vs-cursor-atomic: SUCCESS (7.017s)
[614.108475] [083/131] (408s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[614.203593] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[614.205979] Starting dynamic subtest: pipe-A-default-mode
[615.360998] Dynamic subtest pipe-A-default-mode: SKIP (1.153s)
[615.366420] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.154s)
[615.502204] [084/131] (407s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[615.554002] Starting subtest: multi-wait-all-for-submit-available-signaled
[615.556506] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[615.643226] [085/131] (407s left) gem_exec_schedule (lateslice)
[615.710766] Starting subtest: lateslice
[615.713016] Starting dynamic subtest: rcs0
[615.721969] Dynamic subtest rcs0: SUCCESS (0.022s)
[615.734371] Starting dynamic subtest: bcs0
[615.739983] Dynamic subtest bcs0: SUCCESS (0.016s)
[615.750617] Starting dynamic subtest: vcs0
[615.755854] Dynamic subtest vcs0: SUCCESS (0.017s)
[615.766465] Starting dynamic subtest: vcs1
[615.773336] Dynamic subtest vcs1: SUCCESS (0.017s)
[615.783198] Starting dynamic subtest: vecs0
[615.789811] Dynamic subtest vecs0: SUCCESS (0.016s)
[615.800050] Starting dynamic subtest: ccs0
[615.807987] Dynamic subtest ccs0: SUCCESS (0.017s)
[615.810586] Subtest lateslice: SUCCESS (0.109s)
[617.429007] [086/131] (405s left) gem_exec_reloc (basic-gtt)
[617.492324] Subtest basic-gtt: SKIP (0.000s)
[617.588987] [087/131] (405s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[617.690362] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[617.695227] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[617.805816] [088/131] (405s left) perf (non-zero-reason)
[617.902977] Starting subtest: non-zero-reason
[617.905136] Starting dynamic subtest: 0-rcs0
[623.298067] Dynamic subtest 0-rcs0: SUCCESS (5.398s)
[623.310242] Starting dynamic subtest: 1-vecs0
[627.198688] Dynamic subtest 1-vecs0: SUCCESS (3.901s)
[627.201253] Subtest non-zero-reason: SUCCESS (9.299s)
[627.243612] [089/131] (395s left) kms_plane_cursor (viewport)
[627.333912] Starting subtest: viewport
[627.338769] Starting dynamic subtest: pipe-A-eDP-1-size-64
[630.255770] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.921s)
[630.316819] Starting dynamic subtest: pipe-A-eDP-1-size-128
[633.209674] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.904s)
[633.273298] Starting dynamic subtest: pipe-A-eDP-1-size-256
[636.155168] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.892s)
[636.502150] Starting dynamic subtest: pipe-B-eDP-1-size-64
[640.204715] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.714s)
[640.265766] Starting dynamic subtest: pipe-B-eDP-1-size-128
[643.259508] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (3.003s)
[643.319931] Starting dynamic subtest: pipe-B-eDP-1-size-256
[646.305052] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.993s)
[646.667559] Starting dynamic subtest: pipe-C-eDP-1-size-64
[649.892773] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.240s)
[649.933068] Starting dynamic subtest: pipe-C-eDP-1-size-128
[652.371571] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.446s)
[652.408766] Starting dynamic subtest: pipe-C-eDP-1-size-256
[654.891973] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.491s)
[655.219856] Starting dynamic subtest: pipe-D-eDP-1-size-64
[658.447960] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (3.239s)
[658.486899] Starting dynamic subtest: pipe-D-eDP-1-size-128
[660.968026] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.491s)
[661.014530] Starting dynamic subtest: pipe-D-eDP-1-size-256
[663.468419] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.468s)
[663.784905] Subtest viewport: SUCCESS (36.459s)
[664.615603] [090/131] (358s left) kms_flip (nonexisting-fb-interruptible)
[664.722975] Starting subtest: nonexisting-fb-interruptible
[664.725593] Starting dynamic subtest: A-eDP1
[665.898151] Dynamic subtest A-eDP1: SUCCESS (1.176s)
[665.908271] Starting dynamic subtest: B-eDP1
[667.021735] Dynamic subtest B-eDP1: SUCCESS (1.123s)
[667.033881] Starting dynamic subtest: C-eDP1
[668.139880] Dynamic subtest C-eDP1: SUCCESS (1.117s)
[668.153254] Starting dynamic subtest: D-eDP1
[669.263416] Dynamic subtest D-eDP1: SUCCESS (1.123s)
[669.266047] Subtest nonexisting-fb-interruptible: SUCCESS (4.546s)
[670.422737] [091/131] (352s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[670.529273] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[670.534483] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[670.633465] [092/131] (352s left) kms_tiled_display (basic-test-pattern)
[670.750839] Subtest basic-test-pattern: SKIP (0.000s)
[670.797605] [093/131] (352s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[670.899911] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[670.902264] Starting dynamic subtest: pipe-A-default-mode
[673.670010] Dynamic subtest pipe-A-default-mode: SUCCESS (2.765s)
[673.672811] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.766s)
[674.500587] [094/131] (348s left) gem_exec_endless (dispatch)
[674.569266] Starting subtest: dispatch
[674.571872] Starting dynamic subtest: rcs0
[674.576565] Dynamic subtest rcs0: SUCCESS (0.005s)
[674.588145] Starting dynamic subtest: bcs0
[674.593673] Dynamic subtest bcs0: SUCCESS (0.004s)
[674.605277] Starting dynamic subtest: vcs0
[674.609918] Dynamic subtest vcs0: SUCCESS (0.004s)
[674.619800] Starting dynamic subtest: vcs1
[674.624675] Dynamic subtest vcs1: SUCCESS (0.004s)
[674.634591] Starting dynamic subtest: vecs0
[674.639038] Dynamic subtest vecs0: SUCCESS (0.004s)
[674.648795] Starting dynamic subtest: ccs0
[674.653928] Dynamic subtest ccs0: SUCCESS (0.004s)
[674.656284] Subtest dispatch: SUCCESS (0.029s)
[676.366600] [095/131] (346s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[676.466697] Starting subtest: plane-all-transition-nonblocking-fencing
[676.469913] Starting dynamic subtest: pipe-A-eDP-1
[678.973019] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.503s)
[679.273049] Starting dynamic subtest: pipe-B-eDP-1
[682.529459] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.266s)
[682.808228] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.337s)
[683.645881] [096/131] (339s left) gem_mmap_gtt (cpuset-big-copy)
[683.710289] Subtest cpuset-big-copy: SKIP (0.000s)
[683.777544] [097/131] (339s left) kms_frontbuffer_tracking (basic)
[683.878039] Starting subtest: basic
[687.023878] Subtest basic: SUCCESS (3.151s)
[687.165472] [098/131] (336s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[687.208806] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[687.210797] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[687.319394] [099/131] (336s left) sysfs_heartbeat_interval (nopreempt)
[687.367402] Starting subtest: nopreempt
[687.369761] Starting dynamic subtest: vecs0
[697.348388] Dynamic subtest vecs0: SUCCESS (9.975s)
[697.361250] Starting dynamic subtest: ccs0
[701.378297] Dynamic subtest ccs0: SUCCESS (4.029s)
[701.390236] Starting dynamic subtest: vcs0
[711.357258] Dynamic subtest vcs0: SUCCESS (9.976s)
[711.370424] Starting dynamic subtest: bcs0
[715.277043] Dynamic subtest bcs0: SUCCESS (3.917s)
[715.287948] Starting dynamic subtest: rcs0
[719.342877] Dynamic subtest rcs0: SUCCESS (4.064s)
[719.355844] Starting dynamic subtest: vcs1
[728.292029] Dynamic subtest vcs1: SUCCESS (8.944s)
[728.295120] Subtest nopreempt: SUCCESS (40.914s)
[728.366622] [100/131] (295s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[728.474776] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[728.479140] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[728.571634] [101/131] (295s left) syncobj_timeline (multi-wait-available-submitted)
[728.629270] Starting subtest: multi-wait-available-submitted
[728.631679] Subtest multi-wait-available-submitted: SUCCESS (0.000s)
[728.738773] [102/131] (294s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[728.834911] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[728.839448] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[728.953166] [103/131] (294s left) kms_psr (fbc-psr2-no-drrs)
[729.043821] Starting subtest: fbc-psr2-no-drrs
[729.046121] Starting dynamic subtest: eDP-1
[729.051046] Dynamic subtest eDP-1: SKIP (0.000s)
[729.055665] Subtest fbc-psr2-no-drrs: SKIP (0.001s)
[729.121640] [104/131] (294s left) fbdev (unaligned-read)
[729.158855] Starting subtest: unaligned-read
[729.176219] Subtest unaligned-read: SUCCESS (0.018s)
[729.241403] [105/131] (294s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[729.333775] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[729.337478] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[729.442757] [106/131] (294s left) kms_async_flips (invalid-async-flip-atomic)
[729.526466] Starting subtest: invalid-async-flip-atomic
[729.530612] Subtest invalid-async-flip-atomic: SKIP (0.000s)
[730.676411] [107/131] (293s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[730.777183] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[735.376984] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (4.603s)
[736.567579] [108/131] (287s left) gem_exec_flush (basic-wb-ro-before-default)
[736.639688] Starting subtest: basic-wb-ro-before-default
[742.091163] Subtest basic-wb-ro-before-default: SUCCESS (5.450s)
[742.285711] [109/131] (281s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[742.381951] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[742.384500] Starting dynamic subtest: pipe-A-eDP-1
[742.433278] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.054s)
[742.444855] Starting dynamic subtest: pipe-B-eDP-1
[742.492109] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.058s)
[742.503679] Starting dynamic subtest: pipe-C-eDP-1
[742.540167] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.048s)
[742.550812] Starting dynamic subtest: pipe-D-eDP-1
[742.591462] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.050s)
[742.593720] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.213s)
[744.704398] [110/131] (279s left) kms_invalid_mode (zero-clock)
[744.803702] Starting subtest: zero-clock
[744.805997] Starting dynamic subtest: pipe-A-eDP-1
[745.083945] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.282s)
[745.094515] Starting dynamic subtest: pipe-B-eDP-1
[745.096697] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[745.106952] Starting dynamic subtest: pipe-C-eDP-1
[745.109596] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[745.119640] Starting dynamic subtest: pipe-D-eDP-1
[745.122081] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[745.124656] Subtest zero-clock: SUCCESS (0.287s)
[745.929396] [111/131] (278s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[745.996497] Starting subtest: y-tiled-to-vebox-yf-tiled
[746.000746] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[746.177224] [112/131] (277s left) kms_pm_dc (dc5-psr)
[747.278108] Starting subtest: dc5-psr
[750.151544] Subtest dc5-psr: SUCCESS (2.874s)
[750.955024] [113/131] (273s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[751.055589] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[757.757172] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.707s)
[757.883045] [114/131] (266s left) gem_ctx_isolation (dirty-switch)
[757.949695] Starting subtest: dirty-switch
[757.951842] Starting dynamic subtest: rcs0
[758.358127] Dynamic subtest rcs0: SUCCESS (0.408s)
[758.369512] Starting dynamic subtest: bcs0
[758.795237] Dynamic subtest bcs0: SUCCESS (0.436s)
[758.808092] Starting dynamic subtest: vcs0
[759.267914] Dynamic subtest vcs0: SUCCESS (0.472s)
[759.280927] Starting dynamic subtest: vcs1
[760.768490] Dynamic subtest vcs1: SUCCESS (1.500s)
[760.781004] Starting dynamic subtest: vecs0
[762.825656] Dynamic subtest vecs0: SUCCESS (2.056s)
[762.839035] Starting dynamic subtest: ccs0
[764.818256] Dynamic subtest ccs0: SUCCESS (1.992s)
[764.821276] Subtest dirty-switch: SUCCESS (6.868s)
[765.071134] [115/131] (259s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt)
[765.185535] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt
[765.190651] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[765.272464] [116/131] (258s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[765.368134] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[765.370741] Starting dynamic subtest: pipe-A-eDP-1
[765.398223] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[765.410103] Starting dynamic subtest: pipe-B-eDP-1
[765.438244] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[765.449265] Starting dynamic subtest: pipe-C-eDP-1
[765.478922] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[765.491267] Starting dynamic subtest: pipe-D-eDP-1
[765.518649] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[765.523139] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[767.553611] [117/131] (256s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[767.661955] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[768.541255] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.881s)
[768.758722] [118/131] (255s left) kms_big_fb (yf-tiled-addfb)
[768.873792] Starting subtest: yf-tiled-addfb
[768.878459] Subtest yf-tiled-addfb: SKIP (0.000s)
[768.990049] [119/131] (255s left) perf (invalid-oa-metric-set-id)
[769.074233] Starting subtest: invalid-oa-metric-set-id
[769.090229] Subtest invalid-oa-metric-set-id: SUCCESS (0.015s)
[769.135834] [120/131] (255s left) kms_psr2_su (page_flip-p010)
[769.192717] Subtest page_flip-P010: SKIP (0.000s)
[769.254736] [121/131] (255s left) gem_lmem_swapping (smem-oom)
[769.294419] Subtest smem-oom: SKIP (0.000s)
[769.345934] [122/131] (255s left) kms_cursor_crc (cursor-suspend)
[769.469421] Starting subtest: cursor-suspend
[769.471476] Starting dynamic subtest: pipe-A-eDP-1
[802.253720] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.052s)
[802.265530] Starting dynamic subtest: pipe-D-eDP-1
[835.237072] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.591s)
[835.239447] Subtest cursor-suspend: SUCCESS (6.645s)
[836.029117] [123/131] (188s left) gem_pxp (create-regular-context-2)
[836.153758] Starting subtest: create-regular-context-2
[836.156226] Subtest create-regular-context-2: SUCCESS (0.002s)
[836.281016] [124/131] (188s left) gem_ctx_persistence (legacy-engines-hang)
[836.340192] Starting subtest: legacy-engines-hang
[836.342156] Starting dynamic subtest: render
[836.467920] Dynamic subtest render: SUCCESS (0.129s)
[836.481051] Starting dynamic subtest: bsd1
[836.581322] Dynamic subtest bsd1: SUCCESS (0.110s)
[836.593461] Starting dynamic subtest: bsd2
[836.677948] Dynamic subtest bsd2: SUCCESS (0.094s)
[836.689357] Starting dynamic subtest: blt
[836.790105] Dynamic subtest blt: SUCCESS (0.109s)
[836.803846] Starting dynamic subtest: vebox
[836.896991] Dynamic subtest vebox: SUCCESS (0.104s)
[836.899578] Subtest legacy-engines-hang: SUCCESS (0.558s)
[836.977211] [125/131] (187s left) kms_plane_alpha_blend (alpha-7efc)
[837.078271] Starting subtest: alpha-7efc
[837.499032] Starting dynamic subtest: pipe-A-eDP-1
[838.053450] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.551s)
[838.081266] Starting dynamic subtest: pipe-D-eDP-1
[839.317835] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.243s)
[839.320094] Subtest alpha-7efc: SUCCESS (2.231s)
[840.099689] [126/131] (184s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[840.207978] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[840.212127] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[840.302544] [127/131] (184s left) gem_userptr_blits (userfault)
[840.358988] Starting subtest: userfault
[840.361301] Subtest userfault: SUCCESS (0.006s)
[840.500137] [128/131] (184s left) i915_module_load (reload-no-display)
[840.538516] Starting subtest: reload-no-display
[845.291889] Subtest reload-no-display: SUCCESS (4.746s)
[845.320292] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[845.320989] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[845.324122] [129/131] (179s left) kms_chamelium_color (ctm-max)
[846.803852] Subtest ctm-max: SKIP (0.000s)
[846.840288] [FACT kms_chamelium_color (ctm-max)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[846.842311] [FACT kms_chamelium_color (ctm-max)] new: kernel.kmod_is_loaded.i915: true
[846.845874] [130/131] (177s left) kms_atomic_interruptible (legacy-pageflip)
[846.951420] Starting subtest: legacy-pageflip
[846.953713] Starting dynamic subtest: pipe-A-eDP-1
[854.352426] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.392s)
[854.354280] Subtest legacy-pageflip: SUCCESS (7.394s)
[855.212651] [131/131] (169s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[855.289835] Starting subtest: map-fixed-invalidate-overlap-busy
[855.294158] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[855.421928] Closing watchdogs
results: parsing output: 0/ for test: kms_plane_scaling
results: parsing output: 1/ for test: gem_exec_reloc
results: parsing output: 2/ for test: kms_cursor_legacy
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: kms_ccs
results: parsing output: 5/ for test: gem_ctx_shared
results: parsing output: 6/ for test: kms_addfb_basic
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: prime_busy
results: parsing output: 9/ for test: drm_read
results: parsing output: 10/ for test: kms_psr2_sf
results: parsing output: 11/ for test: gem_exec_balancer
results: parsing output: 12/ for test: gem_exec_schedule
results: parsing output: 13/ for test: gem_busy
results: parsing output: 14/ for test: kms_selftest
results: parsing output: 15/ for test: gem_exec_basic
results: parsing output: 16/ for test: kms_rotation_crc
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: kms_psr
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: kms_busy
results: parsing output: 21/ for test: gem_busy
results: parsing output: 22/ for test: perf
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_cursor_legacy
results: parsing output: 25/ for test: kms_color
results: parsing output: 26/ for test: syncobj_wait
results: parsing output: 27/ for test: kms_getfb
results: parsing output: 28/ for test: perf_pmu
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_atomic_transition
results: parsing output: 31/ for test: kms_addfb_basic
results: parsing output: 32/ for test: prime_mmap
results: parsing output: 33/ for test: kms_cursor_crc
results: parsing output: 34/ for test: gem_gpgpu_fill
results: parsing output: 35/ for test: kms_flip
results: parsing output: 36/ for test: intel_sysfs_debugfs
results: parsing output: 37/ for test: kms_vblank
results: parsing output: 38/ for test: kms_pm_rpm
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_render_copy
results: parsing output: 41/ for test: kms_plane_scaling
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: gem_exec_fence
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: syncobj_wait
results: parsing output: 47/ for test: gem_exec_schedule
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gen9_exec_parse
results: parsing output: 51/ for test: kms_cursor_crc
results: parsing output: 52/ for test: kms_flip
results: parsing output: 53/ for test: kms_dirtyfb
results: parsing output: 54/ for test: i915_drm_fdinfo
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_flip
results: parsing output: 57/ for test: gem_ctx_param
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: syncobj_timeline
results: parsing output: 60/ for test: gem_partial_pwrite_pread
results: parsing output: 61/ for test: kms_psr2_sf
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: gem_pread
results: parsing output: 64/ for test: gem_exec_flush
results: parsing output: 65/ for test: kms_flip
results: parsing output: 66/ for test: kms_cursor_crc
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: kms_chamelium_frames
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_flip
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: api_intel_bb
results: parsing output: 73/ for test: i915_query
results: parsing output: 74/ for test: kms_ccs
results: parsing output: 75/ for test: gem_eio
results: parsing output: 76/ for test: i915_pm_rps
results: parsing output: 77/ for test: kms_lease
results: parsing output: 78/ for test: device_reset
results: parsing output: 79/ for test: syncobj_wait
results: parsing output: 80/ for test: gen9_exec_parse
results: parsing output: 81/ for test: kms_cursor_legacy
results: parsing output: 82/ for test: kms_flip_scaled_crc
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: gem_exec_schedule
results: parsing output: 85/ for test: gem_exec_reloc
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: perf
results: parsing output: 88/ for test: kms_plane_cursor
results: parsing output: 89/ for test: kms_flip
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_tiled_display
results: parsing output: 92/ for test: kms_flip_scaled_crc
results: parsing output: 93/ for test: gem_exec_endless
results: parsing output: 94/ for test: kms_atomic_transition
results: parsing output: 95/ for test: gem_mmap_gtt
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: syncobj_wait
results: parsing output: 98/ for test: sysfs_heartbeat_interval
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: fbdev
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_async_flips
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_exec_flush
results: parsing output: 108/ for test: kms_ccs
results: parsing output: 109/ for test: kms_invalid_mode
results: parsing output: 110/ for test: gem_render_copy
results: parsing output: 111/ for test: kms_pm_dc
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_ctx_isolation
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: perf
results: parsing output: 119/ for test: kms_psr2_su
results: parsing output: 120/ for test: gem_lmem_swapping
results: parsing output: 121/ for test: kms_cursor_crc
results: parsing output: 122/ for test: gem_pxp
results: parsing output: 123/ for test: gem_ctx_persistence
results: parsing output: 124/ for test: kms_plane_alpha_blend
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_userptr_blits
results: parsing output: 127/ for test: i915_module_load
results: parsing output: 128/ for test: kms_chamelium_color
results: parsing output: 129/ for test: kms_atomic_interruptible
results: parsing output: 130/ for test: gem_userptr_blits
Done.