[52.316216] Initializing watchdogs
[52.316283]   /dev/watchdog0
[52.332780] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[52.339052] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[52.341551] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[52.343507] [001/133] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[52.437757] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[52.439119] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[52.537308] [002/133] (960s left) gem_reg_read (timestamp-monotonic)
[52.570523] Starting subtest: timestamp-monotonic
[57.245534] Subtest timestamp-monotonic: SUCCESS (4.665s)
[57.285492] [003/133] (955s left) i915_drm_fdinfo (busy-check-all)
[57.323769] Starting subtest: busy-check-all
[57.324725] Starting dynamic subtest: rcs0
[57.848471] Dynamic subtest rcs0: SUCCESS (0.525s)
[57.858321] Starting dynamic subtest: bcs0
[58.372304] Dynamic subtest bcs0: SUCCESS (0.522s)
[58.379625] Starting dynamic subtest: vcs0
[58.892172] Dynamic subtest vcs0: SUCCESS (0.519s)
[58.901435] Starting dynamic subtest: vcs1
[59.415180] Dynamic subtest vcs1: SUCCESS (0.523s)
[59.423411] Starting dynamic subtest: vecs0
[59.942283] Dynamic subtest vecs0: SUCCESS (0.526s)
[59.943391] Subtest busy-check-all: SUCCESS (2.619s)
[60.010216] [004/133] (952s left) kms_pwrite_crc
[60.555324] [005/133] (952s left) syncobj_timeline (reset-unsignaled)
[60.592380] Starting subtest: reset-unsignaled
[60.593103] Subtest reset-unsignaled: SUCCESS (0.000s)
[60.642862] [006/133] (952s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[60.733550] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[60.734917] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[60.823312] [007/133] (952s left) api_intel_allocator (execbuf-with-allocator)
[60.856759] Starting subtest: execbuf-with-allocator
[60.860365] Subtest execbuf-with-allocator: SUCCESS (0.004s)
[60.994388] [008/133] (952s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[61.082372] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[61.083704] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[61.170852] [009/133] (951s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[61.259417] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[62.580950] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (1.321s)
[62.699758] [010/133] (950s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[62.799753] Starting subtest: y-tiled-32bpp-rotate-180
[64.189565] Subtest y-tiled-32bpp-rotate-180: SUCCESS (1.390s)
[64.306059] [011/133] (948s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[64.394194] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[64.394868] Starting dynamic subtest: pipe-A-valid-mode
[65.195831] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.801s)
[65.196592] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SUCCESS (0.802s)
[65.330980] [012/133] (947s left) gem_exec_suspend (basic-s3)
[65.377672] Starting subtest: basic-S3
[65.378394] Starting dynamic subtest: smem
[83.302145] Dynamic subtest smem: SUCCESS (3.820s)
[83.302877] Subtest basic-S3: SUCCESS (3.821s)
[92.558329] [013/133] (929s left) gem_exec_balancer (invalid-balancer)
[92.611522] Starting subtest: invalid-balancer
[93.926735] Subtest invalid-balancer: SUCCESS (1.306s)
[94.116548] [014/133] (928s left) kms_pm_lpsp (screens-disabled)
[95.207382] Starting subtest: screens-disabled
[95.208810] Subtest screens-disabled: SKIP (0.000s)
[95.260631] [015/133] (927s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[95.349707] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[96.640690] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (1.291s)
[96.748853] [016/133] (925s left) gem_wait (await)
[96.794047] Starting subtest: await
[96.794774] Starting dynamic subtest: all-engines
[97.869329] Dynamic subtest all-engines: SUCCESS (1.075s)
[97.878750] Starting dynamic subtest: rcs0
[98.896525] Dynamic subtest rcs0: SUCCESS (1.026s)
[98.905777] Starting dynamic subtest: bcs0
[99.924489] Dynamic subtest bcs0: SUCCESS (1.027s)
[99.934111] Starting dynamic subtest: vcs0
[100.954624] Dynamic subtest vcs0: SUCCESS (1.029s)
[100.964663] Starting dynamic subtest: vcs1
[101.994896] Dynamic subtest vcs1: SUCCESS (1.039s)
[102.004525] Starting dynamic subtest: vecs0
[103.024540] Dynamic subtest vecs0: SUCCESS (1.029s)
[103.025590] Subtest await: SUCCESS (6.229s)
[103.206611] [FACT gem_wait (await)] new: kernel.kmod_is_loaded.vgem: true
[103.210348] [017/133] (919s left) gem_exercise_blt (fast-copy-emit)
[103.246165] Starting subtest: fast-copy-emit
[103.246939] Starting dynamic subtest: linear-smem-smem-emit
[103.265184] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.019s)
[103.271995] Starting dynamic subtest: ymajor-smem-smem-emit
[103.281674] Dynamic subtest ymajor-smem-smem-emit: SUCCESS (0.016s)
[103.288434] Starting dynamic subtest: tile4-smem-smem-emit
[103.297366] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.015s)
[103.304044] Starting dynamic subtest: tile64-smem-smem-emit
[103.313156] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.016s)
[103.313906] Subtest fast-copy-emit: SUCCESS (0.067s)
[103.412696] [018/133] (919s left) kms_big_fb (linear-16bpp-rotate-270)
[103.508005] Starting subtest: linear-16bpp-rotate-270
[103.582687] Subtest linear-16bpp-rotate-270: SKIP (0.074s)
[103.697981] [019/133] (918s left) gem_exec_balancer (parallel-keep-submit-fence)
[103.861404] Subtest parallel-keep-submit-fence: SKIP (0.000s)
[103.929821] [020/133] (918s left) gem_ctx_shared (single-timeline)
[103.969896] Starting subtest: single-timeline
[103.975649] Subtest single-timeline: SUCCESS (0.005s)
[104.157140] [021/133] (918s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[104.256548] Starting subtest: extended-modeset-hang-newfb-with-reset
[104.258118] Starting dynamic subtest: pipe-A
[107.094878] Dynamic subtest pipe-A: SUCCESS (2.837s)
[107.105848] Starting dynamic subtest: pipe-D
[109.973710] Dynamic subtest pipe-D: SUCCESS (2.875s)
[109.974545] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (5.717s)
[110.122483] [022/133] (912s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[110.223960] Starting subtest: x-tiled-32bpp-rotate-270
[110.301550] Subtest x-tiled-32bpp-rotate-270: SKIP (0.077s)
[110.415641] [023/133] (912s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[110.498932] Starting subtest: primary-y-tiled-reflect-x-180
[115.575069] Subtest primary-y-tiled-reflect-x-180: SUCCESS (5.075s)
[115.766953] [024/133] (906s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[115.853628] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[115.854317] Starting dynamic subtest: pipe-A-HDMI-A-1
[115.861842] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[115.868881] Starting dynamic subtest: pipe-B-HDMI-A-1
[115.876469] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[115.883259] Starting dynamic subtest: pipe-C-HDMI-A-1
[115.890718] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[115.897799] Starting dynamic subtest: pipe-D-HDMI-A-1
[115.905151] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[115.906489] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SKIP (0.005s)
[116.086715] [025/133] (906s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[116.126841] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[116.127542] Starting dynamic subtest: smem
[116.226198] Dynamic subtest smem: SUCCESS (0.100s)
[116.226965] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SUCCESS (0.100s)
[116.405007] [026/133] (906s left) gem_exec_schedule (u-fairslice-all)
[116.449727] Starting subtest: u-fairslice-all
[118.491322] Subtest u-fairslice-all: SUCCESS (2.042s)
[118.800040] [027/133] (904s left) kms_prime (basic-crc-vgem)
[118.898576] Starting subtest: basic-crc-vgem
[118.899264] Starting dynamic subtest: second-to-first
[119.567485] Dynamic subtest second-to-first: SUCCESS (0.670s)
[119.568460] Subtest basic-crc-vgem: SUCCESS (0.670s)
[119.673329] [028/133] (903s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[119.760862] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[119.763714] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.002s)
[119.818529] [029/133] (903s left) gem_mmap_gtt (basic-small-copy)
[119.850788] Starting subtest: basic-small-copy
[121.662502] Subtest basic-small-copy: SUCCESS (1.811s)
[121.727858] [030/133] (901s left) kms_content_protection (atomic-dpms)
[121.867469] Starting subtest: atomic-dpms
[121.880585] Subtest atomic-dpms: SKIP (0.011s)
[121.971726] [031/133] (901s left) prime_vgem (fence-wait)
[122.046883] Starting subtest: fence-wait
[122.047613] Starting dynamic subtest: rcs0
[123.092284] Dynamic subtest rcs0: SUCCESS (1.037s)
[123.103015] Starting dynamic subtest: bcs0
[124.123926] Dynamic subtest bcs0: SUCCESS (1.030s)
[124.135004] Starting dynamic subtest: vcs0
[125.147971] Dynamic subtest vcs0: SUCCESS (1.023s)
[125.158972] Starting dynamic subtest: vcs1
[126.171080] Dynamic subtest vcs1: SUCCESS (1.022s)
[126.182159] Starting dynamic subtest: vecs0
[127.193948] Dynamic subtest vecs0: SUCCESS (1.022s)
[127.195074] Subtest fence-wait: SUCCESS (5.140s)
[127.297393] [032/133] (895s left) i915_pm_rps (thresholds-idle)
[127.335662] Starting subtest: thresholds-idle
[127.336373] Starting dynamic subtest: gt0
[137.717233] Dynamic subtest gt0: SUCCESS (10.382s)
[137.718344] Subtest thresholds-idle: SUCCESS (10.383s)
[137.787357] [033/133] (885s left) kms_pipe_crc_basic (bad-source)
[137.873693] Starting subtest: bad-source
[137.874429] Subtest bad-source: SUCCESS (0.000s)
[137.928173] [034/133] (885s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[137.960622] Starting subtest: cpuset-medium-copy-odd
[144.951400] Subtest cpuset-medium-copy-odd: SUCCESS (6.988s)
[145.033905] [035/133] (878s left) syncobj_wait (invalid-reset-illegal-handle)
[145.109666] Starting subtest: invalid-reset-illegal-handle
[145.110359] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[145.173091] [036/133] (878s left) gem_pxp (create-regular-context-1)
[145.276054] Starting subtest: create-regular-context-1
[145.277111] Subtest create-regular-context-1: SUCCESS (0.001s)
[145.347870] [037/133] (877s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[145.440165] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (0.000s)
[145.481819] [038/133] (877s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[145.566628] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[145.607554] [039/133] (877s left) dmabuf_sync_file (export-before-signal)
[145.644496] Starting subtest: export-before-signal
[145.645205] Subtest export-before-signal: SUCCESS (0.001s)
[145.695306] [040/133] (877s left) kms_psr (psr2-sprite-mmap-cpu)
[145.779536] Subtest psr2-sprite-mmap-cpu: SKIP (0.000s)
[145.824452] [041/133] (877s left) gem_exec_parallel (userptr)
[145.865282] Starting subtest: userptr
[145.865993] Starting dynamic subtest: rcs0
[147.587433] Dynamic subtest rcs0: SUCCESS (1.722s)
[147.595699] Starting dynamic subtest: bcs0
[149.276688] Dynamic subtest bcs0: SUCCESS (1.689s)
[149.286017] Starting dynamic subtest: vcs0
[150.969980] Dynamic subtest vcs0: SUCCESS (1.693s)
[150.977643] Starting dynamic subtest: vcs1
[152.660849] Dynamic subtest vcs1: SUCCESS (1.690s)
[152.668403] Starting dynamic subtest: vecs0
[154.350410] Dynamic subtest vecs0: SUCCESS (1.689s)
[154.351144] Subtest userptr: SUCCESS (8.486s)
[154.535247] [042/133] (868s left) gem_pxp (reject-modify-context-protection-off-3)
[154.573715] Starting subtest: reject-modify-context-protection-off-3
[154.574401] Subtest reject-modify-context-protection-off-3: SUCCESS (0.000s)
[154.629444] [043/133] (868s left) gem_shrink (reclaim)
[154.666297] Starting subtest: reclaim
[156.946044] Subtest reclaim: SUCCESS (2.271s)
[157.077988] [044/133] (866s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[157.168849] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[157.170224] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[157.265387] [045/133] (866s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[157.349790] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[157.350477] Starting dynamic subtest: pipe-A-valid-mode
[158.504958] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.155s)
[158.505778] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SUCCESS (1.156s)
[158.669404] [046/133] (864s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[158.711732] Starting subtest: single-wait-for-submit-available-signaled
[158.712476] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.001s)
[158.770889] [047/133] (864s left) gem_ctx_param (get-priority-new-ctx)
[158.804014] Starting subtest: get-priority-new-ctx
[158.804764] Subtest get-priority-new-ctx: SUCCESS (0.000s)
[158.865177] [048/133] (864s left) i915_pm_rpm (system-suspend)
[160.273110] Starting subtest: system-suspend
[180.282582] Subtest system-suspend: SUCCESS (4.737s)
[187.506400] [049/133] (843s left) kms_lease (implicit-plane-lease)
[187.596915] Starting subtest: implicit-plane-lease
[187.598507] Subtest implicit-plane-lease: SUCCESS (0.002s)
[187.659981] [050/133] (843s left) gem_exec_schedule (implicit-read-write)
[187.704239] Starting subtest: implicit-read-write
[187.704970] Starting dynamic subtest: rcs0
[187.766296] Dynamic subtest rcs0: SUCCESS (0.062s)
[187.777159] Starting dynamic subtest: bcs0
[187.830937] Dynamic subtest bcs0: SUCCESS (0.063s)
[187.843312] Starting dynamic subtest: vcs0
[187.897259] Dynamic subtest vcs0: SUCCESS (0.065s)
[187.909967] Starting dynamic subtest: vcs1
[187.963409] Dynamic subtest vcs1: SUCCESS (0.065s)
[187.974827] Starting dynamic subtest: vecs0
[188.028644] Dynamic subtest vecs0: SUCCESS (0.064s)
[188.029833] Subtest implicit-read-write: SUCCESS (0.326s)
[188.326118] [051/133] (842s left) perf_pmu (frequency)
[188.361317] Starting subtest: frequency
[188.362896] Starting dynamic subtest: gt0
[190.471594] Dynamic subtest gt0: SUCCESS (2.107s)
[190.480143] Starting dynamic subtest: idle-gt0
[190.985647] Dynamic subtest idle-gt0: SUCCESS (0.506s)
[190.986343] Subtest frequency: SUCCESS (2.619s)
[191.049351] [052/133] (839s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[191.142450] Starting subtest: fbcpsr-modesetfrombusy
[191.143920] Subtest fbcpsr-modesetfrombusy: SKIP (0.000s)
[191.239903] [053/133] (839s left) gem_userptr_blits (stress-mm-invalidate-close)
[191.284975] Starting subtest: stress-mm-invalidate-close
[193.440969] Subtest stress-mm-invalidate-close: SUCCESS (2.148s)
[193.554330] [054/133] (837s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[193.642185] Starting subtest: crc-primary-suspend-y-tiled-ccs
[193.642884] Starting dynamic subtest: pipe-A-HDMI-A-1
[193.645625] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[193.653602] Starting dynamic subtest: pipe-B-HDMI-A-1
[193.656420] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[193.664649] Starting dynamic subtest: pipe-C-HDMI-A-1
[193.667429] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[193.675078] Starting dynamic subtest: pipe-D-HDMI-A-1
[193.677885] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[193.679287] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.006s)
[193.870093] [055/133] (837s left) sw_sync (sync_multi_consumer)
[193.906616] Starting subtest: sync_multi_consumer
[194.450709] Subtest sync_multi_consumer: SUCCESS (0.535s)
[194.509718] [056/133] (836s left) kms_vblank (query-forked-busy-hang)
[194.595061] Starting subtest: query-forked-busy-hang
[194.595739] Starting dynamic subtest: pipe-A-HDMI-A-1
[209.227712] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (14.633s)
[209.239242] Starting dynamic subtest: pipe-D-HDMI-A-1
[223.045107] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (13.813s)
[223.045839] Subtest query-forked-busy-hang: SUCCESS (28.453s)
[223.188403] [057/133] (807s left) kms_plane (plane-panning-bottom-right-suspend)
[223.282072] Starting subtest: plane-panning-bottom-right-suspend
[223.283639] Starting dynamic subtest: pipe-A
[240.116391] Dynamic subtest pipe-A: SUCCESS (1.566s)
[240.128083] Starting dynamic subtest: pipe-B
[257.116335] Dynamic subtest pipe-B: SUCCESS (1.533s)
[257.117102] Subtest plane-panning-bottom-right-suspend: SUCCESS (3.102s)
[266.299836] [058/133] (773s left) gem_mmap_offset (bad-extensions)
[266.351045] Starting subtest: bad-extensions
[266.351757] Subtest bad-extensions: SUCCESS (0.000s)
[266.445329] [059/133] (773s left) kms_psr (pr-basic)
[266.533934] Subtest pr-basic: SKIP (0.000s)
[266.580140] [060/133] (773s left) gem_userptr_blits (relocations)
[266.618528] Starting subtest: relocations
[266.619251] Subtest relocations: SUCCESS (0.002s)
[266.756928] [061/133] (773s left) kms_cursor_legacy (single-move)
[266.843694] Starting subtest: single-move
[266.844459] Starting dynamic subtest: pipe-A
[272.258305] Dynamic subtest pipe-A: SUCCESS (5.380s)
[272.266321] Starting dynamic subtest: pipe-B
[277.639032] Dynamic subtest pipe-B: SUCCESS (5.379s)
[277.647049] Starting dynamic subtest: pipe-C
[283.017282] Dynamic subtest pipe-C: SUCCESS (5.379s)
[283.025179] Starting dynamic subtest: pipe-D
[288.396311] Dynamic subtest pipe-D: SUCCESS (5.378s)
[288.404076] Starting dynamic subtest: all-pipes
[293.776929] Dynamic subtest all-pipes: SUCCESS (5.379s)
[293.777993] Subtest single-move: SUCCESS (26.900s)
[293.814631] [062/133] (746s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[293.914353] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[294.242523] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.328s)
[294.371911] [063/133] (746s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[294.467693] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[294.469103] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[294.563621] [064/133] (745s left) gem_exec_reloc (basic-gtt-read-active)
[294.601505] Starting subtest: basic-gtt-read-active
[294.735280] Subtest basic-gtt-read-active: SUCCESS (0.125s)
[294.854618] [065/133] (745s left) kms_chamelium_frames (hdmi-crc-single)
[294.994800] Subtest hdmi-crc-single: SKIP (0.000s)
[295.095254] [066/133] (745s left) gem_userptr_blits (process-exit)
[295.142880] Starting subtest: process-exit
[295.152719] Subtest process-exit: SUCCESS (0.010s)
[295.289491] [067/133] (745s left) kms_psr (psr-primary-mmap-cpu)
[295.376465] Subtest psr-primary-mmap-cpu: SKIP (0.000s)
[295.423415] [068/133] (745s left) gem_ctx_persistence (legacy-engines-cleanup)
[295.461129] Starting subtest: legacy-engines-cleanup
[295.461819] Starting dynamic subtest: render
[295.498175] Dynamic subtest render: SUCCESS (0.036s)
[295.515512] Starting dynamic subtest: bsd1
[295.544129] Dynamic subtest bsd1: SUCCESS (0.044s)
[295.562973] Starting dynamic subtest: bsd2
[295.585045] Dynamic subtest bsd2: SUCCESS (0.038s)
[295.602981] Starting dynamic subtest: blt
[295.625042] Dynamic subtest blt: SUCCESS (0.038s)
[295.642511] Starting dynamic subtest: vebox
[295.670033] Dynamic subtest vebox: SUCCESS (0.042s)
[295.671230] Subtest legacy-engines-cleanup: SUCCESS (0.209s)
[295.747116] [069/133] (744s left) kms_flip (blocking-absolute-wf_vblank)
[295.833063] Starting subtest: blocking-absolute-wf_vblank
[295.835758] Starting dynamic subtest: A-HDMI-A1
[303.539147] Dynamic subtest A-HDMI-A1: SUCCESS (7.683s)
[303.546768] Starting dynamic subtest: B-HDMI-A1
[311.189457] Dynamic subtest B-HDMI-A1: SUCCESS (7.661s)
[311.197333] Starting dynamic subtest: C-HDMI-A1
[318.882694] Dynamic subtest C-HDMI-A1: SUCCESS (7.666s)
[318.890037] Starting dynamic subtest: D-HDMI-A1
[326.513093] Dynamic subtest D-HDMI-A1: SUCCESS (7.656s)
[326.515691] Subtest blocking-absolute-wf_vblank: SUCCESS (30.680s)
[326.692401] [070/133] (713s left) kms_cursor_crc (cursor-alpha-transparent)
[326.782729] Starting subtest: cursor-alpha-transparent
[326.784759] Starting dynamic subtest: pipe-A-HDMI-A-1
[327.061636] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.277s)
[327.072328] Starting dynamic subtest: pipe-D-HDMI-A-1
[327.317037] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.253s)
[327.317928] Subtest cursor-alpha-transparent: SUCCESS (0.534s)
[327.471609] [071/133] (713s left) kms_color (invalid-degamma-lut-sizes)
[327.558862] Starting subtest: invalid-degamma-lut-sizes
[327.559626] Starting dynamic subtest: pipe-A
[327.615713] Dynamic subtest pipe-A: SUCCESS (0.057s)
[327.627443] Starting dynamic subtest: pipe-B
[327.628229] Dynamic subtest pipe-B: SUCCESS (0.001s)
[327.638203] Starting dynamic subtest: pipe-C
[327.638983] Dynamic subtest pipe-C: SUCCESS (0.001s)
[327.649342] Starting dynamic subtest: pipe-D
[327.650155] Dynamic subtest pipe-D: SUCCESS (0.001s)
[327.650916] Subtest invalid-degamma-lut-sizes: SUCCESS (0.062s)
[327.732296] [072/133] (713s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[327.821232] Starting subtest: 2x-flip-vs-cursor-legacy
[327.823892] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.002s)
[327.882905] [073/133] (712s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[327.972497] Starting subtest: psr-1p-primscrn-cur-indfb-move
[327.973931] Subtest psr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[328.063559] [074/133] (712s left) syncobj_wait (wait-any-interrupted)
[328.097544] Starting subtest: wait-any-interrupted
[328.199294] Subtest wait-any-interrupted: SUCCESS (0.101s)
[328.277051] [075/133] (712s left) gem_ctx_param (set-priority-invalid-size)
[328.310501] Starting subtest: set-priority-invalid-size
[328.311268] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[328.395357] [076/133] (712s left) perf_pmu (busy-double-start)
[328.431370] Starting subtest: busy-double-start
[328.432074] Starting dynamic subtest: rcs0
[331.978243] Dynamic subtest rcs0: SUCCESS (3.546s)
[331.989862] Starting dynamic subtest: bcs0
[335.525208] Dynamic subtest bcs0: SUCCESS (3.545s)
[335.537265] Starting dynamic subtest: vcs0
[339.069256] Dynamic subtest vcs0: SUCCESS (3.542s)
[339.082505] Starting dynamic subtest: vcs1
[342.618027] Dynamic subtest vcs1: SUCCESS (3.546s)
[342.629795] Starting dynamic subtest: vecs0
[346.169000] Dynamic subtest vecs0: SUCCESS (3.549s)
[346.170133] Subtest busy-double-start: SUCCESS (17.738s)
[346.242579] [077/133] (694s left) gem_ctx_persistence (engines-queued)
[346.279674] Starting subtest: engines-queued
[346.280382] Starting dynamic subtest: rcs0
[346.331220] Dynamic subtest rcs0: SUCCESS (0.050s)
[346.349247] Starting dynamic subtest: bcs0
[346.380135] Dynamic subtest bcs0: SUCCESS (0.047s)
[346.399925] Starting dynamic subtest: vcs0
[346.433243] Dynamic subtest vcs0: SUCCESS (0.050s)
[346.452626] Starting dynamic subtest: vcs1
[346.482074] Dynamic subtest vcs1: SUCCESS (0.047s)
[346.502383] Starting dynamic subtest: vecs0
[346.531158] Dynamic subtest vecs0: SUCCESS (0.047s)
[346.532618] Subtest engines-queued: SUCCESS (0.252s)
[346.609517] [078/133] (694s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[346.701085] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[346.702455] Subtest psr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[346.803769] [079/133] (694s left) kms_hdr (static-toggle-dpms)
[346.889303] Starting subtest: static-toggle-dpms
[346.891358] Subtest static-toggle-dpms: SKIP (0.000s)
[346.951544] [080/133] (694s left) gem_mmap (short-mmap)
[346.985533] Starting subtest: short-mmap
[346.986250] Subtest short-mmap: SUCCESS (0.000s)
[347.079527] [081/133] (694s left) syncobj_wait (invalid-signal-one-illegal-handle)
[347.113375] Starting subtest: invalid-signal-one-illegal-handle
[347.114108] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[347.195594] [082/133] (693s left) kms_cursor_crc (cursor-sliding-32x10)
[347.282459] Starting subtest: cursor-sliding-32x10
[347.335024] Subtest cursor-sliding-32x10: SKIP (0.051s)
[347.416783] [083/133] (693s left) gem_bad_reloc (negative-reloc)
[347.457685] Starting subtest: negative-reloc
[347.459710] Subtest negative-reloc: SUCCESS (0.000s)
[347.565637] [084/133] (693s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[347.654169] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[347.655613] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[347.737489] [085/133] (693s left) gem_pipe_control_store_loop (fresh-buffer)
[347.775580] Starting subtest: fresh-buffer
[349.934073] Subtest fresh-buffer: SUCCESS (2.150s)
[350.045576] [086/133] (691s left) i915_pm_freq_api (freq-basic-api)
[350.082448] Subtest freq-basic-api: SKIP (0.000s)
[350.140539] [087/133] (691s left) gem_request_retire (retire-vma-not-inactive)
[350.178670] Starting subtest: retire-vma-not-inactive
[350.189721] Subtest retire-vma-not-inactive: SUCCESS (0.011s)
[350.314632] [088/133] (691s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[350.401024] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[350.401700] Starting dynamic subtest: pipe-A-HDMI-A-1
[350.408244] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[350.416174] Starting dynamic subtest: pipe-B-HDMI-A-1
[350.422733] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[350.430776] Starting dynamic subtest: pipe-C-HDMI-A-1
[350.437286] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[350.444843] Starting dynamic subtest: pipe-D-HDMI-A-1
[350.451800] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[350.453163] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SKIP (0.007s)
[350.631307] [089/133] (690s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[350.721900] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[350.723307] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[350.824035] [090/133] (690s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[350.910182] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.000s)
[350.951838] [091/133] (690s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[350.986591] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[351.091181] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.104s)
[351.166828] [092/133] (690s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[351.257234] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[351.258616] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[351.349652] [093/133] (690s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[351.444112] Starting subtest: 4-tiled-8bpp-rotate-90
[351.445558] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.000s)
[351.544034] [094/133] (690s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[351.628442] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[351.629168] Starting dynamic subtest: pipe-A-HDMI-A-1
[351.635940] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[351.644170] Starting dynamic subtest: pipe-B-HDMI-A-1
[351.650927] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[351.658840] Starting dynamic subtest: pipe-C-HDMI-A-1
[351.665610] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[351.673337] Starting dynamic subtest: pipe-D-HDMI-A-1
[351.680116] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[351.681442] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[351.866932] [095/133] (689s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[351.965650] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[351.967052] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[352.070168] [096/133] (689s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[352.203042] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[352.298808] [097/133] (689s left) kms_feature_discovery (dp-mst)
[352.397736] Starting subtest: dp-mst
[352.399125] Subtest dp-mst: SKIP (0.000s)
[352.477638] [098/133] (689s left) kms_flip (bo-too-big)
[352.563515] Starting subtest: bo-too-big
[352.565536] Starting dynamic subtest: A-HDMI-A1
[352.903084] Dynamic subtest A-HDMI-A1: SUCCESS (0.337s)
[352.917246] Starting dynamic subtest: B-HDMI-A1
[353.219171] Dynamic subtest B-HDMI-A1: SUCCESS (0.309s)
[353.231155] Starting dynamic subtest: C-HDMI-A1
[353.528931] Dynamic subtest C-HDMI-A1: SUCCESS (0.312s)
[353.539041] Starting dynamic subtest: D-HDMI-A1
[353.858357] Dynamic subtest D-HDMI-A1: SUCCESS (0.324s)
[353.859243] Subtest bo-too-big: SUCCESS (1.295s)
[354.008782] [099/133] (687s left) sysfs_defaults (readonly)
[354.048738] Starting subtest: readonly
[354.050887] Starting dynamic subtest: vecs0
[354.051629] Dynamic subtest vecs0: SUCCESS (0.001s)
[354.061903] Starting dynamic subtest: vcs0
[354.062670] Dynamic subtest vcs0: SUCCESS (0.000s)
[354.070464] Starting dynamic subtest: bcs0
[354.071148] Dynamic subtest bcs0: SUCCESS (0.001s)
[354.078834] Starting dynamic subtest: rcs0
[354.079505] Dynamic subtest rcs0: SUCCESS (0.001s)
[354.086751] Starting dynamic subtest: vcs1
[354.087445] Dynamic subtest vcs1: SUCCESS (0.001s)
[354.088139] Subtest readonly: SUCCESS (0.011s)
[354.149426] [100/133] (687s left) gem_spin_batch (resubmit-all)
[354.190561] Starting subtest: resubmit-all
[354.191269] Starting dynamic subtest: rcs0
[354.194972] Dynamic subtest rcs0: SUCCESS (0.004s)
[354.205734] Starting dynamic subtest: bcs0
[354.206496] Dynamic subtest bcs0: SUCCESS (0.002s)
[354.214803] Starting dynamic subtest: vcs0
[354.215495] Dynamic subtest vcs0: SUCCESS (0.002s)
[354.223005] Starting dynamic subtest: vcs1
[354.223698] Dynamic subtest vcs1: SUCCESS (0.002s)
[354.231173] Starting dynamic subtest: vecs0
[354.231861] Dynamic subtest vecs0: SUCCESS (0.002s)
[354.232542] Subtest resubmit-all: SUCCESS (0.016s)
[354.394236] [101/133] (687s left) perf_pmu (busy-idle-check-all)
[354.430760] Starting subtest: busy-idle-check-all
[354.431479] Starting dynamic subtest: rcs0
[355.055764] Dynamic subtest rcs0: SUCCESS (0.624s)
[355.067758] Starting dynamic subtest: bcs0
[355.679844] Dynamic subtest bcs0: SUCCESS (0.620s)
[355.691059] Starting dynamic subtest: vcs0
[356.302922] Dynamic subtest vcs0: SUCCESS (0.621s)
[356.315140] Starting dynamic subtest: vcs1
[356.928972] Dynamic subtest vcs1: SUCCESS (0.622s)
[356.940129] Starting dynamic subtest: vecs0
[357.551883] Dynamic subtest vecs0: SUCCESS (0.621s)
[357.552935] Subtest busy-idle-check-all: SUCCESS (3.121s)
[357.623585] [102/133] (684s left) kms_vblank (accuracy-idle)
[357.710263] Starting subtest: accuracy-idle
[357.710961] Starting dynamic subtest: pipe-A-HDMI-A-1
[358.889560] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.177s)
[358.899761] Starting dynamic subtest: pipe-D-HDMI-A-1
[360.049236] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.156s)
[360.049956] Subtest accuracy-idle: SUCCESS (2.340s)
[360.214139] [103/133] (681s left) perf (per-context-mode-unprivileged)
[360.309582] Starting subtest: per-context-mode-unprivileged
[360.310940] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[360.355284] [104/133] (681s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[360.443394] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[360.444123] Starting dynamic subtest: pipe-A
[361.558470] Dynamic subtest pipe-A: SUCCESS (1.115s)
[361.569344] Starting dynamic subtest: pipe-B
[362.733891] Dynamic subtest pipe-B: SUCCESS (1.174s)
[362.748417] Starting dynamic subtest: pipe-C
[362.934299] Dynamic subtest pipe-C: SUCCESS (0.199s)
[362.943836] Starting dynamic subtest: pipe-D
[363.142551] Dynamic subtest pipe-D: SUCCESS (0.207s)
[363.143274] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (2.700s)
[363.317661] [105/133] (678s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[363.407285] Starting subtest: compare-crc-sanitycheck-xr24
[363.408050] Starting dynamic subtest: pipe-A-HDMI-A-1
[363.675502] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.267s)
[363.684731] Starting dynamic subtest: pipe-B-HDMI-A-1
[363.924496] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.247s)
[363.936565] Starting dynamic subtest: pipe-C-HDMI-A-1
[364.180278] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.254s)
[364.190519] Starting dynamic subtest: pipe-D-HDMI-A-1
[364.439171] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.256s)
[364.439862] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.033s)
[364.597160] [106/133] (677s left) kms_atomic_transition (modeset-transition-nonblocking)
[364.688548] Starting subtest: modeset-transition-nonblocking
[364.689268] Starting dynamic subtest: 1x-outputs
[365.883607] Dynamic subtest 1x-outputs: SUCCESS (1.195s)
[365.884657] Subtest modeset-transition-nonblocking: SUCCESS (1.196s)
[366.015012] [107/133] (676s left) syncobj_wait (invalid-signal-illegal-handle)
[366.051889] Starting subtest: invalid-signal-illegal-handle
[366.052598] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[366.123224] [108/133] (676s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[366.213400] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[366.214837] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[366.307554] [109/133] (675s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[366.343211] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[366.457103] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.108s)
[366.528935] [110/133] (675s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[366.563403] Starting subtest: invalid-multi-wait-unsubmitted
[366.564122] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[366.623494] [111/133] (675s left) syncobj_timeline (multi-wait-all-available-signaled)
[366.660182] Starting subtest: multi-wait-all-available-signaled
[366.660862] Subtest multi-wait-all-available-signaled: SUCCESS (0.001s)
[366.745324] [112/133] (675s left) gem_userptr_blits (invalid-null-pointer)
[366.783101] Starting subtest: invalid-null-pointer
[366.783799] Subtest invalid-null-pointer: SUCCESS (0.001s)
[366.900232] [113/133] (675s left) kms_psr (fbc-psr2-cursor-render)
[366.986213] Subtest fbc-psr2-cursor-render: SKIP (0.000s)
[367.026600] [114/133] (675s left) gem_exec_schedule (u-submit-late-slice)
[367.073373] Starting subtest: u-submit-late-slice
[367.074069] Starting dynamic subtest: rcs0
[367.100774] Dynamic subtest rcs0: SUCCESS (0.028s)
[367.110932] Starting dynamic subtest: bcs0
[367.130669] Dynamic subtest bcs0: SUCCESS (0.029s)
[367.140603] Starting dynamic subtest: vcs0
[367.159064] Dynamic subtest vcs0: SUCCESS (0.027s)
[367.167822] Starting dynamic subtest: vcs1
[367.187546] Dynamic subtest vcs1: SUCCESS (0.027s)
[367.196195] Starting dynamic subtest: vecs0
[367.215795] Dynamic subtest vecs0: SUCCESS (0.028s)
[367.216560] Subtest u-submit-late-slice: SUCCESS (0.144s)
[367.518543] [115/133] (675s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[367.558836] Starting subtest: single-wait-all-for-submit-unsubmitted
[367.659106] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.106s)
[367.743658] [116/133] (674s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[367.834750] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[369.136800] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (1.303s)
[369.257019] [117/133] (673s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping)
[369.346902] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping
[369.348384] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[369.405104] [118/133] (673s left) kms_addfb_basic (master-rmfb)
[369.439404] Starting subtest: master-rmfb
[369.440102] Subtest master-rmfb: SUCCESS (0.001s)
[369.593007] [119/133] (673s left) api_intel_bb (offset-control)
[369.627563] Starting subtest: offset-control
[369.632123] Subtest offset-control: SUCCESS (0.006s)
[369.732185] [120/133] (673s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[369.822532] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[369.832180] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.009s)
[369.898373] [121/133] (672s left) gen9_exec_parse (bb-secure)
[369.934509] Subtest bb-secure: SKIP (0.000s)
[369.978060] [122/133] (672s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[370.063529] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[370.064938] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s)
[370.122902] [123/133] (672s left) kms_plane_multiple (2x-tiling-x)
[370.208686] Starting subtest: 2x-tiling-x
[370.210098] Subtest 2x-tiling-x: SKIP (0.000s)
[370.263838] [124/133] (672s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[370.349556] Starting subtest: basic-flip-before-cursor-varying-size
[370.870356] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.520s)
[370.996314] [125/133] (671s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[371.082768] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[371.130536] [126/133] (671s left) gem_basic (bad-close)
[371.165803] Starting subtest: bad-close
[371.167196] Subtest bad-close: SUCCESS (0.000s)
[371.227304] [127/133] (671s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[371.316201] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[371.317571] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[371.400236] [128/133] (671s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[371.485581] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[371.486296] Starting dynamic subtest: pipe-A-HDMI-A-1
[371.493129] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[371.501290] Starting dynamic subtest: pipe-B-HDMI-A-1
[371.508097] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[371.516047] Starting dynamic subtest: pipe-C-HDMI-A-1
[371.522841] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[371.530637] Starting dynamic subtest: pipe-D-HDMI-A-1
[371.537419] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[371.538807] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.007s)
[371.725139] [129/133] (671s left) kms_cursor_crc (cursor-sliding-128x128)
[371.817693] Starting subtest: cursor-sliding-128x128
[371.822369] Starting dynamic subtest: pipe-A-HDMI-A-1
[373.667894] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.845s)
[373.706793] Starting dynamic subtest: pipe-D-HDMI-A-1
[375.508683] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.808s)
[375.509393] Subtest cursor-sliding-128x128: SUCCESS (3.691s)
[375.679210] [130/133] (667s left) gem_exec_fence (long-history)
[376.047394] Starting subtest: long-history
[381.774694] Subtest long-history: SUCCESS (5.718s)
[382.219122] [131/133] (660s left) gem_ctx_exec (basic-close-race)
[382.254954] Starting subtest: basic-close-race
[387.892629] Subtest basic-close-race: SUCCESS (5.628s)
[387.999176] [132/133] (655s left) syncobj_wait (single-wait-all-signaled)
[388.033093] Starting subtest: single-wait-all-signaled
[388.033891] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[388.102072] [133/133] (655s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[388.189302] Starting subtest: basic-flip-before-cursor-legacy
[388.713957] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.524s)
[388.855216] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_reg_read
results: parsing output: 2/ for test: i915_drm_fdinfo
results: parsing output: 3/ for test: kms_pwrite_crc
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: api_intel_allocator
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: kms_flip_scaled_crc
results: parsing output: 11/ for test: gem_exec_suspend
results: parsing output: 12/ for test: gem_exec_balancer
results: parsing output: 13/ for test: kms_pm_lpsp
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_wait
results: parsing output: 16/ for test: gem_exercise_blt
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: gem_exec_balancer
results: parsing output: 19/ for test: gem_ctx_shared
results: parsing output: 20/ for test: kms_busy
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: kms_rotation_crc
results: parsing output: 23/ for test: kms_ccs
results: parsing output: 24/ for test: gem_render_copy
results: parsing output: 25/ for test: gem_exec_schedule
results: parsing output: 26/ for test: kms_prime
results: parsing output: 27/ for test: kms_cursor_legacy
results: parsing output: 28/ for test: gem_mmap_gtt
results: parsing output: 29/ for test: kms_content_protection
results: parsing output: 30/ for test: prime_vgem
results: parsing output: 31/ for test: i915_pm_rps
results: parsing output: 32/ for test: kms_pipe_crc_basic
results: parsing output: 33/ for test: gem_mmap_gtt
results: parsing output: 34/ for test: syncobj_wait
results: parsing output: 35/ for test: gem_pxp
results: parsing output: 36/ for test: kms_psr2_sf
results: parsing output: 37/ for test: kms_psr
results: parsing output: 38/ for test: dmabuf_sync_file
results: parsing output: 39/ for test: kms_psr
results: parsing output: 40/ for test: gem_exec_parallel
results: parsing output: 41/ for test: gem_pxp
results: parsing output: 42/ for test: gem_shrink
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_flip_scaled_crc
results: parsing output: 45/ for test: syncobj_timeline
results: parsing output: 46/ for test: gem_ctx_param
results: parsing output: 47/ for test: i915_pm_rpm
results: parsing output: 48/ for test: kms_lease
results: parsing output: 49/ for test: gem_exec_schedule
results: parsing output: 50/ for test: perf_pmu
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: gem_userptr_blits
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: sw_sync
results: parsing output: 55/ for test: kms_vblank
results: parsing output: 56/ for test: kms_plane
results: parsing output: 57/ for test: gem_mmap_offset
results: parsing output: 58/ for test: kms_psr
results: parsing output: 59/ for test: gem_userptr_blits
results: parsing output: 60/ for test: kms_cursor_legacy
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_exec_reloc
results: parsing output: 64/ for test: kms_chamelium_frames
results: parsing output: 65/ for test: gem_userptr_blits
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: gem_ctx_persistence
results: parsing output: 68/ for test: kms_flip
results: parsing output: 69/ for test: kms_cursor_crc
results: parsing output: 70/ for test: kms_color
results: parsing output: 71/ for test: kms_cursor_legacy
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: syncobj_wait
results: parsing output: 74/ for test: gem_ctx_param
results: parsing output: 75/ for test: perf_pmu
results: parsing output: 76/ for test: gem_ctx_persistence
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_hdr
results: parsing output: 79/ for test: gem_mmap
results: parsing output: 80/ for test: syncobj_wait
results: parsing output: 81/ for test: kms_cursor_crc
results: parsing output: 82/ for test: gem_bad_reloc
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: gem_pipe_control_store_loop
results: parsing output: 85/ for test: i915_pm_freq_api
results: parsing output: 86/ for test: gem_request_retire
results: parsing output: 87/ for test: kms_ccs
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: kms_ccs
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: kms_chamelium_hpd
results: parsing output: 96/ for test: kms_feature_discovery
results: parsing output: 97/ for test: kms_flip
results: parsing output: 98/ for test: sysfs_defaults
results: parsing output: 99/ for test: gem_spin_batch
results: parsing output: 100/ for test: perf_pmu
results: parsing output: 101/ for test: kms_vblank
results: parsing output: 102/ for test: perf
results: parsing output: 103/ for test: kms_plane_scaling
results: parsing output: 104/ for test: kms_pipe_crc_basic
results: parsing output: 105/ for test: kms_atomic_transition
results: parsing output: 106/ for test: syncobj_wait
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: syncobj_timeline
results: parsing output: 109/ for test: syncobj_wait
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: gem_userptr_blits
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: gem_exec_schedule
results: parsing output: 114/ for test: syncobj_wait
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_plane
results: parsing output: 117/ for test: kms_addfb_basic
results: parsing output: 118/ for test: api_intel_bb
results: parsing output: 119/ for test: kms_flip
results: parsing output: 120/ for test: gen9_exec_parse
results: parsing output: 121/ for test: kms_flip_scaled_crc
results: parsing output: 122/ for test: kms_plane_multiple
results: parsing output: 123/ for test: kms_cursor_legacy
results: parsing output: 124/ for test: kms_psr2_sf
results: parsing output: 125/ for test: gem_basic
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_ccs
results: parsing output: 128/ for test: kms_cursor_crc
results: parsing output: 129/ for test: gem_exec_fence
results: parsing output: 130/ for test: gem_ctx_exec
results: parsing output: 131/ for test: syncobj_wait
results: parsing output: 132/ for test: kms_cursor_legacy
Done.