[60.133437] Initializing watchdogs
[60.133500]   /dev/watchdog0
[60.147592] [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]
[60.152178] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.155065] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.158524] [001/133] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[60.273895] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[60.278319] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[60.369870] [002/133] (960s left) gem_pread (self)
[60.429284] Subtest self: SKIP (0.000s)
[60.517739] [003/133] (960s left) gem_flink_race (flink_close)
[60.558675] Starting subtest: flink_close
[65.646018] Subtest flink_close: SUCCESS (5.076s)
[65.719471] [004/133] (955s left) kms_cursor_crc (cursor-offscreen-32x10)
[65.891462] Starting subtest: cursor-offscreen-32x10
[65.943101] Subtest cursor-offscreen-32x10: SKIP (0.048s)
[66.233833] [005/133] (954s left) gem_exec_balancer (fairslice)
[66.309818] Starting subtest: fairslice
[69.267802] Subtest fairslice: SUCCESS (2.954s)
[69.595226] [006/133] (951s left) syncobj_timeline (invalid-signal-bad-pad)
[69.641524] Starting subtest: invalid-signal-bad-pad
[69.643586] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[69.736336] [007/133] (951s left) kms_lease (lease-invalid-crtc)
[69.823176] Starting subtest: lease-invalid-crtc
[69.825500] Starting dynamic subtest: pipe-A-eDP-1
[69.827706] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[69.835948] Starting dynamic subtest: pipe-B-eDP-1
[69.837799] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[69.844915] Starting dynamic subtest: pipe-C-eDP-1
[69.847074] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[69.855064] Starting dynamic subtest: pipe-D-eDP-1
[69.856865] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[69.858769] Subtest lease-invalid-crtc: SUCCESS (0.003s)
[69.896839] [008/133] (951s left) syncobj_wait (multi-wait-all-submitted-signaled)
[69.944710] Starting subtest: multi-wait-all-submitted-signaled
[70.051119] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.104s)
[70.119915] [009/133] (950s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[70.221272] Starting subtest: 4-tiled-16bpp-rotate-0
[71.509838] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.289s)
[71.639981] [010/133] (949s left) i915_pm_rc6_residency (media-rc6-accuracy)
[71.706085] Starting subtest: media-rc6-accuracy
[71.709460] Subtest media-rc6-accuracy: SKIP (0.000s)
[71.816404] [011/133] (949s left) kms_universal_plane (disable-primary-vs-flip)
[71.911103] Starting subtest: disable-primary-vs-flip
[71.913083] Starting dynamic subtest: pipe-A-eDP-1
[73.501254] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.586s)
[73.509123] Starting dynamic subtest: pipe-B-eDP-1
[75.680919] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.179s)
[75.689844] Starting dynamic subtest: pipe-C-eDP-1
[77.935187] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.251s)
[77.943391] Starting dynamic subtest: pipe-D-eDP-1
[80.168167] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.231s)
[80.170354] Subtest disable-primary-vs-flip: SUCCESS (8.251s)
[80.981958] [012/133] (940s left) prime_mmap (test_dup)
[81.034828] Starting subtest: test_dup
[81.037220] Starting dynamic subtest: test_dup-smem
[81.067680] Dynamic subtest test_dup-smem: SUCCESS (0.035s)
[81.070386] Subtest test_dup: SUCCESS (0.035s)
[81.141350] [013/133] (940s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[81.189791] Starting subtest: single-wait-for-submit-available-submitted
[81.191983] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s)
[81.281351] [014/133] (939s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[81.380305] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[81.384717] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[81.477281] [015/133] (939s left) vgem_basic (dmabuf-mmap)
[81.560390] Starting subtest: dmabuf-mmap
[81.567526] Subtest dmabuf-mmap: SUCCESS (0.010s)
[81.625973] [FACT vgem_basic (dmabuf-mmap)] new: kernel.kmod_is_loaded.vgem: true
[81.628978] [016/133] (939s left) gen9_exec_parse (batch-invalid-length)
[81.697902] Subtest batch-invalid-length: SKIP (0.000s)
[81.759859] [017/133] (939s left) gem_exec_params (invalid-ring)
[81.813588] Starting subtest: invalid-ring
[81.815967] Subtest invalid-ring: SUCCESS (0.000s)
[81.907044] [018/133] (939s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[81.998910] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[82.000556] Starting dynamic subtest: pipe-A-eDP-1
[84.239059] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.240s)
[84.247099] Starting dynamic subtest: pipe-B-eDP-1
[86.576548] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.336s)
[86.584451] Starting dynamic subtest: pipe-C-eDP-1
[88.744982] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.169s)
[88.751944] Starting dynamic subtest: pipe-D-eDP-1
[90.919499] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.173s)
[90.921429] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.921s)
[92.079866] [019/133] (929s left) kms_flip (modeset-vs-vblank-race)
[92.179778] Starting subtest: modeset-vs-vblank-race
[92.182081] Starting dynamic subtest: A-eDP1
[96.889354] Dynamic subtest A-eDP1: SUCCESS (4.711s)
[96.899677] Starting dynamic subtest: B-eDP1
[101.606712] Dynamic subtest B-eDP1: SUCCESS (4.715s)
[101.616961] Starting dynamic subtest: C-eDP1
[106.292374] Dynamic subtest C-eDP1: SUCCESS (4.684s)
[106.300052] Starting dynamic subtest: D-eDP1
[110.920603] Dynamic subtest D-eDP1: SUCCESS (4.626s)
[110.925905] Subtest modeset-vs-vblank-race: SUCCESS (18.748s)
[112.088209] [020/133] (909s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[112.146736] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[112.149056] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[112.243500] [021/133] (909s left) gem_mmap_gtt (isolation)
[112.301337] Subtest isolation: SKIP (0.000s)
[112.360739] [022/133] (909s left) perf_pmu (render-node-busy-idle)
[112.454419] Starting subtest: render-node-busy-idle
[112.456460] Starting dynamic subtest: rcs0
[113.146819] Dynamic subtest rcs0: SUCCESS (0.695s)
[113.156734] Starting dynamic subtest: bcs0
[113.816779] Dynamic subtest bcs0: SUCCESS (0.668s)
[113.826485] Starting dynamic subtest: vcs0
[114.902509] Dynamic subtest vcs0: SUCCESS (1.082s)
[114.911526] Starting dynamic subtest: vcs1
[116.885420] Dynamic subtest vcs1: SUCCESS (1.980s)
[116.896149] Starting dynamic subtest: vecs0
[118.933810] Dynamic subtest vecs0: SUCCESS (2.046s)
[118.944798] Starting dynamic subtest: ccs0
[119.597807] Dynamic subtest ccs0: SUCCESS (0.663s)
[119.600821] Subtest render-node-busy-idle: SUCCESS (7.148s)
[119.686488] [023/133] (901s left) api_intel_bb (object-reloc-purge-cache)
[119.737036] Starting subtest: object-reloc-purge-cache
[119.741761] Subtest object-reloc-purge-cache: SKIP (0.005s)
[119.864687] [024/133] (901s left) kms_scaling_modes (scaling-mode-none)
[119.959057] Starting subtest: scaling-mode-none
[119.961481] Starting dynamic subtest: pipe-A-eDP-1
[120.053643] Dynamic subtest pipe-A-eDP-1: SKIP (0.094s)
[120.064192] Starting dynamic subtest: pipe-B-eDP-1
[120.093051] Dynamic subtest pipe-B-eDP-1: SKIP (0.037s)
[120.101554] Starting dynamic subtest: pipe-C-eDP-1
[120.130955] Dynamic subtest pipe-C-eDP-1: SKIP (0.035s)
[120.139092] Starting dynamic subtest: pipe-D-eDP-1
[120.182741] Dynamic subtest pipe-D-eDP-1: SKIP (0.049s)
[120.187522] Subtest scaling-mode-none: SKIP (0.224s)
[120.301144] [025/133] (901s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[120.413171] Starting subtest: fbcpsr-tiling-linear
[127.047820] Subtest fbcpsr-tiling-linear: SUCCESS (6.637s)
[127.179459] [026/133] (894s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[127.278291] Starting subtest: plane-all-transition-nonblocking-fencing
[127.280596] Starting dynamic subtest: pipe-A-eDP-1
[129.771948] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[130.094393] Starting dynamic subtest: pipe-B-eDP-1
[133.367477] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.282s)
[133.668116] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.389s)
[134.495731] [027/133] (887s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[134.567718] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[134.673142] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.104s)
[134.748638] [028/133] (887s left) kms_flip (dpms-off-confusion)
[134.830155] Starting subtest: dpms-off-confusion
[134.832500] Starting dynamic subtest: A-eDP1
[143.492281] Dynamic subtest A-eDP1: SUCCESS (8.660s)
[143.505532] Starting dynamic subtest: B-eDP1
[152.150481] Dynamic subtest B-eDP1: SUCCESS (8.655s)
[152.163215] Starting dynamic subtest: C-eDP1
[160.772462] Dynamic subtest C-eDP1: SUCCESS (8.619s)
[160.784775] Starting dynamic subtest: D-eDP1
[169.403307] Dynamic subtest D-eDP1: SUCCESS (8.628s)
[169.405752] Subtest dpms-off-confusion: SUCCESS (34.575s)
[170.594796] [029/133] (851s left) perf_pmu (all-busy-idle-check-all)
[170.635167] Starting subtest: all-busy-idle-check-all
[171.925418] Subtest all-busy-idle-check-all: SUCCESS (1.290s)
[172.020512] [030/133] (849s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[172.135438] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[173.115397] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.980s)
[173.239690] [031/133] (848s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[173.345348] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[177.829667] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.487s)
[178.992167] [032/133] (842s left) kms_color (degamma)
[179.080862] Starting subtest: degamma
[179.083100] Starting dynamic subtest: pipe-A-eDP-1
[179.818202] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.737s)
[179.826828] Starting dynamic subtest: pipe-B-eDP-1
[181.212417] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.392s)
[181.222045] Starting dynamic subtest: pipe-C-eDP-1
[182.597415] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.385s)
[182.605900] Starting dynamic subtest: pipe-D-eDP-1
[183.930927] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.332s)
[183.933235] Subtest degamma: SUCCESS (4.850s)
[184.719385] [033/133] (837s left) kms_plane_alpha_blend (coverage-7efc)
[184.825194] Starting subtest: coverage-7efc
[185.116630] Starting dynamic subtest: pipe-A-eDP-1
[185.683298] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.565s)
[185.711163] Starting dynamic subtest: pipe-D-eDP-1
[187.041868] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.337s)
[187.044070] Subtest coverage-7efc: SUCCESS (2.218s)
[187.901136] [034/133] (834s left) i915_drm_fdinfo (virtual-busy-all)
[187.946990] Starting subtest: virtual-busy-all
[187.951384] Subtest virtual-busy-all: SKIP (0.000s)
[188.022544] [035/133] (834s left) kms_psr (pr-sprite-blt)
[188.115087] Starting subtest: pr-sprite-blt
[188.119436] Subtest pr-sprite-blt: SKIP (0.000s)
[188.188203] [036/133] (833s left) kms_addfb_basic (too-wide)
[188.283754] Starting subtest: too-wide
[188.286024] Subtest too-wide: SUCCESS (0.000s)
[188.376667] [037/133] (833s left) kms_chamelium_color (ctm-max)
[188.483197] Subtest ctm-max: SKIP (0.000s)
[188.527962] [038/133] (833s left) kms_chamelium_frames (dp-frame-dump)
[188.941620] Subtest dp-frame-dump: SKIP (0.000s)
[189.715272] [039/133] (832s left) kms_psr (fbc-psr2-cursor-plane-move)
[189.814222] Starting subtest: fbc-psr2-cursor-plane-move
[189.816435] Starting dynamic subtest: eDP-1
[189.820501] Dynamic subtest eDP-1: SKIP (0.000s)
[189.824584] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s)
[189.888136] [040/133] (832s left) prime_vgem (fence-read-hang)
[189.956934] Subtest fence-read-hang: SKIP (0.000s)
[190.055132] [041/133] (832s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[190.152445] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[190.156555] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.000s)
[190.240162] [042/133] (832s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[190.332063] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[190.334271] Starting dynamic subtest: pipe-A-default-mode
[191.489759] Dynamic subtest pipe-A-default-mode: SKIP (1.156s)
[191.494090] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.157s)
[191.648089] [043/133] (830s left) gem_exec_alignment (forked)
[191.714734] Starting subtest: forked
[230.247137] Subtest forked: SUCCESS (38.529s)
[231.303496] [044/133] (791s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[231.447061] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[231.449226] Starting dynamic subtest: pipe-A-eDP-1
[231.632937] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.175s)
[231.643828] Starting dynamic subtest: pipe-B-eDP-1
[231.662884] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[231.673268] Starting dynamic subtest: pipe-C-eDP-1
[231.692475] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[231.701642] Starting dynamic subtest: pipe-D-eDP-1
[231.720448] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[231.722390] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.186s)
[233.916498] [045/133] (788s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[234.038500] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[239.609783] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.572s)
[240.734967] [046/133] (781s left) gem_exec_capture (capture)
[240.799423] Starting subtest: capture
[240.801687] Starting dynamic subtest: rcs0-smem
[241.622885] Dynamic subtest rcs0-smem: SUCCESS (0.824s)
[241.632513] Starting dynamic subtest: bcs0-smem
[242.943598] Dynamic subtest bcs0-smem: SUCCESS (1.321s)
[242.953641] Starting dynamic subtest: vcs0-smem
[243.769125] Dynamic subtest vcs0-smem: SUCCESS (0.823s)
[243.778745] Starting dynamic subtest: vcs1-smem
[244.594272] Dynamic subtest vcs1-smem: SUCCESS (0.825s)
[244.603528] Starting dynamic subtest: vecs0-smem
[245.995812] Dynamic subtest vecs0-smem: FAIL (1.344s)
[246.005618] Starting dynamic subtest: ccs0-smem
[247.262476] Dynamic subtest ccs0-smem: SUCCESS (1.325s)
[247.264969] Subtest capture: FAIL (6.466s)
[247.380775] [047/133] (775s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[247.475329] Starting subtest: fbc-modesetfrombusy
[251.196450] Subtest fbc-modesetfrombusy: SUCCESS (3.724s)
[252.371512] [048/133] (770s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[252.471753] Starting subtest: fbcpsr-rgb101010-draw-blt
[259.229098] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.763s)
[259.332421] [049/133] (763s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[259.512965] Starting subtest: cursor-rapid-movement-64x64
[259.518059] Starting dynamic subtest: pipe-A-eDP-1
[260.060414] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.542s)
[260.090231] Starting dynamic subtest: pipe-D-eDP-1
[261.325332] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.244s)
[261.327701] Subtest cursor-rapid-movement-64x64: SUCCESS (1.812s)
[262.181651] [050/133] (760s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[262.290398] Starting subtest: plane-primary-toggle-with-vblank-wait
[262.292677] Starting dynamic subtest: pipe-A-eDP-1
[262.463379] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.174s)
[262.782179] Starting dynamic subtest: pipe-B-eDP-1
[263.687882] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.914s)
[263.992850] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.704s)
[264.834163] [051/133] (757s left) perf_pmu (busy-accuracy-98)
[264.884275] Starting subtest: busy-accuracy-98
[264.887097] Starting dynamic subtest: rcs0
[267.924193] Dynamic subtest rcs0: SUCCESS (3.037s)
[267.935852] Starting dynamic subtest: bcs0
[270.975607] Dynamic subtest bcs0: SUCCESS (3.049s)
[270.986119] Starting dynamic subtest: vcs0
[274.020070] Dynamic subtest vcs0: SUCCESS (3.042s)
[274.030901] Starting dynamic subtest: vcs1
[277.065144] Dynamic subtest vcs1: SUCCESS (3.042s)
[277.075791] Starting dynamic subtest: vecs0
[280.106311] Dynamic subtest vecs0: SUCCESS (3.039s)
[280.117496] Starting dynamic subtest: ccs0
[283.158783] Dynamic subtest ccs0: SUCCESS (3.049s)
[283.161894] Subtest busy-accuracy-98: SUCCESS (18.272s)
[283.272168] [052/133] (739s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[283.344807] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[283.347305] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[283.444196] [053/133] (739s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[283.555235] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[283.559225] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[283.651802] [054/133] (739s left) kms_big_fb (4-tiled-addfb-size-overflow)
[283.757624] Starting subtest: 4-tiled-addfb-size-overflow
[283.760046] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[283.856376] [055/133] (739s left) gem_ctx_bad_destroy (invalid-default-ctx)
[283.922072] Starting subtest: invalid-default-ctx
[283.924464] Subtest invalid-default-ctx: SUCCESS (0.000s)
[283.996588] [056/133] (738s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[284.099247] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[284.101749] Starting dynamic subtest: pipe-A-eDP-1
[284.124602] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[284.134356] Starting dynamic subtest: pipe-B-eDP-1
[284.155884] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[284.170569] Starting dynamic subtest: pipe-C-eDP-1
[284.189946] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[284.199064] Starting dynamic subtest: pipe-D-eDP-1
[284.217338] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[284.220786] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.005s)
[286.402849] [057/133] (736s left) i915_module_load (resize-bar)
[286.439999] Starting subtest: resize-bar
[286.450201] Subtest resize-bar: SKIP (0.008s)
[286.542889] [058/133] (736s left) gem_bad_reloc (negative-reloc)
[286.603922] Subtest negative-reloc: SKIP (0.000s)
[286.670567] [059/133] (736s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[286.774921] Starting subtest: fbc-1p-pri-indfb-multidraw
[299.632544] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (12.859s)
[301.038721] [060/133] (722s left) kms_pm_backlight (fade)
[301.134888] Starting subtest: fade
[301.186603] Starting dynamic subtest: eDP-1
[303.656764] Dynamic subtest eDP-1: SUCCESS (2.471s)
[303.659093] Subtest fade: SUCCESS (2.521s)
[304.447565] [061/133] (718s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[304.588252] Starting subtest: cursor-vs-flip-legacy
[333.986055] Subtest cursor-vs-flip-legacy: SUCCESS (29.395s)
[334.785499] [062/133] (688s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[334.898229] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[334.900553] Starting dynamic subtest: pipe-A
[334.920300] Dynamic subtest pipe-A: SKIP (0.017s)
[334.929079] Starting dynamic subtest: pipe-B
[334.948736] Dynamic subtest pipe-B: SKIP (0.029s)
[334.957068] Starting dynamic subtest: pipe-C
[334.979317] Dynamic subtest pipe-C: SKIP (0.030s)
[334.987483] Starting dynamic subtest: pipe-D
[335.009979] Dynamic subtest pipe-D: SKIP (0.029s)
[335.013745] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.108s)
[335.125468] [063/133] (688s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[335.228099] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[335.232275] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[335.342510] [064/133] (687s left) gem_exec_fence (long-history)
[335.816834] Starting subtest: long-history
[342.648083] Subtest long-history: SUCCESS (6.832s)
[343.164913] [065/133] (680s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[343.287451] Starting subtest: cursorA-vs-flipA-atomic
[354.416742] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.128s)
[355.213968] [066/133] (668s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[355.312358] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[361.995362] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.686s)
[362.099326] [067/133] (661s left) perf (i915-ref-count)
[362.174029] Starting subtest: i915-ref-count
[362.242126] Subtest i915-ref-count: SUCCESS (0.070s)
[362.296502] [068/133] (661s left) kms_psr (psr-basic)
[362.390074] Starting subtest: psr-basic
[362.392372] Starting dynamic subtest: eDP-1
[364.045533] Dynamic subtest eDP-1: SUCCESS (1.656s)
[364.047867] Subtest psr-basic: SUCCESS (1.657s)
[364.918770] [069/133] (658s left) gem_softpin (evict-prime)
[364.972898] Starting subtest: evict-prime
[364.975174] Starting dynamic subtest: rcs0
[366.122829] Dynamic subtest rcs0: SUCCESS (1.149s)
[366.134728] Starting dynamic subtest: bcs0
[367.241921] Dynamic subtest bcs0: SUCCESS (1.117s)
[367.252813] Starting dynamic subtest: vcs0
[368.914743] Dynamic subtest vcs0: SUCCESS (1.670s)
[368.926163] Starting dynamic subtest: vcs1
[370.836799] Dynamic subtest vcs1: SUCCESS (1.919s)
[370.847266] Starting dynamic subtest: vecs0
[372.879324] Dynamic subtest vecs0: SUCCESS (2.040s)
[372.895196] Starting dynamic subtest: ccs0
[373.998605] Dynamic subtest ccs0: SUCCESS (1.118s)
[374.007993] Starting dynamic subtest: all
[375.890301] Dynamic subtest all: SUCCESS (1.889s)
[375.892775] Subtest evict-prime: SUCCESS (10.917s)
[375.982439] [070/133] (647s left) gem_ctx_persistence (saturated-hostile)
[376.050576] Starting subtest: saturated-hostile
[376.053026] Starting dynamic subtest: rcs0
[376.889519] Dynamic subtest rcs0: SUCCESS (0.839s)
[376.902952] Starting dynamic subtest: bcs0
[377.687675] Dynamic subtest bcs0: SUCCESS (0.796s)
[377.702209] Starting dynamic subtest: vcs0
[378.489220] Dynamic subtest vcs0: SUCCESS (0.798s)
[378.501145] Starting dynamic subtest: vcs1
[379.277734] Dynamic subtest vcs1: SUCCESS (0.786s)
[379.291935] Starting dynamic subtest: vecs0
[380.082931] Dynamic subtest vecs0: SUCCESS (0.803s)
[380.095243] Starting dynamic subtest: ccs0
[380.908743] Dynamic subtest ccs0: SUCCESS (0.824s)
[380.914512] Subtest saturated-hostile: SUCCESS (4.859s)
[381.018440] [071/133] (642s left) kms_invalid_mode (bad-hsync-start)
[381.112263] Starting subtest: bad-hsync-start
[381.114514] Starting dynamic subtest: pipe-A-eDP-1
[381.398955] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[381.408253] Starting dynamic subtest: pipe-B-eDP-1
[381.410477] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[381.418991] Starting dynamic subtest: pipe-C-eDP-1
[381.421364] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[381.430080] Starting dynamic subtest: pipe-D-eDP-1
[381.432410] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[381.434737] Subtest bad-hsync-start: SUCCESS (0.296s)
[382.236985] [072/133] (641s left) sw_sync (timeline_closed)
[382.282155] Starting subtest: timeline_closed
[382.284474] Subtest timeline_closed: SUCCESS (0.000s)
[382.337799] [073/133] (641s left) gem_create (create-ext-set-pat)
[382.506329] Starting subtest: create-ext-set-pat
[382.508521] Subtest create-ext-set-pat: SUCCESS (0.001s)
[382.599819] [074/133] (641s left) kms_dsc (dsc-with-bpc-formats)
[382.701216] Starting subtest: dsc-with-bpc-formats
[382.812652] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[382.853268] [075/133] (640s left) gem_vm_create (execbuf)
[382.904154] Starting subtest: execbuf
[382.910647] Subtest execbuf: SUCCESS (0.007s)
[383.016178] [076/133] (640s left) gem_ctx_param (invalid-param-get)
[383.074832] Starting subtest: invalid-param-get
[383.077123] Subtest invalid-param-get: SUCCESS (0.001s)
[383.201682] [077/133] (640s left) gem_sync (basic-store-all)
[383.261054] Starting subtest: basic-store-all
[386.328877] Subtest basic-store-all: SUCCESS (3.078s)
[386.513745] [078/133] (637s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[386.622875] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[394.001406] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.382s)
[394.120064] [079/133] (629s left) gem_close_race (basic-threads)
[394.180301] Starting subtest: basic-threads
[395.548175] Subtest basic-threads: SUCCESS (1.370s)
[395.748534] [080/133] (628s left) kms_cursor_crc (cursor-tearing-position-change)
[395.867319] Starting subtest: cursor-tearing-position-change
[395.869635] Starting dynamic subtest: pipe-A-eDP-1
[396.434276] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.564s)
[396.443650] Starting dynamic subtest: pipe-D-eDP-1
[397.697038] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.260s)
[397.699197] Subtest cursor-tearing-position-change: SUCCESS (1.827s)
[398.532802] [081/133] (625s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[398.661211] Starting subtest: modeset-atomic-cursor-hotspot
[398.665604] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[398.807605] [082/133] (625s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[398.904682] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[398.909239] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[398.986504] [083/133] (625s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[399.386504] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[400.167930] [084/133] (624s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[400.271590] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[400.276118] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[400.370402] [085/133] (623s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[400.474361] Starting subtest: x-tiled-16bpp-rotate-0
[401.820292] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.346s)
[401.939363] [086/133] (622s left) i915_suspend (sysfs-reader)
[401.999938] Starting subtest: sysfs-reader
[420.343720] Subtest sysfs-reader: SUCCESS (3.967s)
[420.454378] [087/133] (603s left) gem_lmem_swapping (random)
[420.506446] Subtest random: SKIP (0.000s)
[420.558443] [088/133] (603s left) gem_exec_fence (syncobj-timeline-wait)
[421.136826] Starting subtest: syncobj-timeline-wait
[422.293076] Subtest syncobj-timeline-wait: SUCCESS (1.140s)
[422.486388] [089/133] (601s left) gem_mmap_wc (invalid-flags)
[422.549036] Subtest invalid-flags: SKIP (0.000s)
[422.611739] [090/133] (601s left) gem_exec_flush (basic-wb-rw-before-default)
[422.677550] Starting subtest: basic-wb-rw-before-default
[428.187202] Subtest basic-wb-rw-before-default: SUCCESS (5.459s)
[428.378704] [091/133] (596s left) i915_query (query-topology-coherent-slice-mask)
[428.436166] Starting subtest: query-topology-coherent-slice-mask
[428.440362] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[428.529144] [092/133] (596s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[428.625283] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[428.627608] Starting dynamic subtest: pipe-A-eDP-1
[428.636626] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[428.647478] Starting dynamic subtest: pipe-B-eDP-1
[428.656568] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[428.666690] Starting dynamic subtest: pipe-C-eDP-1
[428.675102] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[428.684157] Starting dynamic subtest: pipe-D-eDP-1
[428.692867] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[428.697279] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[430.874926] [093/133] (593s left) kms_big_fb (linear-32bpp-rotate-180)
[430.977776] Starting subtest: linear-32bpp-rotate-180
[432.442354] Subtest linear-32bpp-rotate-180: SUCCESS (1.458s)
[432.575477] [094/133] (592s left) prime_busy (after-wait)
[432.630561] Starting subtest: after-wait
[432.635310] Starting dynamic subtest: rcs0
[432.676278] Dynamic subtest rcs0: SUCCESS (0.042s)
[432.688363] Starting dynamic subtest: bcs0
[432.734135] Dynamic subtest bcs0: SUCCESS (0.056s)
[432.745037] Starting dynamic subtest: vcs0
[432.774930] Dynamic subtest vcs0: SUCCESS (0.040s)
[432.784738] Starting dynamic subtest: vcs1
[432.814794] Dynamic subtest vcs1: SUCCESS (0.039s)
[432.824470] Starting dynamic subtest: vecs0
[432.855652] Dynamic subtest vecs0: SUCCESS (0.040s)
[432.864944] Starting dynamic subtest: ccs0
[432.894477] Dynamic subtest ccs0: SUCCESS (0.038s)
[433.002229] Subtest after-wait: SUCCESS (0.368s)
[433.078579] [095/133] (591s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[433.176158] Starting subtest: y-tiled-64bpp-rotate-0
[433.180727] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[433.307411] [096/133] (591s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[433.409902] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[439.959352] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.536s)
[440.089993] [097/133] (584s left) gem_pxp (reject-modify-context-protection-off-2)
[440.210849] Starting subtest: reject-modify-context-protection-off-2
[440.213662] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[440.315995] [098/133] (584s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[440.420488] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[440.424692] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[440.543785] [099/133] (584s left) gem_ctx_persistence (engines-hostile-preempt)
[440.601460] Starting subtest: engines-hostile-preempt
[440.603648] Starting dynamic subtest: rcs0
[440.679138] Dynamic subtest rcs0: SUCCESS (0.080s)
[440.692319] Starting dynamic subtest: bcs0
[440.735986] Dynamic subtest bcs0: SUCCESS (0.055s)
[440.747976] Starting dynamic subtest: vcs0
[442.286602] Dynamic subtest vcs0: SUCCESS (1.545s)
[442.299386] Starting dynamic subtest: vcs1
[444.278820] Dynamic subtest vcs1: SUCCESS (1.987s)
[444.290410] Starting dynamic subtest: vecs0
[446.258638] Dynamic subtest vecs0: SUCCESS (1.975s)
[446.270574] Starting dynamic subtest: ccs0
[446.285723] Dynamic subtest ccs0: SUCCESS (0.026s)
[446.288045] Subtest engines-hostile-preempt: SUCCESS (5.680s)
[446.404053] [100/133] (578s left) gem_ctx_param (non-root-set)
[446.455891] Starting subtest: non-root-set
[446.474204] Subtest non-root-set: SUCCESS (0.018s)
[446.572234] [101/133] (578s left) kms_pm_rpm (i2c)
[448.430055] Starting subtest: i2c
[453.575181] Subtest i2c: SUCCESS (5.148s)
[453.665601] [102/133] (571s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[453.732171] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[453.795583] [103/133] (571s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[453.898718] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[461.695223] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.800s)
[461.820842] [104/133] (563s left) kms_psr (fbc-pr-primary-blt)
[461.917011] Starting subtest: fbc-pr-primary-blt
[461.921011] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[461.989809] [105/133] (563s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[462.092216] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[462.096537] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[462.212484] [106/133] (562s left) kms_vblank (query-idle)
[462.304074] Starting subtest: query-idle
[462.306346] Starting dynamic subtest: pipe-A-eDP-1
[464.047931] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.742s)
[464.063024] Starting dynamic subtest: pipe-D-eDP-1
[466.490971] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.438s)
[466.492912] Subtest query-idle: SUCCESS (4.185s)
[467.326709] [107/133] (557s left) kms_async_flips (crc)
[467.438240] Starting subtest: crc
[467.811363] Starting dynamic subtest: pipe-A-eDP-1
[470.735137] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.922s)
[471.121357] Starting dynamic subtest: pipe-B-eDP-1
[474.075486] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.962s)
[474.447917] Starting dynamic subtest: pipe-C-eDP-1
[477.377712] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.937s)
[477.758992] Starting dynamic subtest: pipe-D-eDP-1
[480.616480] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.865s)
[480.618835] Subtest crc: SUCCESS (13.176s)
[481.798692] [108/133] (543s left) gem_exec_whisper (basic-queues-forked-all)
[481.868126] Starting subtest: basic-queues-forked-all
[501.518182] Subtest basic-queues-forked-all: SUCCESS (19.638s)
[501.706407] [109/133] (523s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[501.820198] Starting subtest: yf-tiled-8bpp-rotate-270
[501.824401] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[501.916723] [110/133] (523s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[502.008564] Starting subtest: psr-rgb565-draw-pwrite
[508.954720] Subtest psr-rgb565-draw-pwrite: SUCCESS (6.946s)
[509.065486] [111/133] (516s left) vgem_basic (busy-fence)
[509.108741] Starting subtest: busy-fence
[509.111130] Subtest busy-fence: SUCCESS (0.000s)
[509.170436] [112/133] (516s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping)
[509.267192] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping
[509.294263] Starting dynamic subtest: pipe-A-plane-0
[509.582994] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[509.593704] Starting dynamic subtest: pipe-A-plane-3
[509.816177] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[510.899685] Starting dynamic subtest: pipe-B-plane-0
[511.192137] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[511.204474] Starting dynamic subtest: pipe-B-plane-3
[511.437777] Dynamic subtest pipe-B-plane-3: SUCCESS (0.244s)
[511.761141] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.494s)
[512.590188] [113/133] (512s left) kms_content_protection (atomic-hdcp14)
[512.731085] Starting subtest: atomic-hdcp14
[512.735686] Subtest atomic-hdcp14: SKIP (0.000s)
[512.846901] [114/133] (512s left) kms_flip (plain-flip-ts-check-interruptible)
[512.949691] Starting subtest: plain-flip-ts-check-interruptible
[512.952120] Starting dynamic subtest: A-eDP1
[521.781793] Dynamic subtest A-eDP1: SUCCESS (8.833s)
[521.794742] Starting dynamic subtest: B-eDP1
[530.612942] Dynamic subtest B-eDP1: SUCCESS (8.830s)
[530.627873] Starting dynamic subtest: C-eDP1
[539.425252] Dynamic subtest C-eDP1: SUCCESS (8.811s)
[539.436474] Starting dynamic subtest: D-eDP1
[548.249913] Dynamic subtest D-eDP1: SUCCESS (8.823s)
[548.254346] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.310s)
[549.430783] [115/133] (476s left) kms_flip (basic-plain-flip)
[549.524679] Starting subtest: basic-plain-flip
[549.527046] Starting dynamic subtest: A-eDP1
[551.230175] Dynamic subtest A-eDP1: SUCCESS (1.704s)
[551.241268] Starting dynamic subtest: B-eDP1
[552.967935] Dynamic subtest B-eDP1: SUCCESS (1.735s)
[552.982114] Starting dynamic subtest: C-eDP1
[554.596058] Dynamic subtest C-eDP1: SUCCESS (1.625s)
[554.611870] Starting dynamic subtest: D-eDP1
[556.228226] Dynamic subtest D-eDP1: SUCCESS (1.629s)
[556.233269] Subtest basic-plain-flip: SUCCESS (6.709s)
[557.400968] [116/133] (468s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[557.500855] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[557.505064] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[557.624073] [117/133] (468s left) gem_exec_schedule (preempt-hang)
[557.796406] Starting subtest: preempt-hang
[557.799145] Starting dynamic subtest: rcs0
[558.037282] Dynamic subtest rcs0: SUCCESS (0.237s)
[558.047953] Starting dynamic subtest: bcs0
[558.295415] Dynamic subtest bcs0: SUCCESS (0.258s)
[558.305958] Starting dynamic subtest: vcs0
[558.523163] Dynamic subtest vcs0: SUCCESS (0.225s)
[558.537233] Starting dynamic subtest: vcs1
[558.746690] Dynamic subtest vcs1: SUCCESS (0.222s)
[558.758270] Starting dynamic subtest: vecs0
[558.975477] Dynamic subtest vecs0: SUCCESS (0.226s)
[558.988380] Starting dynamic subtest: ccs0
[559.204180] Dynamic subtest ccs0: SUCCESS (0.230s)
[559.206202] Subtest preempt-hang: SUCCESS (1.406s)
[560.356898] [118/133] (465s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[560.459771] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[560.461997] Starting dynamic subtest: pipe-A-eDP-1
[560.536151] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[560.546583] Starting dynamic subtest: pipe-B-eDP-1
[561.680656] Dynamic subtest pipe-B-eDP-1: SKIP (1.143s)
[561.685227] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.224s)
[562.890371] [119/133] (462s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[562.997244] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[567.544541] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.549s)
[568.677526] [120/133] (457s left) gem_exec_schedule (u-semaphore-user)
[568.751094] Starting subtest: u-semaphore-user
[568.806645] Subtest u-semaphore-user: SUCCESS (0.062s)
[570.346569] [121/133] (455s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[570.409055] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[570.473556] [122/133] (455s left) gem_fence_thrash (bo-copy)
[570.509015] Starting subtest: bo-copy
[570.527068] Subtest bo-copy: SKIP (0.016s)
[570.590901] [123/133] (455s left) sw_sync (alloc_fence)
[570.629621] Starting subtest: alloc_fence
[570.631855] Subtest alloc_fence: SUCCESS (0.000s)
[570.679126] [124/133] (455s left) gem_exec_store (cachelines)
[570.745213] Starting subtest: cachelines
[570.747349] Starting dynamic subtest: rcs0
[570.806705] Dynamic subtest rcs0: SUCCESS (0.063s)
[570.819106] Starting dynamic subtest: bcs0
[570.858618] Dynamic subtest bcs0: SUCCESS (0.050s)
[570.870724] Starting dynamic subtest: vcs0
[570.912867] Dynamic subtest vcs0: SUCCESS (0.052s)
[570.925344] Starting dynamic subtest: vcs1
[570.972638] Dynamic subtest vcs1: SUCCESS (0.058s)
[570.984687] Starting dynamic subtest: vecs0
[571.028785] Dynamic subtest vecs0: SUCCESS (0.054s)
[571.040388] Starting dynamic subtest: ccs0
[571.087136] Dynamic subtest ccs0: SUCCESS (0.057s)
[571.089801] Subtest cachelines: SUCCESS (0.344s)
[571.274759] [125/133] (454s left) gem_mmap_wc (write-cpu-read-wc)
[571.327370] Subtest write-cpu-read-wc: SKIP (0.000s)
[571.387544] [126/133] (454s left) gem_render_copy (yf-tiled-to-vebox-linear)
[571.435605] Starting subtest: yf-tiled-to-vebox-linear
[571.439106] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[571.623896] [127/133] (454s left) kms_plane_cursor (viewport)
[571.732426] Starting subtest: viewport
[571.736864] Starting dynamic subtest: pipe-A-eDP-1-size-64
[574.362273] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.630s)
[574.428500] Starting dynamic subtest: pipe-A-eDP-1-size-128
[576.884593] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.470s)
[576.946408] Starting dynamic subtest: pipe-A-eDP-1-size-256
[579.487313] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.549s)
[579.839100] Starting dynamic subtest: pipe-B-eDP-1-size-64
[583.059488] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.231s)
[583.121636] Starting dynamic subtest: pipe-B-eDP-1-size-128
[585.572791] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.460s)
[585.635433] Starting dynamic subtest: pipe-B-eDP-1-size-256
[588.152359] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.528s)
[588.516771] Starting dynamic subtest: pipe-C-eDP-1-size-64
[591.376888] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.870s)
[591.415421] Starting dynamic subtest: pipe-C-eDP-1-size-128
[593.499881] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.092s)
[593.538861] Starting dynamic subtest: pipe-C-eDP-1-size-256
[595.634856] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.103s)
[595.961919] Starting dynamic subtest: pipe-D-eDP-1-size-64
[598.758789] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.806s)
[598.797547] Starting dynamic subtest: pipe-D-eDP-1-size-128
[600.991502] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.203s)
[601.031049] Starting dynamic subtest: pipe-D-eDP-1-size-256
[603.203399] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.180s)
[603.527527] Subtest viewport: SUCCESS (31.787s)
[604.339352] [128/133] (421s left) gem_eio (wait-wedge-10ms)
[604.578431] Starting subtest: wait-wedge-10ms
[606.334585] Subtest wait-wedge-10ms: SUCCESS (1.754s)
[606.491074] [129/133] (419s left) core_sysfs (read-all-entries)
[606.539292] Starting subtest: read-all-entries
[606.545149] Subtest read-all-entries: SUCCESS (0.008s)
[606.620232] [130/133] (419s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[606.717189] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[606.719566] Starting dynamic subtest: pipe-A-eDP-1
[606.835951] Dynamic subtest pipe-A-eDP-1: SKIP (0.122s)
[606.847121] Starting dynamic subtest: pipe-B-eDP-1
[608.017634] Dynamic subtest pipe-B-eDP-1: SKIP (1.179s)
[608.021830] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.304s)
[609.205697] [131/133] (417s left) kms_plane_scaling (invalid-parameters)
[609.312001] Starting subtest: invalid-parameters
[609.314111] Starting dynamic subtest: less-than-1-height-src
[609.324168] Dynamic subtest less-than-1-height-src: SUCCESS (0.014s)
[609.334755] Starting dynamic subtest: less-than-1-width-src
[609.339888] Dynamic subtest less-than-1-width-src: SUCCESS (0.013s)
[609.342167] Subtest invalid-parameters: SUCCESS (0.028s)
[609.424799] [132/133] (416s left) kms_psr (fbc-psr2-suspend)
[609.529926] Starting subtest: fbc-psr2-suspend
[609.532102] Starting dynamic subtest: eDP-1
[609.536056] Dynamic subtest eDP-1: SKIP (0.000s)
[609.539996] Subtest fbc-psr2-suspend: SKIP (0.001s)
[609.645707] [133/133] (416s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[609.747407] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[617.202708] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.455s)
[617.339751] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_pread
results: parsing output: 2/ for test: gem_flink_race
results: parsing output: 3/ for test: kms_cursor_crc
results: parsing output: 4/ for test: gem_exec_balancer
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: kms_lease
results: parsing output: 7/ for test: syncobj_wait
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: i915_pm_rc6_residency
results: parsing output: 10/ for test: kms_universal_plane
results: parsing output: 11/ for test: prime_mmap
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: vgem_basic
results: parsing output: 15/ for test: gen9_exec_parse
results: parsing output: 16/ for test: gem_exec_params
results: parsing output: 17/ for test: kms_ccs
results: parsing output: 18/ for test: kms_flip
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: gem_mmap_gtt
results: parsing output: 21/ for test: perf_pmu
results: parsing output: 22/ for test: api_intel_bb
results: parsing output: 23/ for test: kms_scaling_modes
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_atomic_transition
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: kms_flip
results: parsing output: 28/ for test: perf_pmu
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_color
results: parsing output: 32/ for test: kms_plane_alpha_blend
results: parsing output: 33/ for test: i915_drm_fdinfo
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: kms_addfb_basic
results: parsing output: 36/ for test: kms_chamelium_color
results: parsing output: 37/ for test: kms_chamelium_frames
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: prime_vgem
results: parsing output: 40/ for test: kms_flip_scaled_crc
results: parsing output: 41/ for test: kms_flip_scaled_crc
results: parsing output: 42/ for test: gem_exec_alignment
results: parsing output: 43/ for test: kms_ccs
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_exec_capture
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_cursor_crc
results: parsing output: 49/ for test: kms_atomic_transition
results: parsing output: 50/ for test: perf_pmu
results: parsing output: 51/ for test: syncobj_timeline
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: gem_ctx_bad_destroy
results: parsing output: 55/ for test: kms_ccs
results: parsing output: 56/ for test: i915_module_load
results: parsing output: 57/ for test: gem_bad_reloc
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_pm_backlight
results: parsing output: 60/ for test: kms_cursor_legacy
results: parsing output: 61/ for test: kms_plane_scaling
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_exec_fence
results: parsing output: 64/ for test: kms_cursor_legacy
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: perf
results: parsing output: 67/ for test: kms_psr
results: parsing output: 68/ for test: gem_softpin
results: parsing output: 69/ for test: gem_ctx_persistence
results: parsing output: 70/ for test: kms_invalid_mode
results: parsing output: 71/ for test: sw_sync
results: parsing output: 72/ for test: gem_create
results: parsing output: 73/ for test: kms_dsc
results: parsing output: 74/ for test: gem_vm_create
results: parsing output: 75/ for test: gem_ctx_param
results: parsing output: 76/ for test: gem_sync
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_close_race
results: parsing output: 79/ for test: kms_cursor_crc
results: parsing output: 80/ for test: kms_cursor_legacy
results: parsing output: 81/ for test: kms_flip_scaled_crc
results: parsing output: 82/ for test: kms_chamelium_hpd
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: i915_suspend
results: parsing output: 86/ for test: gem_lmem_swapping
results: parsing output: 87/ for test: gem_exec_fence
results: parsing output: 88/ for test: gem_mmap_wc
results: parsing output: 89/ for test: gem_exec_flush
results: parsing output: 90/ for test: i915_query
results: parsing output: 91/ for test: kms_ccs
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: prime_busy
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_pxp
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: gem_ctx_persistence
results: parsing output: 99/ for test: gem_ctx_param
results: parsing output: 100/ for test: kms_pm_rpm
results: parsing output: 101/ for test: gem_mmap_gtt
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_psr
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_vblank
results: parsing output: 106/ for test: kms_async_flips
results: parsing output: 107/ for test: gem_exec_whisper
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: vgem_basic
results: parsing output: 111/ for test: kms_plane
results: parsing output: 112/ for test: kms_content_protection
results: parsing output: 113/ for test: kms_flip
results: parsing output: 114/ for test: kms_flip
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: gem_exec_schedule
results: parsing output: 117/ for test: kms_psr2_sf
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: gem_exec_schedule
results: parsing output: 120/ for test: gem_fenced_exec_thrash
results: parsing output: 121/ for test: gem_fence_thrash
results: parsing output: 122/ for test: sw_sync
results: parsing output: 123/ for test: gem_exec_store
results: parsing output: 124/ for test: gem_mmap_wc
results: parsing output: 125/ for test: gem_render_copy
results: parsing output: 126/ for test: kms_plane_cursor
results: parsing output: 127/ for test: gem_eio
results: parsing output: 128/ for test: core_sysfs
results: parsing output: 129/ for test: kms_psr2_sf
results: parsing output: 130/ for test: kms_plane_scaling
results: parsing output: 131/ for test: kms_psr
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.