[72.250216] Initializing watchdogs
[72.250289]   /dev/watchdog0
[72.267746] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[72.284108] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[72.290093] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[72.294688] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[72.499696] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[79.465415] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.967s)
[79.592512] [002/133] (953s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[79.681645] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[79.686294] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[79.777882] [003/133] (953s left) gem_eio (banned)
[79.937722] Starting subtest: banned
[80.293285] Subtest banned: SUCCESS (0.357s)
[80.429229] [004/133] (952s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[80.814835] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[81.589522] [005/133] (951s left) drm_read (empty-nonblock)
[81.745308] Starting subtest: empty-nonblock
[81.747673] Subtest empty-nonblock: SUCCESS (0.000s)
[81.867045] [006/133] (951s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping)
[81.945867] Starting subtest: pixel-format-4-tiled-modifier-source-clamping
[81.972224] Starting dynamic subtest: pipe-A-plane-0
[82.627423] Dynamic subtest pipe-A-plane-0: SUCCESS (0.656s)
[82.635419] Starting dynamic subtest: pipe-A-plane-3
[83.072082] Dynamic subtest pipe-A-plane-3: SUCCESS (0.444s)
[84.192780] Starting dynamic subtest: pipe-B-plane-0
[84.820420] Dynamic subtest pipe-B-plane-0: SUCCESS (0.633s)
[84.829616] Starting dynamic subtest: pipe-B-plane-3
[85.253054] Dynamic subtest pipe-B-plane-3: SUCCESS (0.433s)
[85.579579] Subtest pixel-format-4-tiled-modifier-source-clamping: SUCCESS (3.634s)
[86.371746] [007/133] (946s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[86.450686] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[86.455137] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[86.546255] [008/133] (946s left) gem_eio (in-flight-internal-10ms)
[86.756545] Starting subtest: in-flight-internal-10ms
[88.297322] Subtest in-flight-internal-10ms: SUCCESS (1.540s)
[88.425406] [009/133] (944s left) kms_pm_rpm (package-g7)
[90.429386] Starting subtest: package-g7
[90.434380] Subtest package-g7: SKIP (0.000s)
[90.792257] [010/133] (942s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[90.881268] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[91.560363] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.681s)
[91.720751] [011/133] (941s left) sw_sync (sync_multi_producer_single_consumer)
[91.759121] Starting subtest: sync_multi_producer_single_consumer
[92.834968] Subtest sync_multi_producer_single_consumer: SUCCESS (1.076s)
[92.894243] [012/133] (940s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[92.954338] Starting subtest: y-tiled-ccs-to-x-tiled
[92.958846] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[93.146832] [013/133] (940s left) gem_wait (invalid-buf)
[93.200730] Starting subtest: invalid-buf
[93.202854] Subtest invalid-buf: SUCCESS (0.000s)
[93.420209] [014/133] (939s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[93.477093] Subtest tiled-to-untiled: SKIP (0.000s)
[93.536617] [015/133] (939s left) kms_draw_crc (draw-method-render)
[93.603876] Starting subtest: draw-method-render
[93.606055] Starting dynamic subtest: xrgb8888-untiled
[93.824297] Dynamic subtest xrgb8888-untiled: SUCCESS (0.222s)
[93.836540] Starting dynamic subtest: rgb565-untiled
[94.046479] Dynamic subtest rgb565-untiled: SUCCESS (0.221s)
[94.056511] Starting dynamic subtest: xrgb2101010-untiled
[94.268219] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[94.277934] Starting dynamic subtest: xbgr16161616f-untiled
[94.490242] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s)
[94.499279] Starting dynamic subtest: xrgb8888-xtiled
[94.612558] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[94.621486] Starting dynamic subtest: rgb565-xtiled
[94.735357] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s)
[94.745238] Starting dynamic subtest: xrgb2101010-xtiled
[94.857927] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s)
[94.868975] Starting dynamic subtest: xbgr16161616f-xtiled
[94.979317] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.121s)
[94.988565] Starting dynamic subtest: xrgb8888-4tiled
[95.102084] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.121s)
[95.112502] Starting dynamic subtest: rgb565-4tiled
[95.212674] Dynamic subtest rgb565-4tiled: SUCCESS (0.110s)
[95.221902] Starting dynamic subtest: xrgb2101010-4tiled
[95.323882] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.110s)
[95.332706] Starting dynamic subtest: xbgr16161616f-4tiled
[95.457367] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.132s)
[95.459349] Subtest draw-method-render: SUCCESS (1.855s)
[95.560674] [016/133] (937s left) perf (non-system-wide-paranoid)
[95.672940] Starting subtest: non-system-wide-paranoid
[95.697703] Subtest non-system-wide-paranoid: SUCCESS (0.026s)
[95.735993] [017/133] (937s left) kms_dp_linktrain_fallback (dp-fallback)
[95.814177] Starting subtest: dp-fallback
[95.819687] Subtest dp-fallback: SKIP (0.000s)
[95.887802] [018/133] (937s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[95.962155] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[95.964095] Starting dynamic subtest: pipe-A-eDP-1
[96.736396] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.768s)
[96.744906] Starting dynamic subtest: pipe-B-eDP-1
[98.319688] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.581s)
[98.329433] Starting dynamic subtest: pipe-C-eDP-1
[99.809405] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.488s)
[99.822426] Starting dynamic subtest: pipe-D-eDP-1
[101.250452] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.440s)
[101.252908] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.280s)
[102.448349] [019/133] (931s left) gem_exec_schedule (pi-userfault)
[102.635653] Starting subtest: pi-userfault
[102.638044] Starting dynamic subtest: rcs0
[102.644486] Dynamic subtest rcs0: SUCCESS (0.011s)
[102.652707] Starting dynamic subtest: bcs0
[102.655097] Dynamic subtest bcs0: SUCCESS (0.009s)
[102.663954] Starting dynamic subtest: vcs0
[102.665841] Dynamic subtest vcs0: SUCCESS (0.007s)
[102.673959] Starting dynamic subtest: vcs1
[102.676204] Dynamic subtest vcs1: SUCCESS (0.011s)
[102.684337] Starting dynamic subtest: vecs0
[102.686567] Dynamic subtest vecs0: SUCCESS (0.009s)
[102.694679] Starting dynamic subtest: ccs0
[102.696556] Dynamic subtest ccs0: SUCCESS (0.007s)
[102.698472] Subtest pi-userfault: SUCCESS (0.056s)
[102.881695] [020/133] (930s left) i915_drm_fdinfo (basics)
[102.918706] Starting subtest: basics
[102.921112] Subtest basics: SUCCESS (0.000s)
[102.977864] [021/133] (930s left) kms_chamelium_hpd (hdmi-hpd-storm)
[103.343048] Subtest hdmi-hpd-storm: SKIP (0.000s)
[104.144479] [022/133] (929s left) perf (invalid-open-flags)
[104.235839] Starting subtest: invalid-open-flags
[104.238073] Subtest invalid-open-flags: SUCCESS (0.000s)
[104.272176] [023/133] (929s left) sw_sync (alloc_merge_fence)
[104.313277] Starting subtest: alloc_merge_fence
[104.315700] Subtest alloc_merge_fence: SUCCESS (0.000s)
[104.370043] [024/133] (929s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[104.452480] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[104.456461] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[104.556948] [025/133] (929s left) gem_exec_params (no-bsd)
[104.618585] Starting subtest: no-bsd
[104.623736] Subtest no-bsd: SUCCESS (0.003s)
[106.243794] [026/133] (927s left) kms_chamelium_color (ctm-limited-range)
[106.326939] Subtest ctm-limited-range: SKIP (0.000s)
[106.369587] [027/133] (927s left) kms_plane (plane-panning-bottom-right)
[106.456073] Starting subtest: plane-panning-bottom-right
[106.458340] Starting dynamic subtest: pipe-A
[108.119667] Dynamic subtest pipe-A: SUCCESS (1.662s)
[108.128832] Starting dynamic subtest: pipe-B
[110.478674] Dynamic subtest pipe-B: SUCCESS (2.358s)
[110.480638] Subtest plane-panning-bottom-right: SUCCESS (4.022s)
[111.301575] [028/133] (922s left) perf (global-sseu-config-invalid)
[111.386908] Starting subtest: global-sseu-config-invalid
[111.391134] Subtest global-sseu-config-invalid: SKIP (0.000s)
[111.434407] [029/133] (922s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[111.523782] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[115.885361] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.367s)
[117.014803] [030/133] (916s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[117.068013] Starting subtest: yf-tiled-to-vebox-yf-tiled
[117.072339] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[117.247501] [031/133] (916s left) gem_exec_balancer (bonded-chain)
[117.302413] Starting subtest: bonded-chain
[124.268879] Subtest bonded-chain: SUCCESS (6.964s)
[124.586667] [032/133] (909s left) kms_color (ctm-blue-to-red)
[124.665969] Starting subtest: ctm-blue-to-red
[124.668357] Starting dynamic subtest: pipe-A-eDP-1
[125.337818] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.671s)
[125.347299] Starting dynamic subtest: pipe-B-eDP-1
[126.679130] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.341s)
[126.688761] Starting dynamic subtest: pipe-C-eDP-1
[127.968616] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.289s)
[127.977663] Starting dynamic subtest: pipe-D-eDP-1
[129.291788] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.321s)
[129.293693] Subtest ctm-blue-to-red: SUCCESS (4.624s)
[130.135476] [033/133] (903s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[130.219518] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[137.280766] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.065s)
[137.381342] [034/133] (896s left) kms_3d (basic)
[137.431679] Starting subtest: basic
[137.435878] Subtest basic: SKIP (0.000s)
[137.509411] [035/133] (896s left) kms_psr (fbc-psr-cursor-plane-move)
[137.580060] Starting subtest: fbc-psr-cursor-plane-move
[137.582304] Starting dynamic subtest: eDP-1
[137.586483] Dynamic subtest eDP-1: SKIP (0.000s)
[137.590726] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[137.663368] [036/133] (896s left) gem_eio (create-ext)
[137.867178] Starting subtest: create-ext
[138.152219] Subtest create-ext: SUCCESS (0.286s)
[138.269492] [037/133] (895s left) i915_power (sanity)
[138.317373] Starting subtest: sanity
[142.357067] Subtest sanity: SUCCESS (4.033s)
[144.327050] [038/133] (889s left) gem_linear_blits (normal)
[144.666770] Starting subtest: normal
[149.459817] Subtest normal: SUCCESS (4.791s)
[149.650341] [039/133] (884s left) syncobj_timeline (wait-all-complex)
[149.732329] Starting subtest: wait-all-complex
[149.947890] Subtest wait-all-complex: SUCCESS (0.213s)
[150.025057] [040/133] (884s left) kms_busy (extended-pageflip-hang-newfb)
[150.113425] Starting subtest: extended-pageflip-hang-newfb
[150.115439] Starting dynamic subtest: pipe-A
[176.035126] Dynamic subtest pipe-A: SUCCESS (25.919s)
[176.045486] Starting dynamic subtest: pipe-D
[200.973451] Dynamic subtest pipe-D: SUCCESS (24.936s)
[200.975698] Subtest extended-pageflip-hang-newfb: SUCCESS (50.860s)
[201.807089] [041/133] (832s left) prime_vgem (basic-fence-flip)
[201.993177] Starting subtest: basic-fence-flip
[202.275374] Subtest basic-fence-flip: SUCCESS (0.282s)
[202.378645] [FACT prime_vgem (basic-fence-flip)] new: kernel.kmod_is_loaded.vgem: true
[202.382048] [042/133] (832s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf)
[202.462060] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf
[202.466314] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[202.532883] [043/133] (831s left) kms_vblank (wait-busy-hang)
[202.609411] Starting subtest: wait-busy-hang
[202.611530] Starting dynamic subtest: pipe-A-eDP-1
[229.051782] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.439s)
[229.067127] Starting dynamic subtest: pipe-D-eDP-1
[244.027257] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.972s)
[244.029214] Subtest wait-busy-hang: SUCCESS (41.415s)
[244.881822] [044/133] (789s left) gem_ctx_param (invalid-param-get)
[244.930089] Starting subtest: invalid-param-get
[244.932456] Subtest invalid-param-get: SUCCESS (0.001s)
[245.025360] [045/133] (789s left) perf (polling-parameterized)
[245.140762] Starting subtest: polling-parameterized
[265.159691] Subtest polling-parameterized: SUCCESS (20.018s)
[265.210167] [046/133] (769s left) gem_ctx_param (invalid-get-ringsize)
[265.264921] Starting subtest: invalid-get-ringsize
[265.267296] Subtest invalid-get-ringsize: SUCCESS (0.002s)
[265.383408] [047/133] (769s left) kms_cursor_crc (cursor-onscreen-128x42)
[265.606352] Starting subtest: cursor-onscreen-128x42
[265.650104] Subtest cursor-onscreen-128x42: SKIP (0.039s)
[265.867853] [048/133] (768s left) i915_pm_rc6_residency (media-rc6-accuracy)
[265.936512] Starting subtest: media-rc6-accuracy
[265.941021] Subtest media-rc6-accuracy: SKIP (0.000s)
[266.038896] [049/133] (768s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[266.121318] Starting subtest: fbc-1p-pri-indfb-multidraw
[278.902825] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (12.786s)
[280.276641] [050/133] (754s left) perf_pmu (rc6)
[280.320146] Starting subtest: rc6
[280.322454] Starting dynamic subtest: gt0
[286.682315] Dynamic subtest gt0: SUCCESS (6.362s)
[286.693168] Starting dynamic subtest: runtime-pm-gt0
[294.467384] Dynamic subtest runtime-pm-gt0: SUCCESS (7.782s)
[294.480830] Starting dynamic subtest: runtime-pm-long-gt0
[306.905065] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.436s)
[306.918025] Starting dynamic subtest: other-idle-gt0
[313.247523] Dynamic subtest other-idle-gt0: SUCCESS (6.340s)
[313.260970] Starting dynamic subtest: gt1
[319.589527] Dynamic subtest gt1: SUCCESS (6.339s)
[319.603209] Starting dynamic subtest: runtime-pm-gt1
[327.077364] Dynamic subtest runtime-pm-gt1: SUCCESS (7.486s)
[327.089958] Starting dynamic subtest: runtime-pm-long-gt1
[339.514621] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.435s)
[339.525301] Starting dynamic subtest: other-idle-gt1
[345.858285] Dynamic subtest other-idle-gt1: SUCCESS (6.341s)
[345.861241] Subtest rc6: SUCCESS (65.541s)
[347.021821] [051/133] (687s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[347.073485] Starting subtest: wait-all-for-submit-delayed-submit
[347.174353] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.102s)
[347.231366] [052/133] (687s left) kms_flip (flip-vs-rmfb)
[347.309317] Starting subtest: flip-vs-rmfb
[347.311612] Starting dynamic subtest: A-eDP1
[355.922132] Dynamic subtest A-eDP1: SUCCESS (8.615s)
[355.935646] Starting dynamic subtest: B-eDP1
[364.548857] Dynamic subtest B-eDP1: SUCCESS (8.624s)
[364.562078] Starting dynamic subtest: C-eDP1
[373.169264] Dynamic subtest C-eDP1: SUCCESS (8.617s)
[373.179409] Starting dynamic subtest: D-eDP1
[381.809309] Dynamic subtest D-eDP1: SUCCESS (8.638s)
[381.814133] Subtest flip-vs-rmfb: SUCCESS (34.508s)
[382.972846] [053/133] (651s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[383.048489] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[383.052531] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[383.124823] [054/133] (651s left) kms_big_fb (linear-32bpp-rotate-90)
[383.209275] Starting subtest: linear-32bpp-rotate-90
[383.232254] Subtest linear-32bpp-rotate-90: SKIP (0.022s)
[383.313682] [055/133] (651s left) gem_exec_balancer (parallel-keep-submit-fence)
[383.568903] Starting subtest: parallel-keep-submit-fence
[384.786590] Subtest parallel-keep-submit-fence: SUCCESS (1.218s)
[384.869355] [056/133] (650s left) gen9_exec_parse (basic-rejected)
[384.929856] Subtest basic-rejected: SKIP (0.000s)
[385.018801] [057/133] (650s left) gem_lmem_swapping (verify-random-ccs)
[385.062098] Subtest verify-random-ccs: SKIP (0.000s)
[385.111552] [058/133] (649s left) kms_psr2_su (frontbuffer-xrgb8888)
[385.166061] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[385.232369] [059/133] (649s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[385.303762] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[385.305885] Starting dynamic subtest: pipe-A-eDP-1
[385.327184] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[385.346674] Starting dynamic subtest: pipe-B-eDP-1
[385.368746] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[385.385620] Starting dynamic subtest: pipe-C-eDP-1
[385.407201] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[385.419572] Starting dynamic subtest: pipe-D-eDP-1
[385.441971] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[385.446057] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[387.525431] [060/133] (647s left) gem_exec_store (dword)
[387.599495] Starting subtest: dword
[387.601669] Starting dynamic subtest: rcs0
[387.657537] Dynamic subtest rcs0: SUCCESS (0.061s)
[387.669748] Starting dynamic subtest: bcs0
[387.699221] Dynamic subtest bcs0: SUCCESS (0.040s)
[387.709458] Starting dynamic subtest: vcs0
[387.740936] Dynamic subtest vcs0: SUCCESS (0.039s)
[387.750945] Starting dynamic subtest: vcs1
[387.781982] Dynamic subtest vcs1: SUCCESS (0.039s)
[387.792402] Starting dynamic subtest: vecs0
[387.824083] Dynamic subtest vecs0: SUCCESS (0.040s)
[387.833889] Starting dynamic subtest: ccs0
[387.868197] Dynamic subtest ccs0: SUCCESS (0.042s)
[387.870443] Subtest dword: SUCCESS (0.273s)
[388.038427] [061/133] (647s left) gen7_exec_parse (basic-allocation)
[388.087383] Subtest basic-allocation: SKIP (0.000s)
[388.153663] [062/133] (647s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[388.235183] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[388.237076] Starting dynamic subtest: pipe-A-eDP-1
[388.659675] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.424s)
[388.671084] Starting dynamic subtest: pipe-B-eDP-1
[388.690812] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.003s)
[388.700283] Starting dynamic subtest: pipe-C-eDP-1
[388.720555] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.008s)
[388.732055] Starting dynamic subtest: pipe-D-eDP-1
[388.751604] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[388.753499] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.456s)
[391.005299] [063/133] (644s left) kms_psr (psr-cursor-mmap-gtt)
[391.078950] Starting subtest: psr-cursor-mmap-gtt
[391.081368] Starting dynamic subtest: eDP-1
[392.805868] Dynamic subtest eDP-1: SUCCESS (1.727s)
[392.808176] Subtest psr-cursor-mmap-gtt: SUCCESS (1.728s)
[393.663211] [064/133] (641s left) syncobj_timeline (multi-wait-all-signaled)
[393.716265] Starting subtest: multi-wait-all-signaled
[393.718187] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[393.785390] [065/133] (641s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[395.390050] Starting subtest: dpms-mode-unset-lpsp
[399.449966] Subtest dpms-mode-unset-lpsp: SUCCESS (4.064s)
[399.795895] [066/133] (635s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[399.875212] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[399.877508] Starting dynamic subtest: pipe-A-default-mode
[402.637247] Dynamic subtest pipe-A-default-mode: SUCCESS (2.761s)
[402.639360] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.763s)
[403.483313] [067/133] (631s left) gem_create (create-ext-set-pat)
[403.647932] Starting subtest: create-ext-set-pat
[403.650412] Subtest create-ext-set-pat: SUCCESS (0.001s)
[403.719783] [068/133] (631s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[403.803816] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[410.384781] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.584s)
[410.474589] [069/133] (625s left) gem_render_tiled_blits (basic)
[410.546079] Subtest basic: SKIP (0.000s)
[410.626092] [070/133] (624s left) kms_legacy_colorkey (basic)
[410.701192] Starting subtest: basic
[410.703340] Starting dynamic subtest: pipe-A
[410.744342] Dynamic subtest pipe-A: SUCCESS (0.045s)
[410.757030] Starting dynamic subtest: pipe-B
[410.758912] Dynamic subtest pipe-B: SUCCESS (0.001s)
[410.768293] Starting dynamic subtest: pipe-C
[410.770161] Dynamic subtest pipe-C: SUCCESS (0.000s)
[410.779549] Starting dynamic subtest: pipe-D
[410.781443] Dynamic subtest pipe-D: SUCCESS (0.000s)
[410.783318] Subtest basic: SUCCESS (0.051s)
[410.821739] [071/133] (624s left) kms_flip (flip-vs-expired-vblank)
[410.911475] Starting subtest: flip-vs-expired-vblank
[410.913726] Starting dynamic subtest: A-eDP1
[419.614572] Dynamic subtest A-eDP1: SUCCESS (8.703s)
[419.625088] Starting dynamic subtest: B-eDP1
[428.256442] Dynamic subtest B-eDP1: SUCCESS (8.641s)
[428.269689] Starting dynamic subtest: C-eDP1
[436.875058] Dynamic subtest C-eDP1: SUCCESS (8.614s)
[436.885652] Starting dynamic subtest: D-eDP1
[445.512149] Dynamic subtest D-eDP1: SUCCESS (8.637s)
[445.514542] Subtest flip-vs-expired-vblank: SUCCESS (34.605s)
[446.666015] [072/133] (588s left) kms_flip (bo-too-big-interruptible)
[446.742949] Starting subtest: bo-too-big-interruptible
[446.745271] Starting dynamic subtest: A-eDP1
[448.022300] Dynamic subtest A-eDP1: SUCCESS (1.279s)
[448.032577] Starting dynamic subtest: B-eDP1
[449.280388] Dynamic subtest B-eDP1: SUCCESS (1.256s)
[449.297168] Starting dynamic subtest: C-eDP1
[450.523406] Dynamic subtest C-eDP1: SUCCESS (1.241s)
[450.533102] Starting dynamic subtest: D-eDP1
[451.852930] Dynamic subtest D-eDP1: SUCCESS (1.327s)
[451.857819] Subtest bo-too-big-interruptible: SUCCESS (5.116s)
[453.051479] [073/133] (582s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[453.133360] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[453.137714] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[453.210358] [074/133] (582s left) kms_flip (flip-vs-dpms-on-nop)
[453.288420] Starting subtest: flip-vs-dpms-on-nop
[453.290724] Starting dynamic subtest: A-eDP1
[455.169129] Dynamic subtest A-eDP1: SUCCESS (1.882s)
[455.182523] Starting dynamic subtest: B-eDP1
[456.999596] Dynamic subtest B-eDP1: SUCCESS (1.829s)
[457.011736] Starting dynamic subtest: C-eDP1
[458.823619] Dynamic subtest C-eDP1: SUCCESS (1.822s)
[458.834858] Starting dynamic subtest: D-eDP1
[460.667283] Dynamic subtest D-eDP1: SUCCESS (1.843s)
[460.669601] Subtest flip-vs-dpms-on-nop: SUCCESS (7.384s)
[461.824302] [075/133] (573s left) gem_ctx_persistence (smoketest)
[461.881544] Starting subtest: smoketest
[502.173427] Subtest smoketest: SUCCESS (40.288s)
[502.230680] [076/133] (533s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[502.326874] Starting subtest: y-tiled-16bpp-rotate-270
[502.331565] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[502.399194] [077/133] (533s left) kms_fence_pin_leak
[502.544772] [078/133] (533s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[502.614642] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[509.430397] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.819s)
[509.554448] [079/133] (526s left) kms_psr (psr2-basic)
[509.623393] Starting subtest: psr2-basic
[509.625606] Starting dynamic subtest: eDP-1
[511.219987] Dynamic subtest eDP-1: SUCCESS (1.597s)
[511.222267] Subtest psr2-basic: SUCCESS (1.598s)
[512.001122] [080/133] (523s left) syncobj_timeline (host-signal-points)
[512.053049] Starting subtest: host-signal-points
[512.055019] Subtest host-signal-points: SUCCESS (0.004s)
[512.136980] [081/133] (523s left) api_intel_allocator (alloc-simple)
[512.199499] Starting subtest: alloc-simple
[512.201509] Subtest alloc-simple: SUCCESS (0.003s)
[512.295587] [082/133] (523s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[512.374684] Starting subtest: psr-rgb565-draw-render
[519.243690] Subtest psr-rgb565-draw-render: SUCCESS (6.871s)
[519.323430] [083/133] (516s left) kms_addfb_basic (too-high)
[519.406307] Starting subtest: too-high
[519.408163] Subtest too-high: SUCCESS (0.000s)
[519.485898] [084/133] (516s left) kms_content_protection (uevent)
[519.615901] Starting subtest: uevent
[519.620496] Subtest uevent: SKIP (0.000s)
[519.708457] [085/133] (516s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[519.781337] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[519.785775] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[519.829584] [086/133] (516s left) api_intel_bb (object-noreloc-keep-cache-simple)
[519.889023] Starting subtest: object-noreloc-keep-cache-simple
[519.895097] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.006s)
[519.982445] [087/133] (516s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[520.059238] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[520.063114] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[520.137167] [088/133] (516s left) kms_flip (blocking-absolute-wf_vblank)
[520.220458] Starting subtest: blocking-absolute-wf_vblank
[520.222460] Starting dynamic subtest: A-eDP1
[528.920093] Dynamic subtest A-eDP1: SUCCESS (8.700s)
[528.930397] Starting dynamic subtest: B-eDP1
[537.648367] Dynamic subtest B-eDP1: SUCCESS (8.726s)
[537.658657] Starting dynamic subtest: C-eDP1
[546.380952] Dynamic subtest C-eDP1: SUCCESS (8.730s)
[546.391350] Starting dynamic subtest: D-eDP1
[555.104440] Dynamic subtest D-eDP1: SUCCESS (8.720s)
[555.109904] Subtest blocking-absolute-wf_vblank: SUCCESS (34.886s)
[556.300776] [089/133] (480s left) gem_exec_flush (basic-wb-ro-default)
[556.362456] Starting subtest: basic-wb-ro-default
[561.833554] Subtest basic-wb-ro-default: SUCCESS (5.471s)
[562.000343] [090/133] (474s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[562.085648] Starting subtest: fbc-indfb-scaledprimary
[565.049893] Subtest fbc-indfb-scaledprimary: SUCCESS (2.968s)
[566.188064] [091/133] (470s left) kms_pipe_crc_basic (nonblocking-crc)
[566.268057] Starting subtest: nonblocking-crc
[566.269944] Starting dynamic subtest: pipe-A-eDP-1
[567.003927] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.734s)
[567.015381] Starting dynamic subtest: pipe-B-eDP-1
[568.399916] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.396s)
[568.410276] Starting dynamic subtest: pipe-C-eDP-1
[569.791241] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.389s)
[569.803726] Starting dynamic subtest: pipe-D-eDP-1
[571.125794] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.334s)
[571.128108] Subtest nonblocking-crc: SUCCESS (4.858s)
[571.911468] [092/133] (464s left) syncobj_timeline (invalid-query-one-illegal-handle)
[571.963434] Starting subtest: invalid-query-one-illegal-handle
[571.965814] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s)
[572.048728] [093/133] (464s left) syncobj_wait (wait-for-submit-complex)
[572.110207] Starting subtest: wait-for-submit-complex
[572.171903] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[572.227989] [094/133] (464s left) kms_psr (psr-sprite-plane-onoff)
[572.306853] Starting subtest: psr-sprite-plane-onoff
[572.309199] Starting dynamic subtest: eDP-1
[574.087120] Dynamic subtest eDP-1: SUCCESS (1.780s)
[574.089528] Subtest psr-sprite-plane-onoff: SUCCESS (1.781s)
[574.880544] [095/133] (461s left) gem_mmap_offset (open-flood)
[574.939762] Starting subtest: open-flood
[596.428625] Subtest open-flood: SUCCESS (21.489s)
[596.524739] [096/133] (440s left) gem_lmem_swapping (heavy-verify-random)
[596.565973] Subtest heavy-verify-random: SKIP (0.000s)
[596.614593] [097/133] (440s left) kms_rotation_crc (cursor-rotation-180)
[596.690419] Starting subtest: cursor-rotation-180
[598.169042] Subtest cursor-rotation-180: SUCCESS (1.477s)
[599.372430] [098/133] (437s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[599.450082] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[599.452467] Starting dynamic subtest: pipe-A
[599.470397] Dynamic subtest pipe-A: SKIP (0.016s)
[599.485982] Starting dynamic subtest: pipe-B
[599.498701] Dynamic subtest pipe-B: SKIP (0.028s)
[599.513977] Starting dynamic subtest: pipe-C
[599.527554] Dynamic subtest pipe-C: SKIP (0.028s)
[599.537829] Starting dynamic subtest: pipe-D
[599.556894] Dynamic subtest pipe-D: SKIP (0.028s)
[599.560706] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.102s)
[599.627031] [099/133] (437s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[599.714472] Starting subtest: modeset-transition-nonblocking-fencing
[599.716765] Starting dynamic subtest: 1x-outputs
[610.525374] Dynamic subtest 1x-outputs: SUCCESS (10.810s)
[610.528106] Subtest modeset-transition-nonblocking-fencing: SUCCESS (10.812s)
[611.369952] [100/133] (425s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[611.446484] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[611.450764] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[611.517872] [101/133] (425s left) kms_plane_multiple (2x-tiling-y)
[611.593556] Starting subtest: 2x-tiling-y
[611.597321] Subtest 2x-tiling-y: SKIP (0.000s)
[611.644169] [102/133] (425s left) gem_exec_params (mmapped)
[611.711330] Starting subtest: mmapped
[611.713331] Subtest mmapped: SUCCESS (0.002s)
[611.799295] [103/133] (425s left) gem_pread (self)
[611.846188] Subtest self: SKIP (0.000s)
[611.908919] [104/133] (425s left) kms_cursor_edge_walk (256x256-top-edge)
[611.986822] Starting subtest: 256x256-top-edge
[611.988980] Starting dynamic subtest: pipe-A-eDP-1
[615.452200] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.465s)
[615.462929] Starting dynamic subtest: pipe-D-eDP-1
[618.580425] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.127s)
[618.582731] Subtest 256x256-top-edge: SUCCESS (6.594s)
[619.370377] [105/133] (417s left) syncobj_wait (wait-any-snapshot)
[619.430616] Starting subtest: wait-any-snapshot
[619.510630] Subtest wait-any-snapshot: SUCCESS (0.081s)
[619.567082] [106/133] (417s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[619.650578] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[619.654751] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[619.724217] [107/133] (417s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[619.786064] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[619.790571] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[619.947572] [108/133] (417s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[620.507647] Starting subtest: syncobj-timeline-invalid-wait
[620.509964] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.004s)
[622.278627] [109/133] (414s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[622.364080] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[622.366348] Starting dynamic subtest: pipe-A-eDP-1
[622.391348] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[622.403196] Starting dynamic subtest: pipe-B-eDP-1
[622.426857] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[622.436847] Starting dynamic subtest: pipe-C-eDP-1
[622.460770] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[622.470565] Starting dynamic subtest: pipe-D-eDP-1
[622.494336] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[622.498572] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[624.548672] [110/133] (412s left) kms_getfb (getfb2-handle-not-fb)
[624.620160] Starting subtest: getfb2-handle-not-fb
[624.622630] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[624.692708] [111/133] (412s left) vgem_basic (dmabuf-mmap)
[624.743748] Starting subtest: dmabuf-mmap
[624.748643] Subtest dmabuf-mmap: SUCCESS (0.007s)
[624.789212] [112/133] (412s left) gem_softpin (allocator-nopin)
[624.851762] Starting subtest: allocator-nopin
[624.944348] Subtest allocator-nopin: SUCCESS (0.092s)
[625.032070] [113/133] (412s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[625.114081] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[625.118494] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[625.190710] [114/133] (412s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[625.273359] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[625.277408] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[625.352118] [115/133] (412s left) kms_joiner (basic-force-ultra-joiner)
[625.447151] Starting subtest: basic-force-ultra-joiner
[625.451314] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[625.489011] [116/133] (412s left) syncobj_eventfd (invalid-bad-pad)
[625.564244] Starting subtest: invalid-bad-pad
[625.566481] Subtest invalid-bad-pad: SUCCESS (0.000s)
[625.635831] [117/133] (411s left) kms_psr (fbc-pr-sprite-plane-move)
[625.709698] Starting subtest: fbc-pr-sprite-plane-move
[625.713360] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[625.758900] [118/133] (411s left) drm_buddy (drm_buddy)
[625.796445] Starting subtest: drm_buddy
[625.800213] Subtest drm_buddy: SKIP (0.001s)
[625.837190] [119/133] (411s left) syncobj_basic (bad-pad-fd-to-handle)
[625.886380] Starting subtest: bad-pad-fd-to-handle
[625.888418] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[625.978312] [120/133] (411s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[626.073769] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[626.077518] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[626.143099] [121/133] (411s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[626.199470] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[626.274708] [122/133] (411s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[626.349907] Starting subtest: psr-rgb101010-draw-mmap-wc
[633.400153] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (7.051s)
[633.499408] [123/133] (404s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[633.580223] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[634.404955] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.826s)
[634.547359] [124/133] (403s left) sysfs_timeslice_duration (idempotent)
[634.616244] Starting subtest: idempotent
[634.618747] Starting dynamic subtest: vecs0
[634.621230] Dynamic subtest vecs0: SUCCESS (0.000s)
[634.632482] Starting dynamic subtest: ccs0
[634.634376] Dynamic subtest ccs0: SUCCESS (0.000s)
[634.643418] Starting dynamic subtest: vcs0
[634.645322] Dynamic subtest vcs0: SUCCESS (0.000s)
[634.654291] Starting dynamic subtest: bcs0
[634.656163] Dynamic subtest bcs0: SUCCESS (0.000s)
[634.664932] Starting dynamic subtest: rcs0
[634.666830] Dynamic subtest rcs0: SUCCESS (0.000s)
[634.676436] Starting dynamic subtest: vcs1
[634.678601] Dynamic subtest vcs1: SUCCESS (0.000s)
[634.680765] Subtest idempotent: SUCCESS (0.006s)
[634.718534] [125/133] (403s left) kms_vblank (query-busy-hang)
[634.800923] Starting subtest: query-busy-hang
[634.803137] Starting dynamic subtest: pipe-A-eDP-1
[661.044854] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.242s)
[661.065071] Starting dynamic subtest: pipe-D-eDP-1
[686.007065] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.956s)
[686.009033] Subtest query-busy-hang: SUCCESS (51.202s)
[686.810491] [126/133] (351s left) perf_pmu (init-sema)
[686.857102] Starting subtest: init-sema
[686.859272] Starting dynamic subtest: rcs0
[686.861534] Dynamic subtest rcs0: SUCCESS (0.002s)
[686.871765] Starting dynamic subtest: bcs0
[686.873647] Dynamic subtest bcs0: SUCCESS (0.000s)
[686.883140] Starting dynamic subtest: vcs0
[686.884996] Dynamic subtest vcs0: SUCCESS (0.001s)
[686.897251] Starting dynamic subtest: vcs1
[686.899201] Dynamic subtest vcs1: SUCCESS (0.000s)
[686.908722] Starting dynamic subtest: vecs0
[686.910930] Dynamic subtest vecs0: SUCCESS (0.000s)
[686.920274] Starting dynamic subtest: ccs0
[686.922431] Dynamic subtest ccs0: SUCCESS (0.001s)
[686.924631] Subtest init-sema: SUCCESS (0.008s)
[686.963650] [127/133] (351s left) gem_ccs (ctrl-surf-copy)
[687.024186] Starting subtest: ctrl-surf-copy
[687.028593] Subtest ctrl-surf-copy: SKIP (0.000s)
[687.101265] [128/133] (350s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[687.196956] Starting subtest: cursorA-vs-flipB-atomic-transitions
[687.201605] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[687.316563] [129/133] (350s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[687.498036] Starting subtest: cursor-rapid-movement-64x21
[687.542806] Subtest cursor-rapid-movement-64x21: SKIP (0.038s)
[687.749308] [130/133] (350s left) gem_exec_schedule (thriceslice)
[687.828460] Starting subtest: thriceslice
[687.830162] Starting dynamic subtest: rcs0
[687.851500] Dynamic subtest rcs0: SUCCESS (0.029s)
[687.863015] Starting dynamic subtest: bcs0
[687.880538] Dynamic subtest bcs0: SUCCESS (0.028s)
[687.890949] Starting dynamic subtest: vcs0
[687.931529] Dynamic subtest vcs0: SUCCESS (0.050s)
[687.944884] Starting dynamic subtest: vcs1
[687.964275] Dynamic subtest vcs1: SUCCESS (0.030s)
[687.973457] Starting dynamic subtest: vecs0
[687.993561] Dynamic subtest vecs0: SUCCESS (0.028s)
[688.002754] Starting dynamic subtest: ccs0
[688.025909] Dynamic subtest ccs0: SUCCESS (0.031s)
[688.028073] Subtest thriceslice: SUCCESS (0.204s)
[688.307775] [131/133] (349s left) i915_pm_freq_api (freq-basic-api)
[688.373748] Starting subtest: freq-basic-api
[688.376201] Starting dynamic subtest: gt0
[688.378629] Dynamic subtest gt0: SUCCESS (0.002s)
[688.390569] Starting dynamic subtest: gt1
[688.392532] Dynamic subtest gt1: SUCCESS (0.003s)
[688.394482] Subtest freq-basic-api: SUCCESS (0.006s)
[688.455098] [132/133] (349s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[688.539698] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[688.544056] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[688.585028] [133/133] (349s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[688.661237] Starting subtest: fbc-2p-pri-indfb-multidraw
[688.665299] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[688.742282] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: gem_eio
results: parsing output: 3/ for test: kms_chamelium_edid
results: parsing output: 4/ for test: drm_read
results: parsing output: 5/ for test: kms_plane
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: gem_eio
results: parsing output: 8/ for test: kms_pm_rpm
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: sw_sync
results: parsing output: 11/ for test: gem_render_copy
results: parsing output: 12/ for test: gem_wait
results: parsing output: 13/ for test: gem_set_tiling_vs_blt
results: parsing output: 14/ for test: kms_draw_crc
results: parsing output: 15/ for test: perf
results: parsing output: 16/ for test: kms_dp_linktrain_fallback
results: parsing output: 17/ for test: kms_ccs
results: parsing output: 18/ for test: gem_exec_schedule
results: parsing output: 19/ for test: i915_drm_fdinfo
results: parsing output: 20/ for test: kms_chamelium_hpd
results: parsing output: 21/ for test: perf
results: parsing output: 22/ for test: sw_sync
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: gem_exec_params
results: parsing output: 25/ for test: kms_chamelium_color
results: parsing output: 26/ for test: kms_plane
results: parsing output: 27/ for test: perf
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: gem_render_copy
results: parsing output: 30/ for test: gem_exec_balancer
results: parsing output: 31/ for test: kms_color
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_3d
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: gem_eio
results: parsing output: 36/ for test: i915_power
results: parsing output: 37/ for test: gem_linear_blits
results: parsing output: 38/ for test: syncobj_timeline
results: parsing output: 39/ for test: kms_busy
results: parsing output: 40/ for test: prime_vgem
results: parsing output: 41/ for test: kms_psr2_sf
results: parsing output: 42/ for test: kms_vblank
results: parsing output: 43/ for test: gem_ctx_param
results: parsing output: 44/ for test: perf
results: parsing output: 45/ for test: gem_ctx_param
results: parsing output: 46/ for test: kms_cursor_crc
results: parsing output: 47/ for test: i915_pm_rc6_residency
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: perf_pmu
results: parsing output: 50/ for test: syncobj_wait
results: parsing output: 51/ for test: kms_flip
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: gem_exec_balancer
results: parsing output: 55/ for test: gen9_exec_parse
results: parsing output: 56/ for test: gem_lmem_swapping
results: parsing output: 57/ for test: kms_psr2_su
results: parsing output: 58/ for test: kms_ccs
results: parsing output: 59/ for test: gem_exec_store
results: parsing output: 60/ for test: gen7_exec_parse
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: syncobj_timeline
results: parsing output: 64/ for test: kms_pm_rpm
results: parsing output: 65/ for test: kms_flip_scaled_crc
results: parsing output: 66/ for test: gem_create
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_render_tiled_blits
results: parsing output: 69/ for test: kms_legacy_colorkey
results: parsing output: 70/ for test: kms_flip
results: parsing output: 71/ for test: kms_flip
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_flip
results: parsing output: 74/ for test: gem_ctx_persistence
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: kms_fence_pin_leak
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_psr
results: parsing output: 79/ for test: syncobj_timeline
results: parsing output: 80/ for test: api_intel_allocator
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_addfb_basic
results: parsing output: 83/ for test: kms_content_protection
results: parsing output: 84/ for test: kms_flip_scaled_crc
results: parsing output: 85/ for test: api_intel_bb
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_flip
results: parsing output: 88/ for test: gem_exec_flush
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_pipe_crc_basic
results: parsing output: 91/ for test: syncobj_timeline
results: parsing output: 92/ for test: syncobj_wait
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: gem_mmap_offset
results: parsing output: 95/ for test: gem_lmem_swapping
results: parsing output: 96/ for test: kms_rotation_crc
results: parsing output: 97/ for test: kms_plane_scaling
results: parsing output: 98/ for test: kms_atomic_transition
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_plane_multiple
results: parsing output: 101/ for test: gem_exec_params
results: parsing output: 102/ for test: gem_pread
results: parsing output: 103/ for test: kms_cursor_edge_walk
results: parsing output: 104/ for test: syncobj_wait
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: gem_render_copy
results: parsing output: 107/ for test: gem_exec_fence
results: parsing output: 108/ for test: kms_ccs
results: parsing output: 109/ for test: kms_getfb
results: parsing output: 110/ for test: vgem_basic
results: parsing output: 111/ for test: gem_softpin
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_joiner
results: parsing output: 115/ for test: syncobj_eventfd
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: drm_buddy
results: parsing output: 118/ for test: syncobj_basic
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: gem_exec_reloc
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: sysfs_timeslice_duration
results: parsing output: 124/ for test: kms_vblank
results: parsing output: 125/ for test: perf_pmu
results: parsing output: 126/ for test: gem_ccs
results: parsing output: 127/ for test: kms_cursor_legacy
results: parsing output: 128/ for test: kms_cursor_crc
results: parsing output: 129/ for test: gem_exec_schedule
results: parsing output: 130/ for test: i915_pm_freq_api
results: parsing output: 131/ for test: kms_psr2_sf
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.