[60.185536] Initializing watchdogs
[60.185596]   /dev/watchdog0
[60.191226] [001/131] (960s left) kms_getfb (getfb-handle-protection)
[60.226523] Starting subtest: getfb-handle-protection
[60.252253] Subtest getfb-handle-protection: SUCCESS (0.026s)
[60.371470] [002/131] (960s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[60.483900] Starting subtest: plane-scaler-unity-scaling-with-rotation
[60.484764] Starting dynamic subtest: pipe-A
[60.959561] Dynamic subtest pipe-A: SKIP (0.478s)
[60.965097] Starting dynamic subtest: pipe-B
[61.443433] Dynamic subtest pipe-B: SKIP (0.488s)
[61.444782] Subtest plane-scaler-unity-scaling-with-rotation: SKIP (0.966s)
[61.619080] [003/131] (959s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[61.729342] Starting subtest: cursor-rapid-movement-512x170
[61.730690] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[61.831224] [004/131] (958s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k)
[61.984177] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s)
[62.044438] [005/131] (958s left) kms_color (ctm-green-to-red)
[62.162786] Starting subtest: ctm-green-to-red
[62.163448] Starting dynamic subtest: pipe-A-HDMI-A-1
[62.705317] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.546s)
[62.711342] Starting dynamic subtest: pipe-B-HDMI-A-1
[63.143129] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.441s)
[63.143811] Subtest ctm-green-to-red: SUCCESS (0.987s)
[63.321222] [006/131] (957s left) kms_properties (crtc-properties-legacy)
[63.436799] Starting subtest: crtc-properties-legacy
[63.437481] Starting dynamic subtest: pipe-A-HDMI-A-1
[63.700050] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.264s)
[63.707943] Starting dynamic subtest: pipe-B-HDMI-A-1
[63.952868] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.253s)
[63.953597] Subtest crtc-properties-legacy: SUCCESS (0.519s)
[64.102887] [007/131] (956s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[64.215872] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs
[64.216566] Starting dynamic subtest: pipe-A-HDMI-A-1
[64.222596] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[64.226630] Starting dynamic subtest: pipe-B-HDMI-A-1
[64.232484] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[64.233153] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SUCCESS (0.003s)
[64.473733] [008/131] (956s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[64.588359] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[64.589672] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[64.701017] [009/131] (956s left) gem_mmap_gtt (cpuset-basic-small-copy)
[64.739944] Starting subtest: cpuset-basic-small-copy
[68.604584] Subtest cpuset-basic-small-copy: SUCCESS (3.881s)
[68.728185] [010/131] (952s left) kms_big_fb (linear-64bpp-rotate-270)
[68.889218] Starting subtest: linear-64bpp-rotate-270
[68.958067] Subtest linear-64bpp-rotate-270: SKIP (0.068s)
[69.103527] [011/131] (951s left) kms_psr2_su (page_flip-xrgb8888)
[69.150561] Subtest page_flip-XRGB8888: SKIP (0.000s)
[69.193622] [012/131] (951s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[69.303861] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[69.305230] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[69.475842] [013/131] (951s left) syncobj_timeline (invalid-query-illegal-handle)
[69.519563] Starting subtest: invalid-query-illegal-handle
[69.520270] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[69.606626] [014/131] (951s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[69.721415] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[72.320098] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (2.605s)
[72.522968] [015/131] (948s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[72.561916] Subtest enable-vfs-bind-unbind-each-numvfs-all: SKIP (0.000s)
[72.601876] [016/131] (948s left) kms_psr (psr-basic)
[72.715582] Subtest psr-basic: SKIP (0.000s)
[72.754265] [017/131] (948s left) kms_addfb_basic (bad-pitch-63)
[72.796487] Starting subtest: bad-pitch-63
[72.797295] Subtest bad-pitch-63: SUCCESS (0.000s)
[72.997144] [018/131] (948s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[73.119747] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[73.121053] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[73.243050] [019/131] (947s left) kms_vrr (flip-dpms)
[73.354812] Starting subtest: flip-dpms
[73.356803] Subtest flip-dpms: SKIP (0.000s)
[73.423916] [020/131] (947s left) syncobj_timeline (multi-wait-for-submit-signaled)
[73.467288] Starting subtest: multi-wait-for-submit-signaled
[73.468755] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[73.550866] [021/131] (947s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[73.670858] Starting subtest: primary-yf-tiled-reflect-x-270
[73.779513] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.107s)
[73.871032] [022/131] (947s left) perf_pmu (busy-check-all)
[73.913393] Starting subtest: busy-check-all
[73.914093] Starting dynamic subtest: rcs0
[74.431868] Dynamic subtest rcs0: SUCCESS (0.519s)
[74.439464] Starting dynamic subtest: bcs0
[74.955371] Dynamic subtest bcs0: SUCCESS (0.523s)
[74.963642] Starting dynamic subtest: vcs0
[75.478896] Dynamic subtest vcs0: SUCCESS (0.524s)
[75.487145] Starting dynamic subtest: vecs0
[76.012279] Dynamic subtest vecs0: SUCCESS (0.533s)
[76.013480] Subtest busy-check-all: SUCCESS (2.102s)
[76.097789] [023/131] (945s left) gem_mmap_gtt (basic-small-bo-tiledy)
[76.137537] Starting subtest: basic-small-bo-tiledY
[76.203357] Subtest basic-small-bo-tiledY: SUCCESS (0.066s)
[76.331563] [024/131] (944s left) i915_pm_rps (engine-order)
[76.413174] Starting subtest: engine-order
[79.251518] Subtest engine-order: SUCCESS (2.840s)
[79.745824] [025/131] (941s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[79.877544] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[79.878885] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[79.988143] [026/131] (941s left) kms_plane_cursor (overlay)
[80.178837] Starting subtest: overlay
[80.180192] Starting dynamic subtest: pipe-A-HDMI-A-1-size-64
[83.086477] Dynamic subtest pipe-A-HDMI-A-1-size-64: SUCCESS (2.908s)
[83.179586] Starting dynamic subtest: pipe-A-HDMI-A-1-size-128
[86.045401] Dynamic subtest pipe-A-HDMI-A-1-size-128: SUCCESS (2.883s)
[86.138131] Starting dynamic subtest: pipe-A-HDMI-A-1-size-256
[89.023417] Dynamic subtest pipe-A-HDMI-A-1-size-256: SUCCESS (2.903s)
[89.134820] Starting dynamic subtest: pipe-B-HDMI-A-1-size-64
[92.047545] Dynamic subtest pipe-B-HDMI-A-1-size-64: SUCCESS (2.919s)
[92.113089] Starting dynamic subtest: pipe-B-HDMI-A-1-size-128
[94.969467] Dynamic subtest pipe-B-HDMI-A-1-size-128: SUCCESS (2.865s)
[95.035015] Starting dynamic subtest: pipe-B-HDMI-A-1-size-256
[97.910287] Dynamic subtest pipe-B-HDMI-A-1-size-256: SUCCESS (2.883s)
[97.993705] Subtest overlay: SUCCESS (17.818s)
[98.112383] [027/131] (923s left) i915_pm_freq_api (freq-reset)
[98.157698] Subtest freq-reset: SKIP (0.000s)
[98.197267] [028/131] (923s left) fbdev (read)
[98.251309] Starting subtest: read
[98.842823] Subtest read: SUCCESS (0.575s)
[98.908455] [029/131] (922s left) kms_pm_rpm (modeset-lpsp)
[100.385139] Starting subtest: modeset-lpsp
[100.668870] Subtest modeset-lpsp: SUCCESS (0.283s)
[100.849943] [030/131] (920s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[100.965435] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[101.007149] [031/131] (920s left) kms_psr (pr-basic)
[101.114550] Subtest pr-basic: SKIP (0.000s)
[101.160508] [032/131] (920s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[101.286209] Starting subtest: yf-tiled-addfb-size-offset-overflow
[101.287520] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[101.393919] [033/131] (920s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[101.514894] Starting subtest: fbcpsr-rgb565-draw-render
[101.516341] Subtest fbcpsr-rgb565-draw-render: SKIP (0.000s)
[101.631234] [034/131] (919s left) gem_exec_create (forked)
[101.676710] Starting subtest: forked
[101.677469] Starting dynamic subtest: smem
[121.813040] Dynamic subtest smem: SUCCESS (20.136s)
[121.813861] Subtest forked: SUCCESS (20.137s)
[122.006615] [035/131] (899s left) i915_suspend (fence-restore-tiled2untiled)
[122.048145] Starting subtest: fence-restore-tiled2untiled
[142.927560] Subtest fence-restore-tiled2untiled: SUCCESS (20.880s)
[144.026883] [036/131] (878s left) kms_addfb_basic (unused-offsets)
[144.073110] Starting subtest: unused-offsets
[144.073809] Subtest unused-offsets: SUCCESS (0.000s)
[144.299353] [037/131] (878s left) prime_mmap_coherency (write)
[144.347047] Starting subtest: write
[149.724066] Subtest write: SUCCESS (5.377s)
[149.861586] [038/131] (872s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[149.973841] Starting subtest: x-tiled-addfb-size-offset-overflow
[149.974515] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[150.093683] [039/131] (872s left) gem_huc_copy (huc-copy)
[150.134528] Starting subtest: huc-copy
[150.135853] Subtest huc-copy: SKIP (0.000s)
[150.264566] [040/131] (872s left) perf (oa-formats)
[150.395693] Starting subtest: oa-formats
[150.396354] Starting dynamic subtest: 0-rcs0
[150.409819] Dynamic subtest 0-rcs0: SUCCESS (0.014s)
[150.410499] Subtest oa-formats: SUCCESS (0.014s)
[150.428304] [041/131] (872s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[150.540437] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[153.433263] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (2.893s)
[153.620709] [042/131] (869s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[153.733775] Starting subtest: 4-tiled-32bpp-rotate-180
[153.735102] Subtest 4-tiled-32bpp-rotate-180: SKIP (0.000s)
[153.869069] [043/131] (868s left) gem_exec_reloc (basic-cpu-gtt-active)
[153.908725] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[154.010442] [044/131] (868s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[154.487063] Starting subtest: syncobj-timeline-multiple-ext-nodes
[154.489384] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.003s)
[154.684778] [045/131] (868s left) gem_mmap_offset (bad-extensions)
[154.719040] Starting subtest: bad-extensions
[154.719730] Subtest bad-extensions: SUCCESS (0.000s)
[154.838500] [046/131] (867s left) gem_pxp (reject-modify-context-protection-off-3)
[275.239933] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[277.625241] Closing watchdogs
[277.627723] Initializing watchdogs
[277.627762]   /dev/watchdog0
[277.635436] [047/131] (745s left) kms_concurrent (multi-plane-atomic-lowres)
[277.740539] Starting subtest: multi-plane-atomic-lowres
[277.741229] Starting dynamic subtest: pipe-A-HDMI-A-1
[278.120480] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.379s)
[278.121178] Subtest multi-plane-atomic-lowres: SUCCESS (0.380s)
[278.245209] [048/131] (744s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[278.355954] Starting subtest: bad-pixel-format-y-tiled-ccs
[278.356657] Starting dynamic subtest: pipe-A-HDMI-A-1
[278.363151] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[278.369629] Starting dynamic subtest: pipe-B-HDMI-A-1
[278.376181] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[278.377471] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.002s)
[278.614455] [049/131] (744s left) gem_softpin (allocator-basic)
[278.655629] Starting subtest: allocator-basic
[278.716294] Subtest allocator-basic: SUCCESS (0.061s)
[278.863333] [050/131] (744s left) prime_mmap (test_forked)
[278.902128] Starting subtest: test_forked
[278.902795] Starting dynamic subtest: test_forked-smem
[278.960485] Dynamic subtest test_forked-smem: SUCCESS (0.059s)
[278.961169] Subtest test_forked: SUCCESS (0.059s)
[279.070302] [051/131] (743s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[279.180064] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[279.180751] Starting dynamic subtest: pipe-A-valid-mode
[279.241144] Dynamic subtest pipe-A-valid-mode: SKIP (0.058s)
[279.242721] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SKIP (0.059s)
[279.361481] [052/131] (743s left) gem_exec_balancer (full-late-pulse)
[279.406947] Starting subtest: full-late-pulse
[280.900469] Subtest full-late-pulse: SUCCESS (1.493s)
[281.087094] [053/131] (741s left) gem_eio (wait-immediate)
[281.134364] Starting subtest: wait-immediate
[281.282623] Subtest wait-immediate: SUCCESS (0.147s)
[281.447677] [054/131] (741s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[281.564537] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[281.565854] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[281.696664] [055/131] (741s left) gem_exec_schedule (preempt-queue-contexts)
[281.746187] Starting subtest: preempt-queue-contexts
[281.746902] Starting dynamic subtest: rcs0
[281.927204] Dynamic subtest rcs0: SUCCESS (0.181s)
[281.934215] Starting dynamic subtest: bcs0
[282.104125] Dynamic subtest bcs0: SUCCESS (0.176s)
[282.111360] Starting dynamic subtest: vcs0
[282.284398] Dynamic subtest vcs0: SUCCESS (0.180s)
[282.291751] Starting dynamic subtest: vecs0
[282.465471] Dynamic subtest vecs0: SUCCESS (0.180s)
[282.466202] Subtest preempt-queue-contexts: SUCCESS (0.719s)
[282.786287] [056/131] (740s left) gem_eio (wait-wedge-1us)
[282.830617] Starting subtest: wait-wedge-1us
[283.080315] Subtest wait-wedge-1us: SUCCESS (0.249s)
[283.231435] [057/131] (739s left) api_intel_bb (add-remove-objects)
[283.271419] Starting subtest: add-remove-objects
[283.275066] Subtest add-remove-objects: SUCCESS (0.004s)
[283.422066] [058/131] (739s left) prime_vgem (busy)
[283.501891] Starting subtest: busy
[283.502658] Starting dynamic subtest: rcs0
[283.564792] Dynamic subtest rcs0: SUCCESS (0.063s)
[283.573034] Starting dynamic subtest: bcs0
[283.581582] Dynamic subtest bcs0: SUCCESS (0.016s)
[283.590023] Starting dynamic subtest: vcs0
[283.607340] Dynamic subtest vcs0: SUCCESS (0.025s)
[283.621632] Starting dynamic subtest: vecs0
[283.623580] Dynamic subtest vecs0: SUCCESS (0.015s)
[283.624254] Subtest busy: SUCCESS (0.122s)
[283.764852] [059/131] (739s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[283.874756] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[286.762945] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (2.889s)
[286.973354] [060/131] (736s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[287.079015] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[287.079766] Starting dynamic subtest: pipe-A-HDMI-A-1
[287.086770] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[287.096504] Starting dynamic subtest: pipe-B-HDMI-A-1
[287.103539] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[287.104971] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[287.338535] [061/131] (735s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[287.450091] Starting subtest: fbcpsr-1p-rte
[287.451382] Subtest fbcpsr-1p-rte: SKIP (0.000s)
[287.543603] [062/131] (735s left) gem_create (hog-create)
[287.581160] Starting subtest: hog-create
[287.581927] Starting dynamic subtest: smem0
[319.883773] Dynamic subtest smem0: SUCCESS (32.299s)
[319.885363] Subtest hog-create: SUCCESS (32.301s)
[320.080702] [063/131] (703s left) dumb_buffer (map-valid)
[320.117057] Starting subtest: map-valid
[320.117817] Subtest map-valid: SUCCESS (0.000s)
[320.221399] [064/131] (703s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[320.332659] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[320.333964] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[320.477474] [065/131] (702s left) gem_ctx_shared (exec-single-timeline)
[320.522894] Starting subtest: exec-single-timeline
[320.523674] Starting dynamic subtest: rcs0
[321.565115] Dynamic subtest rcs0: SUCCESS (1.041s)
[321.576904] Starting dynamic subtest: bcs0
[322.588992] Dynamic subtest bcs0: SUCCESS (1.021s)
[322.600965] Starting dynamic subtest: vcs0
[323.613077] Dynamic subtest vcs0: SUCCESS (1.021s)
[323.625038] Starting dynamic subtest: vecs0
[324.637144] Dynamic subtest vecs0: SUCCESS (1.021s)
[324.638707] Subtest exec-single-timeline: SUCCESS (4.114s)
[324.824103] [066/131] (698s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[324.862901] Starting subtest: multi-wait-all-for-submit-signaled
[324.863622] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[324.929972] [067/131] (698s left) api_intel_bb (render)
[324.965328] Starting subtest: render
[324.966049] Starting dynamic subtest: render-none-512
[325.041754] Dynamic subtest render-none-512: SUCCESS (0.076s)
[325.048871] Starting dynamic subtest: render-none-1024
[325.356450] Dynamic subtest render-none-1024: SUCCESS (0.314s)
[325.363539] Starting dynamic subtest: render-x-512
[325.424211] Dynamic subtest render-x-512: SUCCESS (0.068s)
[325.431202] Starting dynamic subtest: render-x-1024
[325.711262] Dynamic subtest render-x-1024: SUCCESS (0.286s)
[325.718286] Starting dynamic subtest: render-y-512
[325.779315] Dynamic subtest render-y-512: SUCCESS (0.068s)
[325.786312] Starting dynamic subtest: render-y-1024
[326.067198] Dynamic subtest render-y-1024: SUCCESS (0.287s)
[326.067893] Subtest render: SUCCESS (1.102s)
[326.169767] [068/131] (697s left) sysfs_timeslice_duration (timeout)
[326.212834] Starting subtest: timeout
[326.213515] Starting dynamic subtest: vecs0
[327.229967] Dynamic subtest vecs0: SUCCESS (1.014s)
[327.237704] Starting dynamic subtest: vcs0
[328.332965] Dynamic subtest vcs0: SUCCESS (1.101s)
[328.340900] Starting dynamic subtest: bcs0
[329.360513] Dynamic subtest bcs0: SUCCESS (1.028s)
[329.368675] Starting dynamic subtest: rcs0
[330.333802] Dynamic subtest rcs0: SUCCESS (0.970s)
[330.335067] Subtest timeout: SUCCESS (4.119s)
[330.409188] [069/131] (692s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[330.519567] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[330.520931] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[330.639351] [070/131] (692s left) kms_atomic (crtc-invalid-params-fence)
[330.746964] Starting subtest: crtc-invalid-params-fence
[330.748601] Starting dynamic subtest: pipe-A-HDMI-A-1
[330.946656] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.198s)
[330.947573] Subtest crtc-invalid-params-fence: SUCCESS (0.200s)
[331.128879] [071/131] (692s left) kms_chamelium_frames (hdmi-crc-fast)
[331.298283] Subtest hdmi-crc-fast: SKIP (0.000s)
[331.388579] [072/131] (692s left) gem_eio (execbuf)
[331.436724] Starting subtest: execbuf
[331.478216] Subtest execbuf: SUCCESS (0.041s)
[331.653865] [073/131] (691s left) kms_flip (absolute-wf_vblank)
[331.767970] Starting subtest: absolute-wf_vblank
[331.768740] Starting dynamic subtest: A-HDMI-A1
[347.166796] Dynamic subtest A-HDMI-A1: SUCCESS (15.397s)
[347.177888] Starting dynamic subtest: B-HDMI-A1
[362.515266] Dynamic subtest B-HDMI-A1: SUCCESS (15.343s)
[362.518192] Subtest absolute-wf_vblank: SUCCESS (30.749s)
[362.680250] [074/131] (660s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[362.793102] Starting subtest: fbcpsr-tiling-4
[362.794498] Subtest fbcpsr-tiling-4: SKIP (0.000s)
[362.906533] [075/131] (660s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[363.021759] Starting subtest: y-tiled-8bpp-rotate-270
[363.104738] Subtest y-tiled-8bpp-rotate-270: SKIP (0.082s)
[363.269964] [076/131] (660s left) perf (gen8-unprivileged-single-ctx-counters)
[363.380266] Starting subtest: gen8-unprivileged-single-ctx-counters
[363.381655] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[363.395595] [077/131] (660s left) gem_exec_store (pages)
[363.440337] Starting subtest: pages
[363.441044] Starting dynamic subtest: rcs0
[363.562064] Dynamic subtest rcs0: SUCCESS (0.121s)
[363.576178] Starting dynamic subtest: bcs0
[363.623740] Dynamic subtest bcs0: SUCCESS (0.060s)
[363.636397] Starting dynamic subtest: vcs0
[363.687504] Dynamic subtest vcs0: SUCCESS (0.063s)
[363.706358] Starting dynamic subtest: vecs0
[363.739995] Dynamic subtest vecs0: SUCCESS (0.051s)
[363.740853] Subtest pages: SUCCESS (0.300s)
[363.954294] [078/131] (659s left) kms_big_fb (4-tiled-addfb)
[364.067837] Starting subtest: 4-tiled-addfb
[364.069179] Subtest 4-tiled-addfb: SKIP (0.000s)
[364.181581] [079/131] (659s left) kms_flip (flip-vs-panning)
[364.291415] Starting subtest: flip-vs-panning
[364.293102] Starting dynamic subtest: A-HDMI-A1
[379.534802] Dynamic subtest A-HDMI-A1: SUCCESS (15.241s)
[379.555759] Starting dynamic subtest: B-HDMI-A1
[394.727916] Dynamic subtest B-HDMI-A1: SUCCESS (15.189s)
[394.731766] Subtest flip-vs-panning: SUCCESS (30.438s)
[394.891458] [080/131] (628s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[395.005681] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[395.006988] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[395.140875] [081/131] (628s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[395.249049] Starting subtest: sprite-rotation-90-pos-100-0
[402.516355] Subtest sprite-rotation-90-pos-100-0: SUCCESS (7.266s)
[402.727869] [082/131] (620s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[402.845762] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[402.861096] [083/131] (620s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[402.975790] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[402.977103] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[403.102866] [084/131] (620s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[403.216935] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[403.225679] Subtest fbcpsr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[403.314653] [085/131] (620s left) kms_flip (nonblocking-read)
[403.421458] Starting subtest: nonblocking-read
[403.422155] Subtest nonblocking-read: SUCCESS (0.000s)
[403.559813] [086/131] (620s left) syncobj_basic (bad-handle-to-fd)
[403.596157] Starting subtest: bad-handle-to-fd
[403.596853] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[403.686429] [087/131] (620s left) kms_cursor_crc (cursor-onscreen-256x85)
[403.798723] Starting subtest: cursor-onscreen-256x85
[403.801844] Starting dynamic subtest: pipe-A-HDMI-A-1
[406.339455] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.537s)
[406.369516] Starting dynamic subtest: pipe-B-HDMI-A-1
[408.774909] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.411s)
[408.775597] Subtest cursor-onscreen-256x85: SUCCESS (4.976s)
[408.962872] [088/131] (614s left) gem_exec_schedule (u-semaphore-resolve)
[409.009904] Starting subtest: u-semaphore-resolve
[409.021653] Subtest u-semaphore-resolve: SUCCESS (0.012s)
[409.351240] [089/131] (614s left) kms_joiner (invalid-modeset-big-joiner)
[409.463365] Starting subtest: invalid-modeset-big-joiner
[409.464734] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[409.547731] [090/131] (614s left) kms_pm_dc (dc3co-vpb-simulation)
[410.666669] Starting subtest: dc3co-vpb-simulation
[410.667999] Subtest dc3co-vpb-simulation: SKIP (0.000s)
[410.754572] [091/131] (613s left) gem_exec_flush (basic-wb-rw-default)
[410.799496] Starting subtest: basic-wb-rw-default
[416.255716] Subtest basic-wb-rw-default: SUCCESS (5.456s)
[416.491120] [092/131] (607s left) gem_userptr_blits (set-cache-level)
[416.545289] Starting subtest: set-cache-level
[416.545964] Subtest set-cache-level: SUCCESS (0.000s)
[416.707241] [093/131] (607s left) kms_hdmi_inject (inject-4k)
[416.785707] Starting subtest: inject-4k
[417.021062] Subtest inject-4k: SUCCESS (0.234s)
[417.158262] [094/131] (606s left) kms_dirtyfb (default-dirtyfb-ioctl)
[417.266299] Starting subtest: default-dirtyfb-ioctl
[417.268189] Starting dynamic subtest: A-HDMI-A-1
[418.606871] Dynamic subtest A-HDMI-A-1: SUCCESS (1.339s)
[418.607548] Subtest default-dirtyfb-ioctl: SUCCESS (1.341s)
[418.727046] [095/131] (605s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[418.833305] Starting subtest: short-busy-flip-before-cursor-toggle
[418.834682] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[418.915422] [096/131] (605s left) gem_exec_fence (parallel)
[419.076639] Starting subtest: parallel
[419.077991] Starting dynamic subtest: rcs0
[421.226764] Dynamic subtest rcs0: SUCCESS (2.149s)
[421.235358] Starting dynamic subtest: bcs0
[423.375435] Dynamic subtest bcs0: SUCCESS (2.148s)
[423.382888] Starting dynamic subtest: vcs0
[425.525872] Dynamic subtest vcs0: SUCCESS (2.150s)
[425.533440] Starting dynamic subtest: vecs0
[427.675381] Dynamic subtest vecs0: SUCCESS (2.149s)
[427.676082] Subtest parallel: SUCCESS (8.599s)
[428.132335] [097/131] (596s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[428.243234] Starting subtest: cursorA-vs-flipB-atomic-transitions
[428.244564] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[428.328618] [098/131] (595s left) gem_eio (kms)
[428.445692] Starting subtest: kms
[441.926230] Subtest kms: SUCCESS (13.480s)
[442.163246] [099/131] (582s left) kms_lease (master-vs-lease)
[442.275108] Starting subtest: master-vs-lease
[442.275894] Subtest master-vs-lease: SUCCESS (0.001s)
[442.364981] [100/131] (581s left) kms_psr (fbc-psr2-sprite-plane-move)
[442.472443] Subtest fbc-psr2-sprite-plane-move: SKIP (0.000s)
[442.511159] [101/131] (581s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[442.627870] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[442.629263] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[442.749142] [102/131] (581s left) gem_exec_parallel (engines)
[442.794266] Starting subtest: engines
[442.794976] Starting dynamic subtest: basic
[444.233566] Dynamic subtest basic: SUCCESS (1.439s)
[444.247825] Starting dynamic subtest: contexts
[446.066056] Dynamic subtest contexts: SUCCESS (1.831s)
[446.073864] Starting dynamic subtest: fds
[447.786305] Dynamic subtest fds: SUCCESS (1.719s)
[447.799856] Starting dynamic subtest: userptr
[449.166645] Dynamic subtest userptr: SUCCESS (1.379s)
[449.167342] Subtest engines: SUCCESS (6.373s)
[449.357944] [103/131] (574s left) sysfs_timeslice_duration (duration)
[449.399451] Starting subtest: duration
[449.400166] Starting dynamic subtest: vecs0
[449.468807] Dynamic subtest vecs0: SUCCESS (0.068s)
[449.491067] Starting dynamic subtest: vcs0
[449.557738] Dynamic subtest vcs0: SUCCESS (0.086s)
[449.581222] Starting dynamic subtest: bcs0
[449.644719] Dynamic subtest bcs0: SUCCESS (0.084s)
[449.667628] Starting dynamic subtest: rcs0
[449.730676] Dynamic subtest rcs0: SUCCESS (0.083s)
[449.734797] Subtest duration: SUCCESS (0.332s)
[449.822972] [104/131] (574s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[449.859499] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[449.910316] [105/131] (574s left) gem_pread (self)
[449.948583] Subtest self: SKIP (0.000s)
[450.018090] [106/131] (574s left) gem_spin_batch (engines)
[450.060018] Starting subtest: engines
[450.060715] Starting dynamic subtest: rcs0
[453.377225] Dynamic subtest rcs0: SUCCESS (3.314s)
[453.386746] Starting dynamic subtest: bcs0
[456.696028] Dynamic subtest bcs0: SUCCESS (3.316s)
[456.705846] Starting dynamic subtest: vcs0
[460.015770] Dynamic subtest vcs0: SUCCESS (3.317s)
[460.026903] Starting dynamic subtest: vecs0
[463.333808] Dynamic subtest vecs0: SUCCESS (3.314s)
[463.335374] Subtest engines: SUCCESS (13.273s)
[463.536532] [107/131] (560s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[463.648768] Starting subtest: psr-shrfb-scaledprimary
[463.650073] Subtest psr-shrfb-scaledprimary: SKIP (0.000s)
[463.788266] [108/131] (560s left) vgem_slow (nohang)
[463.843246] Starting subtest: nohang
[474.208651] Subtest nohang: SUCCESS (10.364s)
[474.269398] [109/131] (550s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[474.305407] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[474.412704] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.106s)
[474.510929] [110/131] (549s left) kms_vblank (invalid)
[474.621088] Starting subtest: invalid
[474.622842] Starting dynamic subtest: pipe-A-HDMI-A-1
[474.882195] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.259s)
[474.883112] Subtest invalid: SUCCESS (0.260s)
[475.052442] [111/131] (549s left) kms_chamelium_audio (dp-audio-edid)
[475.225824] Subtest dp-audio-edid: SKIP (0.000s)
[475.293702] [112/131] (549s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[475.402773] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[475.404117] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[475.523969] [113/131] (549s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[475.635716] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[475.637041] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[475.764535] [114/131] (548s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[475.875883] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[475.893695] [115/131] (548s left) drm_fdinfo (busy-idle)
[475.930716] Starting subtest: busy-idle
[475.931398] Starting dynamic subtest: rcs0
[476.557451] Dynamic subtest rcs0: SUCCESS (0.626s)
[476.569278] Starting dynamic subtest: bcs0
[477.186900] Dynamic subtest bcs0: SUCCESS (0.627s)
[477.196251] Starting dynamic subtest: vcs0
[477.822572] Dynamic subtest vcs0: SUCCESS (0.634s)
[477.834317] Starting dynamic subtest: vecs0
[478.454463] Dynamic subtest vecs0: SUCCESS (0.629s)
[478.458536] Subtest busy-idle: SUCCESS (2.525s)
[478.532527] [116/131] (546s left) gen9_exec_parse (bb-chained)
[478.571297] Subtest bb-chained: SKIP (0.000s)
[478.614768] [117/131] (546s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[478.724747] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[481.063437] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SUCCESS (2.340s)
[481.245248] [118/131] (543s left) gem_ctx_isolation (preservation-reset)
[481.396240] Starting subtest: preservation-reset
[481.396966] Starting dynamic subtest: rcs0
[481.497914] Dynamic subtest rcs0: SUCCESS (0.101s)
[481.505481] Starting dynamic subtest: bcs0
[481.652282] Dynamic subtest bcs0: SUCCESS (0.154s)
[481.659937] Starting dynamic subtest: vcs0
[481.787707] Dynamic subtest vcs0: SUCCESS (0.135s)
[481.795413] Starting dynamic subtest: vecs0
[481.926758] Dynamic subtest vecs0: SUCCESS (0.138s)
[481.927504] Subtest preservation-reset: SUCCESS (0.531s)
[482.059647] [119/131] (542s left) gem_readwrite (read-write)
[482.092890] Subtest read-write: SKIP (0.000s)
[482.140921] [120/131] (542s left) kms_addfb_basic (invalid-set-prop-any)
[482.175994] Starting subtest: invalid-set-prop-any
[482.176747] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[482.374870] [121/131] (542s left) syncobj_timeline (multi-wait-submitted-signaled)
[482.409612] Starting subtest: multi-wait-submitted-signaled
[482.410346] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[482.507853] [122/131] (542s left) kms_psr (psr-sprite-plane-move)
[482.614459] Subtest psr-sprite-plane-move: SKIP (0.000s)
[482.656917] [123/131] (542s left) kms_flip (2x-flip-vs-suspend)
[482.764433] Starting subtest: 2x-flip-vs-suspend
[482.766785] Subtest 2x-flip-vs-suspend: SKIP (0.001s)
[482.906315] [124/131] (541s left) perf (mi-rpc)
[483.007839] Starting subtest: mi-rpc
[483.009198] Subtest mi-rpc: SKIP (0.000s)
[483.031578] [125/131] (541s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[483.142070] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[483.142748] Starting dynamic subtest: pipe-A
[483.245579] Dynamic subtest pipe-A: SUCCESS (0.103s)
[483.267470] Starting dynamic subtest: pipe-B
[483.391973] Dynamic subtest pipe-B: SUCCESS (0.143s)
[483.395996] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SUCCESS (0.251s)
[483.594181] [126/131] (541s left) kms_vblank (query-forked-busy)
[483.705086] Starting subtest: query-forked-busy
[483.706803] Starting dynamic subtest: pipe-A-HDMI-A-1
[486.515974] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.807s)
[486.548289] Starting dynamic subtest: pipe-B-HDMI-A-1
[489.265788] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.747s)
[489.266924] Subtest query-forked-busy: SUCCESS (5.561s)
[489.468740] [127/131] (535s left) gem_fence_thrash (bo-write-verify-y)
[489.502197] Starting subtest: bo-write-verify-y
[490.707200] Subtest bo-write-verify-y: SUCCESS (1.205s)
[490.838332] [128/131] (534s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[490.873749] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[490.874418] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[490.959295] [129/131] (534s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[491.071737] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[491.073036] Subtest psr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[491.189995] [130/131] (533s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[491.305112] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[491.306537] Subtest psr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[491.438528] [131/131] (533s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[491.547688] Starting subtest: cursorB-vs-flipA-atomic-transitions
[491.549445] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.002s)
[491.646939] Closing watchdogs
Done.