[858.105162] Initializing watchdogs
[858.105207]   /dev/watchdog0
[858.123545] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[858.129727] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[858.131940] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[858.132339] [FACT before any test] new: kernel.kmod_is_loaded.vgem: true
[858.134684] [001/134] (960s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[858.285785] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[865.537882] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.254s)
[865.695299] [002/134] (952s left) kms_chamelium_frames (dp-crc-single)
[866.076320] Subtest dp-crc-single: SKIP (0.000s)
[866.911122] [003/134] (951s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[867.005200] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[867.007310] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[868.131995] [004/134] (950s left) kms_prop_blob (invalid-get-prop)
[868.196303] Starting subtest: invalid-get-prop
[868.197571] Subtest invalid-get-prop: SUCCESS (0.000s)
[868.325314] [005/134] (950s left) syncobj_wait (reset-unsignaled)
[868.374341] Starting subtest: reset-unsignaled
[868.375415] Subtest reset-unsignaled: SUCCESS (0.000s)
[868.491629] [006/134] (950s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[868.598326] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[868.600610] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[868.721763] [007/134] (950s left) i915_module_load (resize-bar)
[868.754625] Starting subtest: resize-bar
[868.760121] Subtest resize-bar: SKIP (0.006s)
[868.800611] [008/134] (950s left) syncobj_timeline (signal-point-0)
[868.860925] Starting subtest: signal-point-0
[868.862592] Subtest signal-point-0: SUCCESS (0.000s)
[869.013738] [009/134] (949s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[869.110136] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[869.112067] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[869.236699] [010/134] (949s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[869.326575] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[869.329073] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[869.442550] [011/134] (949s left) gem_partial_pwrite_pread (reads-uncached)
[869.528524] Subtest reads-uncached: SKIP (0.000s)
[869.588387] [012/134] (949s left) api_intel_allocator (fork-simple-once)
[869.640077] Starting subtest: fork-simple-once
[869.660844] Subtest fork-simple-once: SUCCESS (0.020s)
[869.792812] [013/134] (949s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[869.842780] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[869.844067] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[869.976193] [014/134] (949s left) kms_atomic (plane-cursor-legacy)
[870.071084] Starting subtest: plane-cursor-legacy
[870.073232] Starting dynamic subtest: pipe-A-eDP-1
[870.461180] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.388s)
[870.462290] Subtest plane-cursor-legacy: SUCCESS (0.391s)
[871.343640] [015/134] (947s left) kms_psr (psr-primary-mmap-gtt)
[871.432813] Starting subtest: psr-primary-mmap-gtt
[871.434243] Starting dynamic subtest: eDP-1
[872.825565] Dynamic subtest eDP-1: SKIP (1.389s)
[872.828451] Subtest psr-primary-mmap-gtt: SKIP (1.391s)
[872.988541] [016/134] (946s left) gem_tiled_blits (interruptible)
[873.042863] Subtest interruptible: SKIP (0.000s)
[873.100120] [017/134] (946s left) gem_flink_basic (bad-open)
[873.161092] Starting subtest: bad-open
[873.162291] Subtest bad-open: SUCCESS (0.000s)
[873.279103] [018/134] (945s left) kms_cursor_crc (cursor-onscreen-256x256)
[873.508216] Starting subtest: cursor-onscreen-256x256
[873.511761] Starting dynamic subtest: pipe-A-eDP-1
[875.620296] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.108s)
[875.650038] Starting dynamic subtest: pipe-D-eDP-1
[878.374414] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.734s)
[878.375424] Subtest cursor-onscreen-256x256: SUCCESS (4.865s)
[879.249198] [019/134] (940s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[879.335218] Starting subtest: plane-downscale-factor-0-75-with-rotation
[879.336167] Starting dynamic subtest: pipe-A
[879.565060] Dynamic subtest pipe-A: SUCCESS (0.230s)
[879.574319] Starting dynamic subtest: pipe-B
[880.898697] Dynamic subtest pipe-B: SUCCESS (1.332s)
[880.908584] Starting dynamic subtest: pipe-C
[882.181836] Dynamic subtest pipe-C: SUCCESS (1.282s)
[882.191754] Starting dynamic subtest: pipe-D
[883.477101] Dynamic subtest pipe-D: SUCCESS (1.295s)
[883.478062] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.143s)
[884.634986] [020/134] (934s left) gem_pxp (display-protected-crc)
[884.745381] Starting subtest: display-protected-crc
[886.372187] Subtest display-protected-crc: SUCCESS (1.629s)
[886.542146] [021/134] (932s left) kms_plane_alpha_blend (coverage-7efc)
[886.636551] Starting subtest: coverage-7efc
[886.931559] Starting dynamic subtest: pipe-A-eDP-1
[887.482199] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.549s)
[887.516526] Starting dynamic subtest: pipe-D-eDP-1
[888.801797] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.302s)
[888.802834] Subtest coverage-7efc: SUCCESS (2.166s)
[889.639341] [022/134] (929s left) kms_chamelium_hpd (dp-hpd-storm)
[890.022332] Subtest dp-hpd-storm: SKIP (0.000s)
[890.812000] [023/134] (928s left) gem_eio (in-flight-10ms)
[891.038801] Starting subtest: in-flight-10ms
[899.866656] Subtest in-flight-10ms: SUCCESS (8.828s)
[900.057214] [024/134] (919s left) kms_frontbuffer_tracking (fbcpsr-abgr161616f-draw-mmap-gtt)
[900.154207] Starting subtest: fbcpsr-abgr161616f-draw-mmap-gtt
[900.155840] Subtest fbcpsr-abgr161616f-draw-mmap-gtt: SKIP (0.000s)
[900.272196] [025/134] (919s left) i915_selftest (perf)
[902.233236] Starting subtest: perf
[902.234688] Starting dynamic subtest: engine_cs
[907.992714] Dynamic subtest engine_cs: SUCCESS (5.759s)
[908.001966] Starting dynamic subtest: request
[914.700323] Dynamic subtest request: SUCCESS (6.705s)
[914.709013] Starting dynamic subtest: migrate
[919.002279] Dynamic subtest migrate: SUCCESS (4.299s)
[919.011671] Starting dynamic subtest: region
[926.364779] Dynamic subtest region: SUCCESS (7.361s)
[926.366542] Subtest perf: SUCCESS (24.132s)
[926.391202] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[926.391985] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[926.394431] [026/134] (893s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[929.290194] Starting subtest: async-flip-with-page-flip-events-tiled
[929.668485] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[932.488574] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.818s)
[932.500431] Starting dynamic subtest: pipe-A-eDP-1-4
[934.682124] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.194s)
[934.691660] Starting dynamic subtest: pipe-A-eDP-1-4
[936.694252] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[936.705847] Starting dynamic subtest: pipe-A-eDP-1-x
[938.885153] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.189s)
[939.261599] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[942.025117] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.769s)
[942.033686] Starting dynamic subtest: pipe-B-eDP-1-4
[944.223081] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.196s)
[944.234532] Starting dynamic subtest: pipe-B-eDP-1-4
[946.233078] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[946.244318] Starting dynamic subtest: pipe-B-eDP-1-x
[948.423741] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[948.786620] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[951.549306] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.768s)
[951.558002] Starting dynamic subtest: pipe-C-eDP-1-4
[953.757261] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.207s)
[953.766194] Starting dynamic subtest: pipe-C-eDP-1-4
[955.767768] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[955.775895] Starting dynamic subtest: pipe-C-eDP-1-x
[957.957823] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.188s)
[958.316768] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[961.078200] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.766s)
[961.089390] Starting dynamic subtest: pipe-D-eDP-1-4
[963.263776] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.185s)
[963.272562] Starting dynamic subtest: pipe-D-eDP-1-4
[965.274381] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[965.284240] Starting dynamic subtest: pipe-D-eDP-1-x
[967.476244] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.200s)
[967.477642] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.183s)
[968.673022] [FACT kms_async_flips (async-flip-with-page-flip-events-tiled)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[968.674289] [FACT kms_async_flips (async-flip-with-page-flip-events-tiled)] new: kernel.kmod_is_loaded.i915: true
[968.676989] [027/134] (850s left) gem_userptr_blits (access-control)
[968.754334] Starting subtest: access-control
[968.756901] Subtest access-control: SKIP (0.000s)
[968.895568] [028/134] (850s left) kms_plane (pixel-format-4-tiled-modifier)
[968.990257] Starting subtest: pixel-format-4-tiled-modifier
[969.019530] Starting dynamic subtest: pipe-A-plane-0
[969.707770] Dynamic subtest pipe-A-plane-0: SUCCESS (0.689s)
[969.718239] Starting dynamic subtest: pipe-A-plane-3
[970.196752] Dynamic subtest pipe-A-plane-3: SUCCESS (0.488s)
[970.205191] Starting dynamic subtest: pipe-A-plane-5
[970.207617] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[971.362380] Starting dynamic subtest: pipe-B-plane-0
[972.033546] Dynamic subtest pipe-B-plane-0: SUCCESS (0.678s)
[972.042209] Starting dynamic subtest: pipe-B-plane-3
[972.488344] Dynamic subtest pipe-B-plane-3: SUCCESS (0.455s)
[972.497175] Starting dynamic subtest: pipe-B-plane-5
[972.499616] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[972.797327] Subtest pixel-format-4-tiled-modifier: SUCCESS (3.806s)
[973.637120] [029/134] (846s left) gem_exec_reloc (basic-wc-noreloc)
[973.694543] Subtest basic-wc-noreloc: SKIP (0.000s)
[973.756130] [030/134] (845s left) kms_pm_lpsp (kms-lpsp)
[974.852082] Starting subtest: kms-lpsp
[974.853125] Starting dynamic subtest: pipe-A-eDP-1
[974.991252] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.140s)
[975.284967] Subtest kms-lpsp: SUCCESS (0.434s)
[976.160449] [031/134] (843s left) gem_mmap_wc (read)
[976.214345] Subtest read: SKIP (0.000s)
[976.270152] [032/134] (843s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[976.366831] Starting subtest: psr-farfromfence-mmap-gtt
[976.368771] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[976.486868] [033/134] (843s left) gen9_exec_parse (bb-oversize)
[976.537427] Subtest bb-oversize: SKIP (0.000s)
[976.613677] [034/134] (843s left) gem_exec_reloc (basic-concurrent0)
[976.667410] Subtest basic-concurrent0: SKIP (0.000s)
[976.731942] [035/134] (843s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[976.811344] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[983.487577] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.676s)
[983.662499] [036/134] (836s left) gem_workarounds (reset)
[983.734351] Starting subtest: reset
[983.919585] Subtest reset: SUCCESS (0.185s)
[984.075486] [037/134] (835s left) syncobj_wait (invalid-single-wait-unsubmitted)
[984.131667] Starting subtest: invalid-single-wait-unsubmitted
[984.133141] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[984.250530] [038/134] (835s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[984.347750] Starting subtest: 4-tiled-addfb-size-offset-overflow
[984.348845] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[984.457868] [039/134] (835s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[984.556603] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[984.558726] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[984.678354] [040/134] (835s left) kms_rmfb (rmfb-ioctl)
[984.769604] Starting subtest: rmfb-ioctl
[984.770616] Starting dynamic subtest: pipe-A-eDP-1
[984.875604] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s)
[984.885017] Starting dynamic subtest: pipe-B-eDP-1
[986.043084] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.166s)
[986.051975] Starting dynamic subtest: pipe-C-eDP-1
[987.166456] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.122s)
[987.184917] Starting dynamic subtest: pipe-D-eDP-1
[988.296489] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.129s)
[988.297639] Subtest rmfb-ioctl: SUCCESS (3.528s)
[989.510527] [041/134] (830s left) perf_pmu (busy-accuracy-2)
[989.574339] Starting subtest: busy-accuracy-2
[989.575281] Starting dynamic subtest: rcs0
[992.622623] Dynamic subtest rcs0: SUCCESS (3.046s)
[992.633044] Starting dynamic subtest: bcs0
[995.683585] Dynamic subtest bcs0: SUCCESS (3.058s)
[995.694067] Starting dynamic subtest: vcs0
[998.731779] Dynamic subtest vcs0: SUCCESS (3.046s)
[998.741733] Starting dynamic subtest: vcs1
[1001.781438] Dynamic subtest vcs1: SUCCESS (3.047s)
[1001.790729] Starting dynamic subtest: vecs0
[1004.828059] Dynamic subtest vecs0: SUCCESS (3.044s)
[1004.837390] Starting dynamic subtest: ccs0
[1007.886411] Dynamic subtest ccs0: SUCCESS (3.055s)
[1007.887528] Subtest busy-accuracy-2: SUCCESS (18.311s)
[1008.030098] [042/134] (812s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[1008.137646] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[1012.739531] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.602s)
[1013.919593] [043/134] (806s left) syncobj_wait (single-wait-for-submit-submitted)
[1013.983439] Starting subtest: single-wait-for-submit-submitted
[1014.091312] Subtest single-wait-for-submit-submitted: SUCCESS (0.107s)
[1014.173303] [044/134] (806s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[1014.282076] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[1014.283246] Starting dynamic subtest: pipe-A-eDP-1
[1014.294834] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[1014.303329] Starting dynamic subtest: pipe-B-eDP-1
[1014.313832] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[1014.322049] Starting dynamic subtest: pipe-C-eDP-1
[1014.331779] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[1014.340111] Starting dynamic subtest: pipe-D-eDP-1
[1014.349354] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[1014.351321] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[1016.580679] [045/134] (803s left) kms_content_protection (lic-type-1)
[1016.724239] Starting subtest: lic-type-1
[1016.726105] Subtest lic-type-1: SKIP (0.000s)
[1016.867274] [046/134] (803s left) kms_pm_rpm (modeset-non-lpsp)
[1018.898463] Starting subtest: modeset-non-lpsp
[1020.055397] Subtest modeset-non-lpsp: SKIP (1.159s)
[1020.439883] [047/134] (799s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[1020.534101] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[1020.535180] Starting dynamic subtest: pipe-A-default-mode
[1020.819173] Dynamic subtest pipe-A-default-mode: SKIP (0.284s)
[1020.821221] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.285s)
[1021.659828] [048/134] (798s left) kms_psr (psr2-sprite-mmap-gtt)
[1021.763870] Starting subtest: psr2-sprite-mmap-gtt
[1021.765232] Starting dynamic subtest: eDP-1
[1023.173331] Dynamic subtest eDP-1: SKIP (1.406s)
[1023.176199] Subtest psr2-sprite-mmap-gtt: SKIP (1.408s)
[1023.356973] [049/134] (797s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[1023.450655] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[1023.452841] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[1023.569361] [050/134] (796s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[1023.658243] Starting subtest: fbcpsr-rgb101010-draw-render
[1030.352165] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.696s)
[1030.481478] [051/134] (789s left) kms_feature_discovery (display-3x)
[1030.568092] Starting subtest: display-3x
[1030.569963] Subtest display-3x: SKIP (0.000s)
[1030.648528] [052/134] (789s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[1030.744318] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[1030.746434] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[1030.860210] [053/134] (789s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[1030.979434] Starting subtest: short-busy-flip-before-cursor-toggle
[1030.981890] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[1031.133869] [054/134] (789s left) kms_color (invalid-ctm-matrix-sizes)
[1031.228247] Starting subtest: invalid-ctm-matrix-sizes
[1031.229576] Starting dynamic subtest: pipe-A
[1031.230846] Dynamic subtest pipe-A: SUCCESS (0.002s)
[1031.245125] Starting dynamic subtest: pipe-B
[1031.246614] Dynamic subtest pipe-B: SUCCESS (0.003s)
[1031.256909] Starting dynamic subtest: pipe-C
[1031.258446] Dynamic subtest pipe-C: SUCCESS (0.003s)
[1031.266908] Starting dynamic subtest: pipe-D
[1031.268135] Dynamic subtest pipe-D: SUCCESS (0.004s)
[1031.269305] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.014s)
[1031.319464] [055/134] (789s left) gem_exec_balancer (sequential)
[1031.385151] Starting subtest: sequential
[1034.482761] Subtest sequential: SUCCESS (3.099s)
[1034.824650] [056/134] (785s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[1034.941841] Starting subtest: x-tiled-32bpp-rotate-0
[1036.355204] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.413s)
[1036.516505] [057/134] (784s left) gem_exec_whisper (basic-contexts-all)
[1036.586497] Starting subtest: basic-contexts-all
[1046.903498] Subtest basic-contexts-all: SUCCESS (10.313s)
[1047.093765] [058/134] (773s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[1047.153479] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[1047.156010] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[1047.346300] [059/134] (773s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[1047.444729] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[1054.414174] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (6.971s)
[1054.557937] [060/134] (766s left) kms_cursor_crc (cursor-sliding-64x21)
[1054.758188] Starting subtest: cursor-sliding-64x21
[1054.799613] Subtest cursor-sliding-64x21: SKIP (0.038s)
[1055.063314] [061/134] (765s left) kms_rotation_crc (cursor-rotation-180)
[1055.155716] Starting subtest: cursor-rotation-180
[1056.617896] Subtest cursor-rotation-180: SUCCESS (1.462s)
[1057.814229] [062/134] (762s left) kms_psr (fbc-pr-primary-mmap-gtt)
[1057.907596] Starting subtest: fbc-pr-primary-mmap-gtt
[1057.910395] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[1057.985076] [063/134] (762s left) syncobj_timeline (wait-any-complex)
[1058.036711] Starting subtest: wait-any-complex
[1058.099693] Subtest wait-any-complex: SUCCESS (0.063s)
[1058.186097] [064/134] (762s left) gem_exec_params (invalid-bsd2-flag-on-render)
[1058.242849] Starting subtest: invalid-bsd2-flag-on-render
[1058.244317] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[1058.365713] [065/134] (762s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[1058.460981] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[1058.463370] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[1058.560297] [066/134] (762s left) gem_exec_params (rel-constants-invalid-ring)
[1058.614832] Starting subtest: rel-constants-invalid-ring
[1058.616072] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[1058.739155] [067/134] (762s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[1058.859875] Starting subtest: cursor-vs-flip-atomic-transitions
[1088.743323] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (29.882s)
[1089.552967] [068/134] (731s left) syncobj_timeline (multi-wait-all-available-submitted)
[1089.607536] Starting subtest: multi-wait-all-available-submitted
[1089.608899] Subtest multi-wait-all-available-submitted: SUCCESS (0.000s)
[1089.716040] [069/134] (731s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[1089.811281] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[1089.813568] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[1089.938179] [070/134] (731s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[1090.020441] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[1090.022089] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[1090.132281] [071/134] (730s left) kms_flip (basic-flip-vs-modeset)
[1090.218073] Starting subtest: basic-flip-vs-modeset
[1090.220672] Starting dynamic subtest: A-eDP1
[1092.764061] Dynamic subtest A-eDP1: SUCCESS (2.543s)
[1092.773232] Starting dynamic subtest: B-eDP1
[1094.928089] Dynamic subtest B-eDP1: SUCCESS (2.164s)
[1094.937050] Starting dynamic subtest: C-eDP1
[1097.002571] Dynamic subtest C-eDP1: SUCCESS (2.072s)
[1097.011787] Starting dynamic subtest: D-eDP1
[1099.092145] Dynamic subtest D-eDP1: SUCCESS (2.089s)
[1099.093443] Subtest basic-flip-vs-modeset: SUCCESS (8.875s)
[1099.901206] [072/134] (721s left) i915_drm_fdinfo (memory-info-shared)
[1099.935297] Starting subtest: memory-info-shared
[1099.936377] Starting dynamic subtest: smem0
[1100.008084] Dynamic subtest smem0: SUCCESS (0.072s)
[1100.009473] Subtest memory-info-shared: SUCCESS (0.073s)
[1100.089890] [073/134] (721s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[1100.198279] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[1106.455674] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.258s)
[1107.593064] [074/134] (713s left) prime_vgem (fence-wait)
[1107.663533] Starting subtest: fence-wait
[1107.664817] Starting dynamic subtest: rcs0
[1108.719006] Dynamic subtest rcs0: SUCCESS (1.053s)
[1108.731162] Starting dynamic subtest: bcs0
[1109.776720] Dynamic subtest bcs0: SUCCESS (1.056s)
[1109.787969] Starting dynamic subtest: vcs0
[1110.828544] Dynamic subtest vcs0: SUCCESS (1.050s)
[1110.838766] Starting dynamic subtest: vcs1
[1111.869152] Dynamic subtest vcs1: SUCCESS (1.040s)
[1111.881115] Starting dynamic subtest: vecs0
[1113.658477] Dynamic subtest vecs0: SUCCESS (1.787s)
[1113.670766] Starting dynamic subtest: ccs0
[1114.702318] Dynamic subtest ccs0: SUCCESS (1.042s)
[1114.704128] Subtest fence-wait: SUCCESS (7.037s)
[1114.849408] [075/134] (706s left) gem_mmap_gtt (medium-copy)
[1114.907390] Subtest medium-copy: SKIP (0.000s)
[1114.974962] [076/134] (706s left) gem_exec_whisper (basic-sync)
[1115.043862] Starting subtest: basic-sync
[1127.958712] Subtest basic-sync: SUCCESS (12.912s)
[1128.151628] [077/134] (693s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[1128.249487] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[1135.640057] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.391s)
[1135.775449] [078/134] (685s left) gem_spin_batch (resubmit-new)
[1135.829595] Starting subtest: resubmit-new
[1135.831130] Starting dynamic subtest: rcs0
[1135.838650] Dynamic subtest rcs0: SUCCESS (0.009s)
[1135.848353] Starting dynamic subtest: bcs0
[1135.849624] Dynamic subtest bcs0: SUCCESS (0.004s)
[1135.858604] Starting dynamic subtest: vcs0
[1135.859843] Dynamic subtest vcs0: SUCCESS (0.004s)
[1135.868413] Starting dynamic subtest: vcs1
[1135.869579] Dynamic subtest vcs1: SUCCESS (0.005s)
[1135.877885] Starting dynamic subtest: vecs0
[1135.879196] Dynamic subtest vecs0: SUCCESS (0.004s)
[1135.887861] Starting dynamic subtest: ccs0
[1135.889102] Dynamic subtest ccs0: SUCCESS (0.005s)
[1135.890157] Subtest resubmit-new: SUCCESS (0.035s)
[1137.716124] [079/134] (683s left) kms_pm_backlight (basic-brightness)
[1137.807539] Starting subtest: basic-brightness
[1137.860138] Starting dynamic subtest: eDP-1
[1138.367340] Dynamic subtest eDP-1: SUCCESS (0.506s)
[1138.368840] Subtest basic-brightness: SUCCESS (0.559s)
[1139.228110] [080/134] (682s left) gem_ctx_exec (basic)
[1139.286656] Starting subtest: basic
[1139.291250] Subtest basic: SUCCESS (0.007s)
[1139.453171] [081/134] (682s left) perf (disabled-read-error)
[1139.586323] Starting subtest: disabled-read-error
[1139.604222] Subtest disabled-read-error: SUCCESS (0.018s)
[1139.663740] [082/134] (681s left) gem_pxp (verify-pxp-stale-ctx-execution)
[1139.777615] Starting subtest: verify-pxp-stale-ctx-execution
[1140.835522] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.058s)
[1140.975082] [083/134] (680s left) kms_cursor_crc (cursor-sliding-128x128)
[1141.196669] Starting subtest: cursor-sliding-128x128
[1141.200254] Starting dynamic subtest: pipe-A-eDP-1
[1144.447101] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.246s)
[1144.479539] Starting dynamic subtest: pipe-D-eDP-1
[1148.348624] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.882s)
[1148.349624] Subtest cursor-sliding-128x128: SUCCESS (7.151s)
[1149.208334] [084/134] (672s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[1149.307145] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[1149.307948] Starting dynamic subtest: pipe-A-default-mode
[1149.598409] Dynamic subtest pipe-A-default-mode: SKIP (0.289s)
[1149.599997] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.291s)
[1150.431446] [085/134] (671s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[1150.524624] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[1150.526259] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[1150.639657] [086/134] (671s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[1150.699708] Starting subtest: invalid-single-wait-all-unsubmitted
[1150.700756] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[1150.831113] [087/134] (670s left) kms_vblank (query-forked)
[1150.923315] Starting subtest: query-forked
[1150.924201] Starting dynamic subtest: pipe-A-eDP-1
[1152.735336] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.811s)
[1152.747847] Starting dynamic subtest: pipe-D-eDP-1
[1155.230554] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.492s)
[1155.232072] Subtest query-forked: SUCCESS (4.307s)
[1156.089760] [088/134] (665s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[1156.196980] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[1156.198132] Starting dynamic subtest: pipe-A-eDP-1
[1156.208992] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[1156.223284] Starting dynamic subtest: pipe-B-eDP-1
[1156.234469] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[1156.243772] Starting dynamic subtest: pipe-C-eDP-1
[1156.253453] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[1156.262733] Starting dynamic subtest: pipe-D-eDP-1
[1156.272774] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[1156.274620] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.006s)
[1158.359636] [089/134] (663s left) kms_flip (plain-flip-fb-recreate)
[1158.454062] Starting subtest: plain-flip-fb-recreate
[1158.455151] Starting dynamic subtest: A-eDP1
[1167.347710] Dynamic subtest A-eDP1: SUCCESS (8.893s)
[1167.358580] Starting dynamic subtest: B-eDP1
[1176.173221] Dynamic subtest B-eDP1: SUCCESS (8.824s)
[1176.187860] Starting dynamic subtest: C-eDP1
[1184.994416] Dynamic subtest C-eDP1: SUCCESS (8.820s)
[1185.004376] Starting dynamic subtest: D-eDP1
[1193.832386] Dynamic subtest D-eDP1: SUCCESS (8.837s)
[1193.835178] Subtest plain-flip-fb-recreate: SUCCESS (35.382s)
[1195.025271] [090/134] (626s left) kms_psr (pr-cursor-plane-move)
[1195.124960] Starting subtest: pr-cursor-plane-move
[1195.127262] Subtest pr-cursor-plane-move: SKIP (0.000s)
[1195.205984] [091/134] (626s left) gem_exec_schedule (preempt-other-chain)
[1195.272488] Starting subtest: preempt-other-chain
[1195.273537] Starting dynamic subtest: rcs0
[1195.369817] Dynamic subtest rcs0: SUCCESS (0.096s)
[1195.381226] Starting dynamic subtest: bcs0
[1195.452714] Dynamic subtest bcs0: SUCCESS (0.082s)
[1195.465151] Starting dynamic subtest: vcs0
[1195.536515] Dynamic subtest vcs0: SUCCESS (0.083s)
[1195.547553] Starting dynamic subtest: vcs1
[1195.618340] Dynamic subtest vcs1: SUCCESS (0.081s)
[1195.629348] Starting dynamic subtest: vecs0
[1195.699823] Dynamic subtest vecs0: SUCCESS (0.081s)
[1195.711102] Starting dynamic subtest: ccs0
[1195.780906] Dynamic subtest ccs0: SUCCESS (0.080s)
[1195.782315] Subtest preempt-other-chain: SUCCESS (0.508s)
[1196.795764] [092/134] (625s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[1196.882743] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[1196.885282] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[1198.041479] [093/134] (623s left) gem_flink_basic (basic)
[1198.089368] Starting subtest: basic
[1198.090511] Subtest basic: SUCCESS (0.000s)
[1198.194165] [094/134] (623s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[1198.291486] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[1198.293882] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[1198.409550] [095/134] (623s left) kms_vblank (wait-forked-busy)
[1198.495080] Starting subtest: wait-forked-busy
[1198.496170] Starting dynamic subtest: pipe-A-eDP-1
[1200.381112] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.886s)
[1200.393067] Starting dynamic subtest: pipe-D-eDP-1
[1202.912839] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.529s)
[1202.914607] Subtest wait-forked-busy: SUCCESS (4.419s)
[1203.717908] [096/134] (618s left) core_getversion (basic)
[1203.756834] Starting subtest: basic
[1203.759620] Subtest basic: SUCCESS (0.000s)
[1203.838582] [097/134] (618s left) kms_big_fb (linear-32bpp-rotate-0)
[1203.952992] Starting subtest: linear-32bpp-rotate-0
[1205.468482] Subtest linear-32bpp-rotate-0: SUCCESS (1.516s)
[1205.620887] [098/134] (616s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[1205.725071] Starting subtest: yf-tiled-32bpp-rotate-270
[1205.727118] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[1205.842347] [099/134] (616s left) kms_flip_scaled_crc (flip-nv12-linear-to-nv12-linear-reflect-x)
[1205.939727] Starting subtest: flip-NV12-linear-to-NV12-linear-reflect-x
[1205.941270] Starting dynamic subtest: pipe-A-default-mode
[1207.077588] Dynamic subtest pipe-A-default-mode: SKIP (1.135s)
[1207.084971] Subtest flip-NV12-linear-to-NV12-linear-reflect-x: SKIP (1.137s)
[1207.255196] [100/134] (614s left) kms_addfb_basic (invalid-get-prop)
[1207.321089] Starting subtest: invalid-get-prop
[1207.322210] Subtest invalid-get-prop: SUCCESS (0.000s)
[1207.474926] [101/134] (614s left) gem_mmap_offset (partial-unmap)
[1207.519657] Starting subtest: partial-unmap
[1207.520701] Starting dynamic subtest: smem0
[1208.026727] Dynamic subtest smem0: SUCCESS (0.506s)
[1208.028191] Subtest partial-unmap: SUCCESS (0.507s)
[1208.160847] [102/134] (614s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[1208.250249] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[1208.252062] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[1208.375818] [103/134] (613s left) gem_mmap_gtt (basic)
[1208.426257] Subtest basic: SKIP (0.000s)
[1208.503384] [104/134] (613s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[1208.548157] Starting subtest: etime-multi-wait-all-available-unsubmitted
[1208.649872] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.102s)
[1208.736999] [105/134] (613s left) gem_busy (busy)
[1208.798599] Starting subtest: busy
[1208.800403] Starting dynamic subtest: all-engines
[1208.862692] Dynamic subtest all-engines: SUCCESS (0.064s)
[1208.872301] Starting dynamic subtest: rcs0
[1210.636822] Dynamic subtest rcs0: SUCCESS (1.773s)
[1210.646904] Starting dynamic subtest: bcs0
[1210.701871] Dynamic subtest bcs0: SUCCESS (0.063s)
[1210.711773] Starting dynamic subtest: vcs0
[1210.741515] Dynamic subtest vcs0: SUCCESS (0.039s)
[1210.750727] Starting dynamic subtest: vcs1
[1212.683303] Dynamic subtest vcs1: SUCCESS (1.939s)
[1212.693293] Starting dynamic subtest: vecs0
[1214.667714] Dynamic subtest vecs0: SUCCESS (1.982s)
[1214.676865] Starting dynamic subtest: ccs0
[1216.715309] Dynamic subtest ccs0: SUCCESS (2.047s)
[1216.716830] Subtest busy: SUCCESS (7.916s)
[1217.101867] [106/134] (605s left) kms_invalid_mode (bad-hsync-start)
[1217.203503] Starting subtest: bad-hsync-start
[1217.204785] Starting dynamic subtest: pipe-A-eDP-1
[1217.486594] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s)
[1217.503667] Starting dynamic subtest: pipe-B-eDP-1
[1217.505376] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[1217.520403] Starting dynamic subtest: pipe-C-eDP-1
[1217.521834] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[1217.536605] Starting dynamic subtest: pipe-D-eDP-1
[1217.538133] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[1217.539570] Subtest bad-hsync-start: SUCCESS (0.289s)
[1218.384619] [107/134] (604s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[1218.469306] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[1218.497878] Starting dynamic subtest: pipe-A-plane-0
[1218.500357] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[1218.509875] Starting dynamic subtest: pipe-A-plane-3
[1218.512313] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[1218.520991] Starting dynamic subtest: pipe-A-plane-5
[1218.522775] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[1219.572222] Starting dynamic subtest: pipe-B-plane-0
[1219.574484] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[1219.583482] Starting dynamic subtest: pipe-B-plane-3
[1219.585847] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[1219.594749] Starting dynamic subtest: pipe-B-plane-5
[1219.597178] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[1219.872079] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (1.401s)
[1220.751279] [108/134] (601s left) gem_exec_create (basic)
[1220.812501] Starting subtest: basic
[1220.813892] Starting dynamic subtest: smem
[1224.648325] Dynamic subtest smem: SUCCESS (3.833s)
[1224.649882] Subtest basic: SUCCESS (3.835s)
[1224.839040] [109/134] (597s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[1224.943954] Starting subtest: y-tiled-64bpp-rotate-90
[1224.946233] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[1225.049978] [110/134] (597s left) gem_ctx_persistence (engines-mixed-process)
[1225.110369] Starting subtest: engines-mixed-process
[1225.111750] Starting dynamic subtest: rcs0
[1226.718136] Dynamic subtest rcs0: SUCCESS (1.609s)
[1226.729271] Starting dynamic subtest: bcs0
[1228.709138] Dynamic subtest bcs0: SUCCESS (1.989s)
[1228.720749] Starting dynamic subtest: vcs0
[1230.687822] Dynamic subtest vcs0: SUCCESS (1.977s)
[1230.700658] Starting dynamic subtest: vcs1
[1232.722703] Dynamic subtest vcs1: SUCCESS (2.033s)
[1232.734149] Starting dynamic subtest: vecs0
[1234.677563] Dynamic subtest vecs0: SUCCESS (1.952s)
[1234.687520] Starting dynamic subtest: ccs0
[1236.705872] Dynamic subtest ccs0: SUCCESS (2.028s)
[1236.707548] Subtest engines-mixed-process: SUCCESS (11.598s)
[1236.791818] [111/134] (585s left) perf_pmu (idle-no-semaphores)
[1236.829145] Starting subtest: idle-no-semaphores
[1236.830280] Starting dynamic subtest: rcs0
[1237.398871] Dynamic subtest rcs0: SUCCESS (0.567s)
[1237.411137] Starting dynamic subtest: bcs0
[1237.929612] Dynamic subtest bcs0: SUCCESS (0.528s)
[1237.940729] Starting dynamic subtest: vcs0
[1238.460651] Dynamic subtest vcs0: SUCCESS (0.528s)
[1238.471862] Starting dynamic subtest: vcs1
[1238.988785] Dynamic subtest vcs1: SUCCESS (0.525s)
[1239.001301] Starting dynamic subtest: vecs0
[1239.518684] Dynamic subtest vecs0: SUCCESS (0.527s)
[1239.529705] Starting dynamic subtest: ccs0
[1240.050921] Dynamic subtest ccs0: SUCCESS (0.529s)
[1240.052613] Subtest idle-no-semaphores: SUCCESS (3.221s)
[1240.171811] [112/134] (582s left) gem_ctx_engines (execute-oneforall)
[1240.228136] Starting subtest: execute-oneforall
[1241.937514] Subtest execute-oneforall: SUCCESS (1.707s)
[1242.817186] [113/134] (579s left) kms_properties (plane-properties-legacy)
[1242.913437] Starting subtest: plane-properties-legacy
[1242.914447] Starting dynamic subtest: pipe-A-eDP-1
[1243.471820] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.558s)
[1243.481268] Starting dynamic subtest: pipe-B-eDP-1
[1244.724474] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.251s)
[1244.737200] Starting dynamic subtest: pipe-C-eDP-1
[1245.966713] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.241s)
[1245.977356] Starting dynamic subtest: pipe-D-eDP-1
[1247.202233] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.235s)
[1247.203399] Subtest plane-properties-legacy: SUCCESS (4.290s)
[1248.027131] [114/134] (574s left) gem_ctx_persistence (heartbeat-many)
[1248.102516] Starting subtest: heartbeat-many
[1248.105241] Subtest heartbeat-many: SKIP (0.000s)
[1248.239723] [115/134] (574s left) gem_exec_fence (nb-await)
[1248.418741] Starting subtest: nb-await
[1248.420522] Starting dynamic subtest: rcs0
[1248.491498] Dynamic subtest rcs0: SUCCESS (0.072s)
[1248.503701] Starting dynamic subtest: bcs0
[1248.550034] Dynamic subtest bcs0: SUCCESS (0.058s)
[1248.563287] Starting dynamic subtest: vcs0
[1248.610473] Dynamic subtest vcs0: SUCCESS (0.058s)
[1248.622840] Starting dynamic subtest: vcs1
[1248.670454] Dynamic subtest vcs1: SUCCESS (0.058s)
[1248.684131] Starting dynamic subtest: vecs0
[1248.731066] Dynamic subtest vecs0: SUCCESS (0.059s)
[1248.741837] Starting dynamic subtest: ccs0
[1248.789635] Dynamic subtest ccs0: SUCCESS (0.057s)
[1248.791286] Subtest nb-await: SUCCESS (0.372s)
[1250.718720] [116/134] (572s left) gem_exec_flush (basic-uc-rw-default)
[1250.791029] Starting subtest: basic-uc-rw-default
[1256.251242] Subtest basic-uc-rw-default: SUCCESS (5.460s)
[1256.483388] [117/134] (566s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[1256.553238] Starting subtest: map-fixed-invalidate-overlap
[1256.555406] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[1256.723631] [118/134] (566s left) kms_lease (lease-invalid-plane)
[1256.831111] Starting subtest: lease-invalid-plane
[1256.832508] Starting dynamic subtest: pipe-A-eDP-1
[1256.833803] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[1256.853814] Starting dynamic subtest: pipe-B-eDP-1
[1256.855307] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[1256.875548] Starting dynamic subtest: pipe-C-eDP-1
[1256.877175] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[1256.897459] Starting dynamic subtest: pipe-D-eDP-1
[1256.899232] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[1256.900694] Subtest lease-invalid-plane: SUCCESS (0.005s)
[1257.005448] [119/134] (565s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[1262.072819] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[1262.077344] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.002s)
[1262.916904] [120/134] (560s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[1263.017455] Starting subtest: random-ccs-data-y-tiled-ccs
[1263.018603] Starting dynamic subtest: pipe-A-eDP-1
[1263.029002] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[1263.038687] Starting dynamic subtest: pipe-B-eDP-1
[1263.050082] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[1263.059468] Starting dynamic subtest: pipe-C-eDP-1
[1263.076628] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[1263.085474] Starting dynamic subtest: pipe-D-eDP-1
[1263.096354] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[1263.098280] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.004s)
[1265.196580] [121/134] (557s left) gem_exec_balancer (full-late)
[1265.267079] Starting subtest: full-late
[1269.577711] Subtest full-late: SUCCESS (4.311s)
[1269.927375] [122/134] (553s left) api_intel_bb (intel-bb-blit-y)
[1269.980945] Starting subtest: intel-bb-blit-y
[1273.780476] Subtest intel-bb-blit-y: SUCCESS (3.798s)
[1273.917618] [123/134] (549s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[1274.003211] Starting subtest: primary-yf-tiled-reflect-x-180
[1274.062875] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.059s)
[1274.170679] [124/134] (548s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[1274.291748] Starting subtest: 2x-long-cursor-vs-flip-legacy
[1274.294977] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.001s)
[1274.443298] [125/134] (548s left) kms_psr (fbc-psr2-suspend)
[1274.544609] Starting subtest: fbc-psr2-suspend
[1274.545652] Starting dynamic subtest: eDP-1
[1274.548164] Dynamic subtest eDP-1: SKIP (0.000s)
[1274.550472] Subtest fbc-psr2-suspend: SKIP (0.001s)
[1274.597706] [126/134] (548s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[1274.692778] Starting subtest: fbc-psr2-sprite-plane-onoff
[1274.693735] Starting dynamic subtest: eDP-1
[1274.695393] Dynamic subtest eDP-1: SKIP (0.000s)
[1274.696949] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[1274.775846] [127/134] (548s left) i915_pm_rps (min-max-config-idle)
[1274.831844] Starting subtest: min-max-config-idle
[1274.834485] Subtest min-max-config-idle: SKIP (0.001s)
[1274.934044] [128/134] (548s left) sysfs_preempt_timeout (invalid)
[1274.980385] Starting subtest: invalid
[1274.981498] Starting dynamic subtest: vecs0
[1274.982570] Dynamic subtest vecs0: SUCCESS (0.000s)
[1274.992077] Starting dynamic subtest: ccs0
[1274.993446] Dynamic subtest ccs0: SUCCESS (0.000s)
[1275.002331] Starting dynamic subtest: vcs0
[1275.003458] Dynamic subtest vcs0: SUCCESS (0.000s)
[1275.012416] Starting dynamic subtest: bcs0
[1275.013701] Dynamic subtest bcs0: SUCCESS (0.000s)
[1275.022425] Starting dynamic subtest: rcs0
[1275.023726] Dynamic subtest rcs0: SUCCESS (0.000s)
[1275.032629] Starting dynamic subtest: vcs1
[1275.033609] Dynamic subtest vcs1: SUCCESS (0.000s)
[1275.034680] Subtest invalid: SUCCESS (0.005s)
[1275.124201] [129/134] (548s left) gem_eio (create)
[1275.346210] Starting subtest: create
[1275.674816] Subtest create: SUCCESS (0.329s)
[1275.799539] [130/134] (547s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[1275.851510] Starting subtest: etime-multi-wait-for-submit-submitted
[1275.953718] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.102s)
[1276.036821] [131/134] (547s left) gem_mmap_gtt (cpuset-big-copy-xy)
[1276.092382] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[1276.162729] [132/134] (547s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[1276.259663] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[1283.264253] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (7.002s)
[1283.417434] [133/134] (540s left) gem_exec_schedule (u-fairslice-all)
[1283.474821] Starting subtest: u-fairslice-all
[1285.541158] Subtest u-fairslice-all: SUCCESS (2.067s)
[1285.836273] [134/134] (537s left) gem_vm_create (execbuf)
[1285.901335] Starting subtest: execbuf
[1285.918013] Subtest execbuf: SUCCESS (0.016s)
[1286.046519] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_chamelium_frames
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: kms_prop_blob
results: parsing output: 4/ for test: syncobj_wait
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: i915_module_load
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gem_partial_pwrite_pread
results: parsing output: 11/ for test: api_intel_allocator
results: parsing output: 12/ for test: syncobj_wait
results: parsing output: 13/ for test: kms_atomic
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: gem_tiled_blits
results: parsing output: 16/ for test: gem_flink_basic
results: parsing output: 17/ for test: kms_cursor_crc
results: parsing output: 18/ for test: kms_plane_scaling
results: parsing output: 19/ for test: gem_pxp
results: parsing output: 20/ for test: kms_plane_alpha_blend
results: parsing output: 21/ for test: kms_chamelium_hpd
results: parsing output: 22/ for test: gem_eio
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: i915_selftest
results: parsing output: 25/ for test: kms_async_flips
results: parsing output: 26/ for test: gem_userptr_blits
results: parsing output: 27/ for test: kms_plane
results: parsing output: 28/ for test: gem_exec_reloc
results: parsing output: 29/ for test: kms_pm_lpsp
results: parsing output: 30/ for test: gem_mmap_wc
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gen9_exec_parse
results: parsing output: 33/ for test: gem_exec_reloc
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_workarounds
results: parsing output: 36/ for test: syncobj_wait
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_rmfb
results: parsing output: 40/ for test: perf_pmu
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: syncobj_wait
results: parsing output: 43/ for test: kms_ccs
results: parsing output: 44/ for test: kms_content_protection
results: parsing output: 45/ for test: kms_pm_rpm
results: parsing output: 46/ for test: kms_flip_scaled_crc
results: parsing output: 47/ for test: kms_psr
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_feature_discovery
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_cursor_legacy
results: parsing output: 53/ for test: kms_color
results: parsing output: 54/ for test: gem_exec_balancer
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: gem_exec_whisper
results: parsing output: 57/ for test: gem_render_copy
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_cursor_crc
results: parsing output: 60/ for test: kms_rotation_crc
results: parsing output: 61/ for test: kms_psr
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: gem_exec_params
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: gem_exec_params
results: parsing output: 66/ for test: kms_cursor_legacy
results: parsing output: 67/ for test: syncobj_timeline
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_flip
results: parsing output: 71/ for test: i915_drm_fdinfo
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: prime_vgem
results: parsing output: 74/ for test: gem_mmap_gtt
results: parsing output: 75/ for test: gem_exec_whisper
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gem_spin_batch
results: parsing output: 78/ for test: kms_pm_backlight
results: parsing output: 79/ for test: gem_ctx_exec
results: parsing output: 80/ for test: perf
results: parsing output: 81/ for test: gem_pxp
results: parsing output: 82/ for test: kms_cursor_crc
results: parsing output: 83/ for test: kms_flip_scaled_crc
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: syncobj_wait
results: parsing output: 86/ for test: kms_vblank
results: parsing output: 87/ for test: kms_ccs
results: parsing output: 88/ for test: kms_flip
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: gem_exec_schedule
results: parsing output: 91/ for test: kms_ccs
results: parsing output: 92/ for test: gem_flink_basic
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_vblank
results: parsing output: 95/ for test: core_getversion
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: kms_flip_scaled_crc
results: parsing output: 99/ for test: kms_addfb_basic
results: parsing output: 100/ for test: gem_mmap_offset
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_mmap_gtt
results: parsing output: 103/ for test: syncobj_timeline
results: parsing output: 104/ for test: gem_busy
results: parsing output: 105/ for test: kms_invalid_mode
results: parsing output: 106/ for test: kms_plane
results: parsing output: 107/ for test: gem_exec_create
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: gem_ctx_persistence
results: parsing output: 110/ for test: perf_pmu
results: parsing output: 111/ for test: gem_ctx_engines
results: parsing output: 112/ for test: kms_properties
results: parsing output: 113/ for test: gem_ctx_persistence
results: parsing output: 114/ for test: gem_exec_fence
results: parsing output: 115/ for test: gem_exec_flush
results: parsing output: 116/ for test: gem_userptr_blits
results: parsing output: 117/ for test: kms_lease
results: parsing output: 118/ for test: kms_psr2_sf
results: parsing output: 119/ for test: kms_ccs
results: parsing output: 120/ for test: gem_exec_balancer
results: parsing output: 121/ for test: api_intel_bb
results: parsing output: 122/ for test: kms_rotation_crc
results: parsing output: 123/ for test: kms_cursor_legacy
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: i915_pm_rps
results: parsing output: 127/ for test: sysfs_preempt_timeout
results: parsing output: 128/ for test: gem_eio
results: parsing output: 129/ for test: syncobj_timeline
results: parsing output: 130/ for test: gem_mmap_gtt
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: gem_exec_schedule
results: parsing output: 133/ for test: gem_vm_create
Done.