[60.494727] Initializing watchdogs
[60.494773]   /dev/watchdog0
[60.510276] [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.515118] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.517320] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.520561] [001/131] (960s left) gem_exec_schedule (u-independent)
[60.616878] Starting subtest: u-independent
[60.619078] Starting dynamic subtest: rcs0
[61.908549] Dynamic subtest rcs0: SUCCESS (1.285s)
[61.919693] Starting dynamic subtest: vcs0
[63.904555] Dynamic subtest vcs0: SUCCESS (1.982s)
[63.913622] Starting dynamic subtest: vcs1
[65.913859] Dynamic subtest vcs1: SUCCESS (1.998s)
[65.923698] Starting dynamic subtest: vecs0
[67.940030] Dynamic subtest vecs0: SUCCESS (2.019s)
[67.947316] Starting dynamic subtest: ccs0
[69.908700] Dynamic subtest ccs0: SUCCESS (1.961s)
[69.910808] Subtest u-independent: SUCCESS (9.247s)
[70.204042] [002/131] (950s left) gem_exec_params (invalid-flag)
[70.271943] Starting subtest: invalid-flag
[70.274442] Subtest invalid-flag: SUCCESS (0.000s)
[70.382244] [003/131] (950s left) prime_vgem (fence-wait)
[70.474464] Starting subtest: fence-wait
[70.476726] Starting dynamic subtest: rcs0
[71.510684] Dynamic subtest rcs0: SUCCESS (1.033s)
[71.519950] Starting dynamic subtest: bcs0
[72.714234] Dynamic subtest bcs0: SUCCESS (1.201s)
[72.724715] Starting dynamic subtest: vcs0
[73.762175] Dynamic subtest vcs0: SUCCESS (1.046s)
[73.774087] Starting dynamic subtest: vcs1
[74.803863] Dynamic subtest vcs1: SUCCESS (1.040s)
[74.813856] Starting dynamic subtest: vecs0
[75.847851] Dynamic subtest vecs0: SUCCESS (1.041s)
[75.858056] Starting dynamic subtest: ccs0
[76.890563] Dynamic subtest ccs0: SUCCESS (1.041s)
[76.893213] Subtest fence-wait: SUCCESS (6.405s)
[77.040203] [FACT prime_vgem (fence-wait)] new: kernel.kmod_is_loaded.vgem: true
[77.043379] [004/131] (944s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[77.158663] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[81.626037] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.468s)
[82.809041] [005/131] (938s left) core_sysfs (read-all-entries)
[82.853609] Starting subtest: read-all-entries
[82.857839] Subtest read-all-entries: SUCCESS (0.003s)
[82.961776] [006/131] (938s left) perf (whitelisted-registers-userspace-config)
[83.091451] Starting subtest: whitelisted-registers-userspace-config
[83.093744] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[83.132994] [007/131] (938s left) api_intel_allocator (reloc-allocator)
[83.196787] Starting subtest: reloc-allocator
[83.198679] Starting dynamic subtest: basic
[83.200898] Dynamic subtest basic: SUCCESS (0.005s)
[83.210177] Starting dynamic subtest: parallel-one
[83.212314] Dynamic subtest parallel-one: SUCCESS (0.006s)
[83.223958] Starting dynamic subtest: print
[83.226445] Dynamic subtest print: SUCCESS (0.000s)
[83.234899] Starting dynamic subtest: reuse
[83.237206] Dynamic subtest reuse: SUCCESS (0.000s)
[83.245109] Starting dynamic subtest: fork-reopen-allocator
[83.247236] Dynamic subtest fork-reopen-allocator: SUCCESS (0.013s)
[83.249183] Subtest reloc-allocator: SUCCESS (0.025s)
[83.358255] [008/131] (937s left) gem_exec_balancer (bonded-pair)
[83.419395] Starting subtest: bonded-pair
[83.423903] Subtest bonded-pair: SKIP (0.000s)
[83.725849] [009/131] (937s left) kms_psr (fbc-pr-dpms)
[83.826116] Starting subtest: fbc-pr-dpms
[83.830642] Subtest fbc-pr-dpms: SKIP (0.000s)
[83.903855] [010/131] (937s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[83.998599] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[90.123348] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.129s)
[91.299748] [011/131] (930s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[91.405545] Starting subtest: fbc-shrfb-scaledprimary
[96.496901] Subtest fbc-shrfb-scaledprimary: SUCCESS (5.096s)
[97.701023] [012/131] (923s left) syncobj_timeline (signal-point-0)
[97.752054] Starting subtest: signal-point-0
[97.754453] Subtest signal-point-0: SUCCESS (0.001s)
[97.867609] [013/131] (923s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[97.974938] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[105.225912] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.255s)
[105.381649] [014/131] (916s left) kms_big_fb (linear-64bpp-rotate-180)
[105.486254] Starting subtest: linear-64bpp-rotate-180
[107.075519] Subtest linear-64bpp-rotate-180: SUCCESS (1.589s)
[107.262841] [015/131] (914s left) gem_exec_schedule (independent)
[107.340451] Starting subtest: independent
[107.342431] Starting dynamic subtest: rcs0
[108.884999] Dynamic subtest rcs0: SUCCESS (1.553s)
[108.895826] Starting dynamic subtest: vcs0
[110.973223] Dynamic subtest vcs0: SUCCESS (2.088s)
[110.983556] Starting dynamic subtest: vcs1
[112.962757] Dynamic subtest vcs1: SUCCESS (1.990s)
[112.974099] Starting dynamic subtest: vecs0
[114.928510] Dynamic subtest vecs0: SUCCESS (1.966s)
[114.942234] Starting dynamic subtest: ccs0
[116.883098] Dynamic subtest ccs0: SUCCESS (1.955s)
[116.884952] Subtest independent: SUCCESS (9.553s)
[117.195697] [016/131] (904s left) kms_plane_multiple (2x-tiling-y)
[117.304058] Starting subtest: 2x-tiling-y
[117.308383] Subtest 2x-tiling-y: SKIP (0.000s)
[117.374135] [017/131] (904s left) perf_pmu (pmu-read)
[117.408839] Starting subtest: pmu-read
[117.413236] Subtest pmu-read: SUCCESS (0.002s)
[117.518095] [018/131] (904s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[117.609972] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[117.612338] Starting dynamic subtest: pipe-A
[117.951113] Dynamic subtest pipe-A: SUCCESS (0.341s)
[117.958486] Starting dynamic subtest: pipe-B
[119.407781] Dynamic subtest pipe-B: SUCCESS (1.456s)
[119.415072] Starting dynamic subtest: pipe-C
[120.853677] Dynamic subtest pipe-C: SUCCESS (1.446s)
[120.862953] Starting dynamic subtest: pipe-D
[122.276671] Dynamic subtest pipe-D: SUCCESS (1.423s)
[122.279060] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.667s)
[123.450477] [019/131] (898s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[123.546582] Starting subtest: fbcpsr-suspend
[163.087550] Subtest fbcpsr-suspend: SUCCESS (9.816s)
[163.248682] [020/131] (858s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[163.362292] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[163.366557] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[163.468848] [021/131] (858s left) gem_lmem_swapping (heavy-verify-multi)
[163.512726] Subtest heavy-verify-multi: SKIP (0.000s)
[163.555826] [022/131] (858s left) kms_flip (flip-vs-blocking-wf-vblank)
[163.651725] Starting subtest: flip-vs-blocking-wf-vblank
[163.656599] Starting dynamic subtest: A-eDP1
[184.474797] Dynamic subtest A-eDP1: SUCCESS (20.640s)
[184.484500] Starting dynamic subtest: B-eDP1
[193.412734] Dynamic subtest B-eDP1: SUCCESS (8.930s)
[193.423112] Starting dynamic subtest: C-eDP1
[202.322277] Dynamic subtest C-eDP1: SUCCESS (8.911s)
[202.333309] Starting dynamic subtest: D-eDP1
[211.257426] Dynamic subtest D-eDP1: SUCCESS (8.940s)
[211.259834] Subtest flip-vs-blocking-wf-vblank: SUCCESS (47.430s)
[212.486304] [023/131] (809s left) kms_flip (flip-vs-suspend)
[212.587936] Starting subtest: flip-vs-suspend
[212.590337] Starting dynamic subtest: A-eDP1
[261.652070] Dynamic subtest A-eDP1: SUCCESS (4.445s)
[261.661839] Starting dynamic subtest: B-eDP1
[310.659142] Dynamic subtest B-eDP1: SUCCESS (4.398s)
[310.668599] Starting dynamic subtest: C-eDP1
[359.640509] Dynamic subtest C-eDP1: SUCCESS (4.310s)
[359.649543] Starting dynamic subtest: D-eDP1
[408.652585] Dynamic subtest D-eDP1: SUCCESS (4.360s)
[408.655459] Subtest flip-vs-suspend: SUCCESS (17.523s)
[409.813108] [024/131] (612s left) kms_big_fb (linear-16bpp-rotate-90)
[409.937552] Starting subtest: linear-16bpp-rotate-90
[409.957676] Subtest linear-16bpp-rotate-90: SKIP (0.019s)
[410.087716] [025/131] (611s left) gem_softpin (evict-active)
[410.147923] Starting subtest: evict-active
[410.153407] Subtest evict-active: SUCCESS (0.006s)
[410.291991] [026/131] (611s left) i915_hangman (engine-error-state-capture)
[410.356514] Starting subtest: engine-error-state-capture
[410.359545] Starting dynamic subtest: rcs0
[413.918259] Dynamic subtest rcs0: SUCCESS (3.480s)
[413.930446] Starting dynamic subtest: bcs0
[419.935389] Dynamic subtest bcs0: SUCCESS (5.938s)
[419.947399] Starting dynamic subtest: vcs0
[424.862041] Dynamic subtest vcs0: SUCCESS (4.893s)
[424.873635] Starting dynamic subtest: vcs1
[429.854584] Dynamic subtest vcs1: SUCCESS (4.973s)
[429.865635] Starting dynamic subtest: vecs0
[434.846143] Dynamic subtest vecs0: SUCCESS (4.979s)
[434.857803] Starting dynamic subtest: ccs0
[439.902729] Dynamic subtest ccs0: SUCCESS (5.049s)
[439.905775] Subtest engine-error-state-capture: SUCCESS (29.322s)
[439.984720] [027/131] (582s left) gem_exec_reloc (basic-wc-cpu)
[440.042470] Subtest basic-wc-cpu: SKIP (0.000s)
[440.115447] [028/131] (581s left) gem_exec_schedule (semaphore-user)
[440.189283] Starting subtest: semaphore-user
[440.241662] Subtest semaphore-user: SUCCESS (0.061s)
[441.965791] [029/131] (580s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[442.067941] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[442.070314] Starting dynamic subtest: pipe-A-eDP-1
[442.882771] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.803s)
[442.891619] Starting dynamic subtest: pipe-B-eDP-1
[444.367435] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.486s)
[444.376926] Starting dynamic subtest: pipe-C-eDP-1
[445.884196] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.514s)
[445.894300] Starting dynamic subtest: pipe-D-eDP-1
[447.419652] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.536s)
[447.422581] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.342s)
[448.606981] [030/131] (573s left) syncobj_timeline (device-submit-unordered)
[448.669284] Starting subtest: device-submit-unordered
[448.671565] Subtest device-submit-unordered: SUCCESS (0.000s)
[448.769537] [031/131] (573s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[448.860477] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[448.863270] Starting dynamic subtest: pipe-A-default-mode
[449.987117] Dynamic subtest pipe-A-default-mode: SKIP (1.121s)
[449.992343] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.123s)
[450.135653] [032/131] (572s left) kms_plane_alpha_blend (constant-alpha-mid)
[450.228791] Starting subtest: constant-alpha-mid
[450.509244] Starting dynamic subtest: pipe-A-eDP-1
[451.252374] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.743s)
[451.261988] Starting dynamic subtest: pipe-D-eDP-1
[452.702616] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.447s)
[452.705244] Subtest constant-alpha-mid: SUCCESS (2.471s)
[453.504322] [033/131] (568s left) kms_draw_crc (draw-method-mmap-cpu)
[453.611559] Starting subtest: draw-method-mmap-cpu
[453.614135] Starting dynamic subtest: xrgb8888-untiled
[453.833341] Dynamic subtest xrgb8888-untiled: SUCCESS (0.222s)
[453.841627] Starting dynamic subtest: rgb565-untiled
[454.044406] Dynamic subtest rgb565-untiled: SUCCESS (0.210s)
[454.053376] Starting dynamic subtest: xrgb2101010-untiled
[454.255417] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.211s)
[454.264520] Starting dynamic subtest: xbgr16161616f-untiled
[454.455425] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.199s)
[454.464118] Starting dynamic subtest: xrgb8888-xtiled
[454.577060] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[454.585407] Starting dynamic subtest: rgb565-xtiled
[454.699319] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s)
[454.707622] Starting dynamic subtest: xrgb2101010-xtiled
[454.821997] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s)
[454.830767] Starting dynamic subtest: xbgr16161616f-xtiled
[454.944077] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.122s)
[454.952556] Starting dynamic subtest: xrgb8888-4tiled
[455.066025] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.121s)
[455.075764] Starting dynamic subtest: rgb565-4tiled
[455.210659] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s)
[455.218928] Starting dynamic subtest: xrgb2101010-4tiled
[455.322092] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.111s)
[455.336231] Starting dynamic subtest: xbgr16161616f-4tiled
[455.455217] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.132s)
[455.457049] Subtest draw-method-mmap-cpu: SUCCESS (1.846s)
[455.548957] [034/131] (566s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[455.646238] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[455.648359] Starting dynamic subtest: pipe-A-eDP-1
[455.700054] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[455.709272] Starting dynamic subtest: pipe-B-eDP-1
[455.760871] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[455.770465] Starting dynamic subtest: pipe-C-eDP-1
[455.820896] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[455.829519] Starting dynamic subtest: pipe-D-eDP-1
[455.880504] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[455.884640] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.008s)
[457.883739] [035/131] (564s left) prime_vgem (basic-read)
[457.947669] Starting subtest: basic-read
[457.967022] Subtest basic-read: SKIP (0.016s)
[458.081672] [036/131] (564s left) kms_pm_backlight (bad-brightness)
[458.175299] Starting subtest: bad-brightness
[458.228505] Starting dynamic subtest: eDP-1
[458.541433] Dynamic subtest eDP-1: SUCCESS (0.313s)
[458.543871] Subtest bad-brightness: SUCCESS (0.367s)
[459.428152] [037/131] (563s left) kms_psr (fbc-psr2-no-drrs)
[459.523182] Starting subtest: fbc-psr2-no-drrs
[459.526382] Starting dynamic subtest: eDP-1
[459.532581] Dynamic subtest eDP-1: SKIP (0.000s)
[459.538358] Subtest fbc-psr2-no-drrs: SKIP (0.001s)
[459.622748] [038/131] (562s left) sw_sync (sync_multi_producer_single_consumer)
[459.661790] Starting subtest: sync_multi_producer_single_consumer
[460.735518] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s)
[460.796391] [039/131] (561s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[460.907530] Starting subtest: y-tiled-8bpp-rotate-180
[460.912285] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[461.024820] [040/131] (561s left) gem_pxp (create-regular-context-2)
[461.153390] Starting subtest: create-regular-context-2
[461.156618] Subtest create-regular-context-2: SUCCESS (0.002s)
[461.277146] [041/131] (561s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[461.337446] Starting subtest: etime-multi-wait-for-submit-submitted
[461.443999] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.107s)
[461.524989] [042/131] (561s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[461.627421] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[465.266506] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.644s)
[466.441094] [043/131] (556s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[466.502406] Starting subtest: wait-all-for-submit-delayed-submit
[466.606889] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.104s)
[466.680321] [044/131] (556s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[466.779259] Starting subtest: fbcpsr-tiling-4
[473.717252] Subtest fbcpsr-tiling-4: SUCCESS (6.938s)
[473.854965] [045/131] (548s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[473.948070] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[473.950359] Starting dynamic subtest: pipe-A-eDP-1
[473.972160] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[473.982322] Starting dynamic subtest: pipe-B-eDP-1
[474.004210] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[474.012427] Starting dynamic subtest: pipe-C-eDP-1
[474.034447] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[474.042790] Starting dynamic subtest: pipe-D-eDP-1
[474.066150] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[474.068574] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.007s)
[476.137992] [046/131] (546s left) kms_atomic (plane-primary-legacy)
[476.231349] Starting subtest: plane-primary-legacy
[476.234089] Starting dynamic subtest: pipe-A-eDP-1
[476.680535] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.446s)
[476.682905] Subtest plane-primary-legacy: SUCCESS (0.447s)
[477.483356] [047/131] (545s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[477.577375] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[477.579903] Starting dynamic subtest: pipe-A-default-mode
[480.342903] Dynamic subtest pipe-A-default-mode: SUCCESS (2.761s)
[480.345346] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.762s)
[481.177294] [048/131] (541s left) kms_pm_rpm (modeset-lpsp-stress)
[483.110325] Starting subtest: modeset-lpsp-stress
[499.269463] Subtest modeset-lpsp-stress: SUCCESS (16.152s)
[499.389990] [049/131] (523s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[504.412503] Starting subtest: pr-primary-plane-update-sf-dmg-area-big-fb
[504.418199] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.002s)
[505.262922] [050/131] (517s left) gem_fence_thrash (bo-write-verify-x)
[505.293980] Starting subtest: bo-write-verify-x
[505.315210] Subtest bo-write-verify-x: SKIP (0.019s)
[505.384410] [051/131] (517s left) gem_mmap_offset (close-race)
[505.441811] Starting subtest: close-race
[525.543899] Subtest close-race: SUCCESS (20.107s)
[525.677009] [052/131] (497s left) gem_exec_whisper (basic-contexts-priority-all)
[525.736444] Starting subtest: basic-contexts-priority-all
[549.919517] Subtest basic-contexts-priority-all: SUCCESS (24.177s)
[550.106466] [053/131] (473s left) gem_userptr_blits (set-cache-level)
[550.182374] Starting subtest: set-cache-level
[550.187069] Subtest set-cache-level: SKIP (0.000s)
[550.313948] [054/131] (472s left) i915_query (query-topology-unsupported)
[550.371662] Starting subtest: query-topology-unsupported
[550.377351] Subtest query-topology-unsupported: SKIP (0.000s)
[550.477997] [055/131] (472s left) i915_drm_fdinfo (busy-hang)
[550.513266] Starting subtest: busy-hang
[550.515514] Starting dynamic subtest: rcs0
[550.546976] Dynamic subtest rcs0: SKIP (0.033s)
[550.560123] Starting dynamic subtest: bcs0
[550.565027] Dynamic subtest bcs0: SKIP (0.001s)
[550.574658] Starting dynamic subtest: vcs0
[550.579142] Dynamic subtest vcs0: SKIP (0.001s)
[550.588172] Starting dynamic subtest: vcs1
[550.593199] Dynamic subtest vcs1: SKIP (0.001s)
[550.602438] Starting dynamic subtest: vecs0
[550.607366] Dynamic subtest vecs0: SKIP (0.001s)
[550.616576] Starting dynamic subtest: ccs0
[550.621435] Dynamic subtest ccs0: SKIP (0.001s)
[550.626421] Subtest busy-hang: SKIP (0.043s)
[550.667422] [056/131] (472s left) gem_exec_balancer (parallel-balancer)
[550.921302] Starting subtest: parallel-balancer
[551.793648] Subtest parallel-balancer: SUCCESS (0.871s)
[551.903677] [057/131] (471s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[552.012434] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[556.638652] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.631s)
[557.772569] [058/131] (465s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[557.879418] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[557.884333] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[557.991933] [059/131] (465s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[558.047351] Starting subtest: framebuffer-vs-set-tiling
[558.052373] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[558.192620] [060/131] (465s left) gem_exec_reloc (basic-cpu)
[558.257309] Subtest basic-cpu: SKIP (0.000s)
[558.337747] [061/131] (465s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[558.433130] Starting subtest: plane-use-after-nonblocking-unbind
[558.435559] Starting dynamic subtest: pipe-A-eDP-1
[558.499934] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.066s)
[558.799003] Starting dynamic subtest: pipe-B-eDP-1
[559.574335] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.784s)
[559.880370] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.444s)
[560.734980] [062/131] (462s left) kms_prime (d3hot)
[560.827470] Subtest D3hot: SKIP (0.000s)
[560.908976] [063/131] (462s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[561.008841] Starting subtest: fbcpsr-modesetfrombusy
[567.322926] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.317s)
[567.442188] [064/131] (456s left) i915_pm_rpm (debugfs-forcewake-user)
[569.175458] Starting subtest: debugfs-forcewake-user
[580.579084] Subtest debugfs-forcewake-user: SUCCESS (11.402s)
[580.973934] [065/131] (442s left) gem_ccs (ctrl-surf-copy)
[581.046162] Starting subtest: ctrl-surf-copy
[581.051343] Subtest ctrl-surf-copy: SKIP (0.000s)
[581.162758] [066/131] (442s left) kms_cursor_edge_walk (256x256-left-edge)
[581.256025] Starting subtest: 256x256-left-edge
[581.258332] Starting dynamic subtest: pipe-A-eDP-1
[584.747265] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.488s)
[584.757633] Starting dynamic subtest: pipe-D-eDP-1
[587.867320] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.117s)
[587.869576] Subtest 256x256-left-edge: SUCCESS (6.607s)
[588.681158] [067/131] (435s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[588.738253] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[588.817734] [068/131] (434s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[588.874668] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[588.877893] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[588.993628] [069/131] (434s left) kms_setmode (invalid-clone-exclusive-crtc)
[589.043109] Starting subtest: invalid-clone-exclusive-crtc
[589.050299] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[589.135224] [070/131] (434s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[594.148525] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[594.153410] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.004s)
[595.004200] [071/131] (428s left) kms_scaling_modes (scaling-mode-none)
[595.105671] Starting subtest: scaling-mode-none
[595.108637] Starting dynamic subtest: pipe-A-eDP-1
[595.212578] Dynamic subtest pipe-A-eDP-1: SKIP (0.103s)
[595.224909] Starting dynamic subtest: pipe-B-eDP-1
[595.248166] Dynamic subtest pipe-B-eDP-1: SKIP (0.034s)
[595.257910] Starting dynamic subtest: pipe-C-eDP-1
[595.284376] Dynamic subtest pipe-C-eDP-1: SKIP (0.034s)
[595.293897] Starting dynamic subtest: pipe-D-eDP-1
[595.316649] Dynamic subtest pipe-D-eDP-1: SKIP (0.031s)
[595.322189] Subtest scaling-mode-none: SKIP (0.209s)
[595.433570] [072/131] (428s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[595.540496] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[604.012178] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.471s)
[604.124663] [073/131] (419s left) gem_workarounds (reset-context)
[604.193526] Starting subtest: reset-context
[604.372421] Subtest reset-context: SUCCESS (0.178s)
[604.511018] [074/131] (419s left) kms_flip (absolute-wf_vblank-interruptible)
[604.618283] Starting subtest: absolute-wf_vblank-interruptible
[604.620617] Starting dynamic subtest: A-eDP1
[613.316944] Dynamic subtest A-eDP1: SUCCESS (8.696s)
[613.330280] Starting dynamic subtest: B-eDP1
[622.053138] Dynamic subtest B-eDP1: SUCCESS (8.732s)
[622.063211] Starting dynamic subtest: C-eDP1
[630.782993] Dynamic subtest C-eDP1: SUCCESS (8.726s)
[630.793983] Starting dynamic subtest: D-eDP1
[639.516425] Dynamic subtest D-eDP1: SUCCESS (8.734s)
[639.522209] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.899s)
[640.730041] [075/131] (383s left) kms_flip (flip-vs-panning-vs-hang)
[640.819418] Starting subtest: flip-vs-panning-vs-hang
[640.822273] Starting dynamic subtest: A-eDP1
[680.424090] Dynamic subtest A-eDP1: SUCCESS (39.609s)
[680.434303] Starting dynamic subtest: D-eDP1
[720.424362] Dynamic subtest D-eDP1: SUCCESS (39.998s)
[720.427245] Subtest flip-vs-panning-vs-hang: SUCCESS (79.610s)
[721.604418] [076/131] (302s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[721.656368] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[721.661301] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[721.838886] [077/131] (302s left) gem_ctx_shared (create-shared-gtt)
[721.911419] Starting subtest: create-shared-gtt
[724.066640] Subtest create-shared-gtt: SUCCESS (2.153s)
[724.429647] [078/131] (299s left) i915_query (query-garbage)
[724.480969] Starting subtest: query-garbage
[724.483210] Subtest query-garbage: SUCCESS (0.000s)
[724.583636] [079/131] (299s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[724.642126] Starting subtest: invalid-bsd2-flag-on-vebox
[724.644570] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[724.753341] [080/131] (299s left) kms_vblank (query-busy-hang)
[724.844094] Starting subtest: query-busy-hang
[724.846371] Starting dynamic subtest: pipe-A-eDP-1
[751.675245] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.823s)
[751.693163] Starting dynamic subtest: pipe-D-eDP-1
[776.694560] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.014s)
[776.697532] Subtest query-busy-hang: SUCCESS (51.842s)
[777.561853] [081/131] (246s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[777.663222] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[777.668327] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[777.781302] [082/131] (246s left) gem_reg_read (bad-register)
[777.840773] Starting subtest: bad-register
[777.843511] Subtest bad-register: SUCCESS (0.000s)
[777.950843] [083/131] (246s left) kms_cursor_crc (cursor-offscreen-32x10)
[778.113297] Starting subtest: cursor-offscreen-32x10
[778.158949] Subtest cursor-offscreen-32x10: SKIP (0.039s)
[778.449489] [084/131] (245s left) syncobj_timeline (single-wait-available-submitted)
[778.514108] Starting subtest: single-wait-available-submitted
[778.516544] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[778.607922] [085/131] (245s left) gem_ctx_persistence (engines-hostile)
[778.669896] Starting subtest: engines-hostile
[778.672355] Starting dynamic subtest: rcs0
[778.775264] Dynamic subtest rcs0: SUCCESS (0.105s)
[778.786324] Starting dynamic subtest: bcs0
[778.918955] Dynamic subtest bcs0: SUCCESS (0.141s)
[778.930928] Starting dynamic subtest: vcs0
[779.039293] Dynamic subtest vcs0: SUCCESS (0.119s)
[779.052152] Starting dynamic subtest: vcs1
[779.160617] Dynamic subtest vcs1: SUCCESS (0.119s)
[779.173219] Starting dynamic subtest: vecs0
[779.282566] Dynamic subtest vecs0: SUCCESS (0.120s)
[779.294947] Starting dynamic subtest: ccs0
[779.409658] Dynamic subtest ccs0: SUCCESS (0.125s)
[779.412309] Subtest engines-hostile: SUCCESS (0.741s)
[779.488054] [086/131] (245s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[779.540937] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[779.544890] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[779.729224] [087/131] (244s left) gem_wait (write-busy)
[779.781411] Starting subtest: write-busy
[779.783580] Starting dynamic subtest: all-engines
[780.417813] Dynamic subtest all-engines: SUCCESS (0.635s)
[780.435436] Starting dynamic subtest: rcs0
[780.973668] Dynamic subtest rcs0: SUCCESS (0.555s)
[780.989778] Starting dynamic subtest: bcs0
[781.525462] Dynamic subtest bcs0: SUCCESS (0.551s)
[781.541944] Starting dynamic subtest: vcs0
[782.975370] Dynamic subtest vcs0: SUCCESS (1.447s)
[782.993114] Starting dynamic subtest: vcs1
[784.959954] Dynamic subtest vcs1: SUCCESS (1.982s)
[784.976440] Starting dynamic subtest: vecs0
[786.942906] Dynamic subtest vecs0: SUCCESS (1.981s)
[786.959671] Starting dynamic subtest: ccs0
[787.493662] Dynamic subtest ccs0: SUCCESS (0.550s)
[787.496673] Subtest write-busy: SUCCESS (7.711s)
[787.693736] [088/131] (236s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[787.796436] Starting subtest: psr-rgb101010-draw-render
[795.032489] Subtest psr-rgb101010-draw-render: SUCCESS (7.240s)
[795.160420] [089/131] (229s left) perf (gen12-oa-tlb-invalidate)
[795.252337] Starting subtest: gen12-oa-tlb-invalidate
[795.254814] Starting dynamic subtest: 0-rcs0
[805.298464] Dynamic subtest 0-rcs0: SUCCESS (10.042s)
[805.309119] Starting dynamic subtest: 1-vcs1
[815.348676] Dynamic subtest 1-vcs1: SUCCESS (10.047s)
[815.351195] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.091s)
[815.417792] [090/131] (209s left) syncobj_wait (multi-wait-for-submit-signaled)
[815.477108] Starting subtest: multi-wait-for-submit-signaled
[815.479295] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[815.583461] [091/131] (209s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[815.676266] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[815.680666] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[815.764611] [092/131] (209s left) gem_render_tiled_blits (basic)
[815.822046] Subtest basic: SKIP (0.000s)
[815.881991] [093/131] (208s left) i915_suspend (forcewake)
[815.940575] Starting subtest: forcewake
[847.612859] Subtest forcewake: SUCCESS (2.160s)
[847.689872] [094/131] (177s left) gem_eio (suspend)
[847.898836] Starting subtest: suspend
[859.657467] Subtest suspend: SUCCESS (11.760s)
[859.821014] [095/131] (165s left) dumb_buffer (create-valid-dumb)
[859.888548] Starting subtest: create-valid-dumb
[859.891228] Subtest create-valid-dumb: SUCCESS (0.000s)
[860.000337] [096/131] (164s left) vgem_basic (busy-fence)
[860.039791] Starting subtest: busy-fence
[860.041783] Subtest busy-fence: SUCCESS (0.000s)
[860.097292] [097/131] (164s left) syncobj_timeline (invalid-wait-bad-flags)
[860.159367] Starting subtest: invalid-wait-bad-flags
[860.162020] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[860.257930] [098/131] (164s left) kms_atomic (crtc-invalid-params)
[860.345298] Starting subtest: crtc-invalid-params
[860.348095] Starting dynamic subtest: pipe-A-eDP-1
[860.702150] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.357s)
[860.704868] Subtest crtc-invalid-params: SUCCESS (0.358s)
[861.527880] [099/131] (163s left) kms_psr (fbc-psr-sprite-plane-onoff)
[861.618299] Starting subtest: fbc-psr-sprite-plane-onoff
[861.621159] Starting dynamic subtest: eDP-1
[861.626170] Dynamic subtest eDP-1: SKIP (0.000s)
[861.631088] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[861.691835] [100/131] (163s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[862.219549] Starting subtest: syncobj-timeline-invalid-wait
[862.226019] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.007s)
[863.545673] [101/131] (161s left) gem_userptr_blits (map-fixed-invalidate-busy)
[863.620204] Starting subtest: map-fixed-invalidate-busy
[863.624692] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[863.767791] [102/131] (161s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[864.142784] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[864.934118] [103/131] (160s left) kms_ccs (random-ccs-data-4-tiled-lnl-ccs)
[865.035413] Starting subtest: random-ccs-data-4-tiled-lnl-ccs
[865.040970] Subtest random-ccs-data-4-tiled-lnl-ccs: SKIP (0.000s)
[866.183879] [104/131] (159s left) kms_color (ctm-green-to-red)
[866.284336] Starting subtest: ctm-green-to-red
[866.287177] Starting dynamic subtest: pipe-A-eDP-1
[866.956652] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.673s)
[866.967782] Starting dynamic subtest: pipe-B-eDP-1
[868.340300] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.381s)
[868.352001] Starting dynamic subtest: pipe-C-eDP-1
[869.647029] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.311s)
[869.657902] Starting dynamic subtest: pipe-D-eDP-1
[871.002511] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.356s)
[871.005467] Subtest ctm-green-to-red: SUCCESS (4.724s)
[871.816985] [105/131] (153s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[871.913562] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[871.918546] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[872.005923] [106/131] (153s left) gem_userptr_blits (invalid-null-pointer)
[872.067131] Starting subtest: invalid-null-pointer
[872.069197] Subtest invalid-null-pointer: SUCCESS (0.001s)
[872.204001] [107/131] (153s left) kms_chamelium_color (ctm-negative)
[872.305557] Subtest ctm-negative: SKIP (0.000s)
[872.353807] [108/131] (153s left) kms_hdr (brightness-with-hdr)
[872.444074] Starting subtest: brightness-with-hdr
[872.451398] Subtest brightness-with-hdr: SKIP (0.000s)
[872.518562] [109/131] (152s left) gem_mmap_gtt (fault-concurrent-y)
[872.574875] Subtest fault-concurrent-Y: SKIP (0.000s)
[872.646808] [110/131] (152s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[872.743262] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[872.748051] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[872.854771] [111/131] (152s left) kms_lease (setcrtc-implicit-plane)
[872.947791] Starting subtest: setcrtc-implicit-plane
[872.949677] Starting dynamic subtest: pipe-A-eDP-1
[873.410020] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.463s)
[873.420441] Starting dynamic subtest: pipe-B-eDP-1
[874.534445] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.124s)
[874.547254] Starting dynamic subtest: pipe-C-eDP-1
[875.659449] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.126s)
[875.670465] Starting dynamic subtest: pipe-D-eDP-1
[876.791307] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.131s)
[876.793838] Subtest setcrtc-implicit-plane: SUCCESS (3.849s)
[877.642658] [112/131] (148s left) perf (blocking)
[877.725537] Starting subtest: blocking
[877.728352] Starting dynamic subtest: 0-rcs0
[887.745457] Dynamic subtest 0-rcs0: SUCCESS (10.022s)
[887.757672] Starting dynamic subtest: 1-vcs1
[897.773795] Dynamic subtest 1-vcs1: SUCCESS (10.021s)
[897.776563] Subtest blocking: SUCCESS (20.045s)
[897.825024] [113/131] (127s left) kms_psr (psr-cursor-render)
[897.930378] Starting subtest: psr-cursor-render
[897.933288] Starting dynamic subtest: eDP-1
[899.636111] Dynamic subtest eDP-1: SUCCESS (1.703s)
[899.639118] Subtest psr-cursor-render: SUCCESS (1.704s)
[900.505320] [114/131] (125s left) gem_exec_fence (basic-wait)
[900.683543] Starting subtest: basic-wait
[900.686537] Starting dynamic subtest: rcs0
[900.781021] Dynamic subtest rcs0: SUCCESS (0.097s)
[900.792476] Starting dynamic subtest: bcs0
[900.844520] Dynamic subtest bcs0: SUCCESS (0.062s)
[900.857320] Starting dynamic subtest: vcs0
[900.910554] Dynamic subtest vcs0: SUCCESS (0.064s)
[900.923118] Starting dynamic subtest: vcs1
[900.978146] Dynamic subtest vcs1: SUCCESS (0.066s)
[900.991332] Starting dynamic subtest: vecs0
[901.044703] Dynamic subtest vecs0: SUCCESS (0.064s)
[901.056584] Starting dynamic subtest: ccs0
[901.109448] Dynamic subtest ccs0: SUCCESS (0.063s)
[901.112287] Subtest basic-wait: SUCCESS (0.427s)
[902.532240] [115/131] (123s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[902.633200] Starting subtest: yf-tiled-64bpp-rotate-270
[902.638267] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[902.716794] [116/131] (123s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[902.835146] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[904.280359] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.442s)
[905.083075] [117/131] (120s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[905.198543] Starting subtest: cursor-vs-flip-varying-size
[935.596727] Subtest cursor-vs-flip-varying-size: SUCCESS (30.390s)
[936.422562] [118/131] ( 89s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[936.528013] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[937.471956] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.946s)
[937.586770] [119/131] ( 88s left) gem_exec_await (wide-contexts)
[937.767086] Starting subtest: wide-contexts
[961.393290] Subtest wide-contexts: SUCCESS (23.626s)
[961.601871] [120/131] ( 64s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[961.756436] Starting subtest: fbc-rgb101010-draw-mmap-wc
[966.317204] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.567s)
[967.428572] [121/131] ( 58s left) gem_exec_nop (basic-parallel)
[967.508789] Starting subtest: basic-parallel
[983.492592] Subtest basic-parallel: SUCCESS (15.998s)
[983.743410] [122/131] ( 42s left) gem_ctx_isolation (nonpriv-switch)
[983.811564] Starting subtest: nonpriv-switch
[983.814565] Starting dynamic subtest: rcs0
[984.186073] Dynamic subtest rcs0: SUCCESS (0.374s)
[984.198053] Starting dynamic subtest: bcs0
[984.615252] Dynamic subtest bcs0: SUCCESS (0.428s)
[984.628161] Starting dynamic subtest: vcs0
[984.967878] Dynamic subtest vcs0: SUCCESS (0.352s)
[984.979295] Starting dynamic subtest: vcs1
[986.758624] Dynamic subtest vcs1: SUCCESS (1.791s)
[986.771365] Starting dynamic subtest: vecs0
[988.803484] Dynamic subtest vecs0: SUCCESS (2.044s)
[988.817177] Starting dynamic subtest: ccs0
[990.829301] Dynamic subtest ccs0: SUCCESS (2.026s)
[990.832155] Subtest nonpriv-switch: SUCCESS (7.019s)
[991.109556] [123/131] ( 35s left) kms_busy (extended-pageflip-hang-oldfb)
[991.224212] Starting subtest: extended-pageflip-hang-oldfb
[991.226563] Starting dynamic subtest: pipe-A
[991.657147] Dynamic subtest pipe-A: SUCCESS (0.431s)
[991.669589] Starting dynamic subtest: pipe-D
[992.821198] Dynamic subtest pipe-D: SUCCESS (1.161s)
[992.823551] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.598s)
[993.674653] [124/131] ( 32s left) kms_cursor_crc (cursor-random-64x21)
[993.870962] Starting subtest: cursor-random-64x21
[993.914920] Subtest cursor-random-64x21: SKIP (0.040s)
[994.154054] [125/131] ( 32s left) i915_pm_rps (reset)
[994.209260] Starting subtest: reset
[994.305565] Subtest reset: FAIL (0.027s)
[994.386006] [126/131] ( 31s left) kms_psr (pr-sprite-render)
[994.484092] Starting subtest: pr-sprite-render
[994.488350] Subtest pr-sprite-render: SKIP (0.000s)
[994.554364] [127/131] ( 31s left) gem_softpin (evict-active-interruptible)
[994.609125] Starting subtest: evict-active-interruptible
[994.615523] Subtest evict-active-interruptible: SUCCESS (0.006s)
[994.727910] [128/131] ( 31s left) kms_writeback (writeback-check-output)
[994.823035] Subtest writeback-check-output: SKIP (0.000s)
[994.874277] [129/131] ( 31s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[994.969529] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[1002.570092] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.604s)
[1002.717487] [130/131] ( 23s left) gem_render_copy_redux (flink-interruptible)
[1002.778201] Starting subtest: flink-interruptible
[1003.564150] Subtest flink-interruptible: SUCCESS (0.786s)
[1003.705089] [131/131] ( 22s left) kms_cursor_crc (cursor-sliding-64x64)
[1003.879949] Starting subtest: cursor-sliding-64x64
[1003.884185] Starting dynamic subtest: pipe-A-eDP-1
[1007.115460] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.231s)
[1007.143085] Starting dynamic subtest: pipe-D-eDP-1
[1010.969774] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.836s)
[1010.972203] Subtest cursor-sliding-64x64: SUCCESS (7.090s)
[1011.849324] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_schedule
results: parsing output: 1/ for test: gem_exec_params
results: parsing output: 2/ for test: prime_vgem
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: core_sysfs
results: parsing output: 5/ for test: perf
results: parsing output: 6/ for test: api_intel_allocator
results: parsing output: 7/ for test: gem_exec_balancer
results: parsing output: 8/ for test: kms_psr
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: syncobj_timeline
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_big_fb
results: parsing output: 14/ for test: gem_exec_schedule
results: parsing output: 15/ for test: kms_plane_multiple
results: parsing output: 16/ for test: perf_pmu
results: parsing output: 17/ for test: kms_plane_scaling
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: gem_lmem_swapping
results: parsing output: 21/ for test: kms_flip
results: parsing output: 22/ for test: kms_flip
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: gem_softpin
results: parsing output: 25/ for test: i915_hangman
results: parsing output: 26/ for test: gem_exec_reloc
results: parsing output: 27/ for test: gem_exec_schedule
results: parsing output: 28/ for test: kms_ccs
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: kms_flip_scaled_crc
results: parsing output: 31/ for test: kms_plane_alpha_blend
results: parsing output: 32/ for test: kms_draw_crc
results: parsing output: 33/ for test: kms_ccs
results: parsing output: 34/ for test: prime_vgem
results: parsing output: 35/ for test: kms_pm_backlight
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: sw_sync
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: gem_pxp
results: parsing output: 40/ for test: syncobj_timeline
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: syncobj_wait
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_ccs
results: parsing output: 45/ for test: kms_atomic
results: parsing output: 46/ for test: kms_flip_scaled_crc
results: parsing output: 47/ for test: kms_pm_rpm
results: parsing output: 48/ for test: kms_psr2_sf
results: parsing output: 49/ for test: gem_fence_thrash
results: parsing output: 50/ for test: gem_mmap_offset
results: parsing output: 51/ for test: gem_exec_whisper
results: parsing output: 52/ for test: gem_userptr_blits
results: parsing output: 53/ for test: i915_query
results: parsing output: 54/ for test: i915_drm_fdinfo
results: parsing output: 55/ for test: gem_exec_balancer
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_addfb_basic
results: parsing output: 59/ for test: gem_exec_reloc
results: parsing output: 60/ for test: kms_atomic_transition
results: parsing output: 61/ for test: kms_prime
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: i915_pm_rpm
results: parsing output: 64/ for test: gem_ccs
results: parsing output: 65/ for test: kms_cursor_edge_walk
results: parsing output: 66/ for test: kms_pipe_b_c_ivb
results: parsing output: 67/ for test: syncobj_wait
results: parsing output: 68/ for test: kms_setmode
results: parsing output: 69/ for test: kms_psr2_sf
results: parsing output: 70/ for test: kms_scaling_modes
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: gem_workarounds
results: parsing output: 73/ for test: kms_flip
results: parsing output: 74/ for test: kms_flip
results: parsing output: 75/ for test: gem_render_copy
results: parsing output: 76/ for test: gem_ctx_shared
results: parsing output: 77/ for test: i915_query
results: parsing output: 78/ for test: gem_exec_params
results: parsing output: 79/ for test: kms_vblank
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gem_reg_read
results: parsing output: 82/ for test: kms_cursor_crc
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: gem_ctx_persistence
results: parsing output: 85/ for test: gem_render_copy
results: parsing output: 86/ for test: gem_wait
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: perf
results: parsing output: 89/ for test: syncobj_wait
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: gem_render_tiled_blits
results: parsing output: 92/ for test: i915_suspend
results: parsing output: 93/ for test: gem_eio
results: parsing output: 94/ for test: dumb_buffer
results: parsing output: 95/ for test: vgem_basic
results: parsing output: 96/ for test: syncobj_timeline
results: parsing output: 97/ for test: kms_atomic
results: parsing output: 98/ for test: kms_psr
results: parsing output: 99/ for test: gem_exec_fence
results: parsing output: 100/ for test: gem_userptr_blits
results: parsing output: 101/ for test: kms_chamelium_hpd
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: kms_color
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: gem_userptr_blits
results: parsing output: 106/ for test: kms_chamelium_color
results: parsing output: 107/ for test: kms_hdr
results: parsing output: 108/ for test: gem_mmap_gtt
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_lease
results: parsing output: 111/ for test: perf
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: gem_exec_fence
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: kms_cursor_legacy
results: parsing output: 116/ for test: kms_cursor_legacy
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: gem_exec_await
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: gem_exec_nop
results: parsing output: 121/ for test: gem_ctx_isolation
results: parsing output: 122/ for test: kms_busy
results: parsing output: 123/ for test: kms_cursor_crc
results: parsing output: 124/ for test: i915_pm_rps
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: gem_softpin
results: parsing output: 127/ for test: kms_writeback
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: gem_render_copy_redux
results: parsing output: 130/ for test: kms_cursor_crc
Done.