[56.917097] Initializing watchdogs
[56.917143]   /dev/watchdog0
[56.931385] [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]
[56.935692] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.937864] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.941130] [001/130] (960s left) i915_hangman (detector)
[57.031188] Starting subtest: detector
[57.033506] Starting dynamic subtest: rcs0
[68.851918] Dynamic subtest rcs0: SUCCESS (11.746s)
[68.861961] Starting dynamic subtest: bcs0
[80.884718] Dynamic subtest bcs0: SUCCESS (12.016s)
[80.892790] Starting dynamic subtest: vcs0
[92.850231] Dynamic subtest vcs0: SUCCESS (11.960s)
[92.860114] Starting dynamic subtest: vcs1
[104.818410] Dynamic subtest vcs1: SUCCESS (11.965s)
[104.828369] Starting dynamic subtest: vecs0
[115.825713] Dynamic subtest vecs0: SUCCESS (11.005s)
[115.834204] Starting dynamic subtest: ccs0
[127.857761] Dynamic subtest ccs0: SUCCESS (12.031s)
[127.860689] Subtest detector: SUCCESS (70.727s)
[127.934975] [002/130] (889s left) gem_exec_balancer (bonded-sync)
[128.005522] Starting subtest: bonded-sync
[128.010273] Subtest bonded-sync: SKIP (0.000s)
[128.302533] [003/130] (889s left) kms_sequence (get-forked)
[128.404038] Starting subtest: get-forked
[128.406315] Starting dynamic subtest: pipe-A-eDP-1
[130.312456] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.906s)
[130.320300] Starting dynamic subtest: pipe-B-eDP-1
[132.796478] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.482s)
[132.804382] Starting dynamic subtest: pipe-C-eDP-1
[135.346804] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.552s)
[135.353559] Starting dynamic subtest: pipe-D-eDP-1
[137.843644] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.495s)
[137.845832] Subtest get-forked: SUCCESS (9.437s)
[138.674782] [004/130] (878s left) gem_busy (parallel)
[138.862075] Starting subtest: parallel
[138.864535] Starting dynamic subtest: rcs0
[140.884802] Dynamic subtest rcs0: SUCCESS (2.021s)
[140.894538] Starting dynamic subtest: bcs0
[142.931900] Dynamic subtest bcs0: SUCCESS (2.046s)
[142.941929] Starting dynamic subtest: vcs0
[144.914329] Dynamic subtest vcs0: SUCCESS (1.982s)
[144.923787] Starting dynamic subtest: vcs1
[146.898296] Dynamic subtest vcs1: SUCCESS (1.983s)
[146.908414] Starting dynamic subtest: vecs0
[148.884624] Dynamic subtest vecs0: SUCCESS (1.985s)
[148.894962] Starting dynamic subtest: ccs0
[150.930959] Dynamic subtest ccs0: SUCCESS (2.047s)
[150.933858] Subtest parallel: SUCCESS (12.068s)
[151.198822] [005/130] (866s left) kms_atomic_interruptible (legacy-dpms)
[151.294941] Starting subtest: legacy-dpms
[151.297322] Starting dynamic subtest: pipe-A-eDP-1
[158.690785] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.395s)
[158.693137] Subtest legacy-dpms: SUCCESS (7.396s)
[159.523955] [006/130] (858s left) core_auth (many-magics)
[159.585686] Starting subtest: many-magics
[160.532043] Subtest many-magics: SUCCESS (0.947s)
[160.652101] [007/130] (857s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[160.743749] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[160.745757] Starting dynamic subtest: pipe-A-default-mode
[161.035551] Dynamic subtest pipe-A-default-mode: SKIP (0.285s)
[161.040737] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.286s)
[161.845408] [008/130] (855s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[162.406035] Starting subtest: syncobj-timeline-invalid-wait
[162.408813] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.003s)
[164.030211] [FACT gem_exec_fence (syncobj-timeline-invalid-wait)] new: kernel.kmod_is_loaded.vgem: true
[164.033729] [009/130] (853s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[164.119934] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[164.122533] Starting dynamic subtest: pipe-A-eDP-1
[164.142991] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[164.152393] Starting dynamic subtest: pipe-B-eDP-1
[164.171598] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[164.178327] Starting dynamic subtest: pipe-C-eDP-1
[164.197389] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[164.204644] Starting dynamic subtest: pipe-D-eDP-1
[164.224451] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[164.226721] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.003s)
[166.300606] [010/130] (851s left) syncobj_timeline (invalid-wait-illegal-handle)
[166.358021] Starting subtest: invalid-wait-illegal-handle
[166.359983] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[166.466972] [011/130] (851s left) syncobj_timeline (signal)
[166.523081] Starting subtest: signal
[166.525502] Subtest signal: SUCCESS (0.000s)
[166.611183] [012/130] (851s left) api_intel_allocator (execbuf-with-allocator)
[166.660802] Starting subtest: execbuf-with-allocator
[166.666626] Subtest execbuf-with-allocator: SUCCESS (0.008s)
[166.811570] [013/130] (851s left) gem_userptr_blits (access-control)
[166.887771] Starting subtest: access-control
[166.892514] Subtest access-control: SKIP (0.000s)
[167.018922] [014/130] (850s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[167.115141] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[167.119872] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[167.222816] [015/130] (850s left) kms_flip_tiling (flip-change-tiling)
[167.308500] Starting subtest: flip-change-tiling
[167.310489] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs
[167.521200] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.212s)
[167.530465] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs
[167.709521] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.186s)
[167.717138] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[167.896951] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.187s)
[167.906062] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4
[168.068410] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.172s)
[168.078920] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x
[168.251415] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.183s)
[168.262081] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear
[168.423451] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.172s)
[168.433190] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs
[168.610437] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.186s)
[168.620712] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs
[168.761548] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.149s)
[168.771649] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[168.933821] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.172s)
[168.943848] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4
[169.124732] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.191s)
[169.136295] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x
[169.294958] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.172s)
[169.304980] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear
[169.466567] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.172s)
[169.476575] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[169.653973] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.186s)
[169.664262] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[169.810940] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.155s)
[169.820575] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[169.943041] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.133s)
[169.953073] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4
[170.115483] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.172s)
[170.129270] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x
[170.311979] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.197s)
[170.323314] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear
[170.483913] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.172s)
[170.492279] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs
[170.656425] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.172s)
[170.666213] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs
[170.829545] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.173s)
[170.839505] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc
[171.002947] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.173s)
[171.012593] Starting dynamic subtest: pipe-A-eDP-1-4-to-4
[171.157287] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.154s)
[171.166760] Starting dynamic subtest: pipe-A-eDP-1-4-to-x
[171.332247] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.174s)
[171.342583] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear
[171.505187] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.173s)
[171.514902] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs
[171.677523] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.172s)
[171.687651] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs
[171.849527] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.172s)
[171.860331] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc
[172.021519] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.172s)
[172.031209] Starting dynamic subtest: pipe-A-eDP-1-x-to-4
[172.198488] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.177s)
[172.208263] Starting dynamic subtest: pipe-A-eDP-1-x-to-x
[172.355277] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.156s)
[172.364948] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear
[172.529820] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.174s)
[172.542552] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs
[172.701520] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.172s)
[172.711272] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs
[172.873478] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.172s)
[172.883626] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc
[173.057041] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.183s)
[173.066505] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4
[173.234562] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.177s)
[173.247062] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x
[173.417454] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.182s)
[173.428196] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear
[173.578776] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.161s)
[173.629323] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs
[174.872220] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.248s)
[174.882744] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs
[175.045067] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.171s)
[175.055518] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[175.230252] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.185s)
[175.240513] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4
[175.401451] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.172s)
[175.411810] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x
[175.572638] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.172s)
[175.582925] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear
[175.744797] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.171s)
[175.754459] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs
[175.917456] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.172s)
[175.930865] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs
[176.068672] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.150s)
[176.078733] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[176.223851] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.155s)
[176.234083] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4
[176.395071] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.172s)
[176.405893] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x
[176.578973] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.184s)
[176.587061] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear
[176.750772] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.172s)
[176.759446] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[176.942181] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.190s)
[176.952794] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[177.114849] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.170s)
[177.125114] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[177.247440] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.133s)
[177.258217] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4
[177.419075] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.172s)
[177.429200] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x
[177.590429] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.172s)
[177.600631] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear
[177.764710] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.172s)
[177.781342] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs
[177.934811] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.172s)
[177.944726] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs
[178.107265] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.172s)
[178.117638] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc
[178.278773] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.172s)
[178.289675] Starting dynamic subtest: pipe-B-eDP-1-4-to-4
[178.434331] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.155s)
[178.444585] Starting dynamic subtest: pipe-B-eDP-1-4-to-x
[178.638603] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.205s)
[178.648404] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear
[178.821633] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.183s)
[178.831279] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs
[178.993839] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.172s)
[179.003532] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs
[179.165914] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.172s)
[179.176207] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc
[179.337736] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.171s)
[179.347736] Starting dynamic subtest: pipe-B-eDP-1-x-to-4
[179.520504] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.183s)
[179.530466] Starting dynamic subtest: pipe-B-eDP-1-x-to-x
[179.691414] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.170s)
[179.704894] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear
[179.873446] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.180s)
[179.883475] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs
[180.043272] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.171s)
[180.052966] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs
[180.214799] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.172s)
[180.224902] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc
[180.398642] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.183s)
[180.408417] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4
[180.581315] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.183s)
[180.590636] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x
[180.771369] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.189s)
[180.781567] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear
[180.929071] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.158s)
[180.980098] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs
[182.201060] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.227s)
[182.210463] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs
[182.352442] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.150s)
[182.362259] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[182.501538] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.149s)
[182.512069] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4
[182.652049] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.151s)
[182.661342] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x
[182.803577] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.149s)
[182.813249] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear
[182.951603] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.149s)
[182.964686] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs
[183.106535] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.155s)
[183.117068] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs
[183.257273] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.149s)
[183.270374] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[183.408440] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.150s)
[183.418693] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4
[183.563408] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.156s)
[183.576870] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x
[183.713068] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.150s)
[183.723183] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear
[183.862259] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.149s)
[183.872517] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[184.012748] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.150s)
[184.023419] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[184.164268] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.149s)
[184.174828] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[184.284904] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.122s)
[184.295476] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4
[184.435062] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.149s)
[184.445824] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x
[184.584429] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.149s)
[184.594483] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear
[184.733511] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.149s)
[184.743526] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs
[184.883933] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.149s)
[184.894074] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs
[185.034373] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.149s)
[185.044737] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc
[185.184770] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.149s)
[185.194700] Starting dynamic subtest: pipe-C-eDP-1-4-to-4
[185.341095] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.157s)
[185.351492] Starting dynamic subtest: pipe-C-eDP-1-4-to-x
[185.496641] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.155s)
[185.506552] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear
[185.647457] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.151s)
[185.657314] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs
[185.797321] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.149s)
[185.807624] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs
[185.946970] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.149s)
[185.956965] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc
[186.096308] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.149s)
[186.106203] Starting dynamic subtest: pipe-C-eDP-1-x-to-4
[186.245990] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.149s)
[186.255647] Starting dynamic subtest: pipe-C-eDP-1-x-to-x
[186.396235] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.149s)
[186.405308] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear
[186.546042] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.149s)
[186.555580] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs
[186.695206] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.149s)
[186.703847] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs
[186.844688] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.149s)
[186.854525] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc
[186.999188] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.154s)
[187.008344] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4
[187.154335] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.155s)
[187.162629] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x
[187.310553] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.156s)
[187.320786] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear
[187.468426] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.157s)
[187.508084] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs
[188.721715] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.219s)
[188.732171] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs
[188.872969] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.149s)
[188.880917] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[189.022687] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.149s)
[189.030755] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4
[189.173314] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.151s)
[189.183821] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x
[189.322886] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.149s)
[189.332983] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear
[189.472567] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.149s)
[189.482812] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs
[189.622915] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.149s)
[189.633034] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs
[189.773762] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.149s)
[189.783366] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[189.924052] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.149s)
[189.934274] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4
[190.072748] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.150s)
[190.082797] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x
[190.222274] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.149s)
[190.232103] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear
[190.371491] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.149s)
[190.385515] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[190.521920] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.150s)
[190.532635] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[190.673483] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.149s)
[190.683819] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[190.822499] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.149s)
[190.832893] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4
[190.971514] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.149s)
[190.981978] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x
[191.120558] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.149s)
[191.130938] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear
[191.270345] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.149s)
[191.280245] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs
[191.420071] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.149s)
[191.430115] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs
[191.571326] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.149s)
[191.581366] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc
[191.721544] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.149s)
[191.731896] Starting dynamic subtest: pipe-D-eDP-1-4-to-4
[191.871998] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.150s)
[191.882237] Starting dynamic subtest: pipe-D-eDP-1-4-to-x
[192.019332] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.149s)
[192.029238] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear
[192.169400] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.149s)
[192.179121] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs
[192.330090] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.160s)
[192.338908] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs
[192.479512] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.149s)
[192.489990] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc
[192.629291] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.149s)
[192.638083] Starting dynamic subtest: pipe-D-eDP-1-x-to-4
[192.779133] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.149s)
[192.788689] Starting dynamic subtest: pipe-D-eDP-1-x-to-x
[192.931421] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.152s)
[192.941080] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear
[193.109670] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.177s)
[193.119539] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs
[193.265801] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.156s)
[193.275155] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs
[193.415825] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.149s)
[193.425553] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc
[193.565478] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.149s)
[193.575155] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4
[193.714981] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.149s)
[193.724493] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x
[193.872407] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.157s)
[193.881359] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear
[194.032721] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.160s)
[194.054214] Subtest flip-change-tiling: SUCCESS (26.744s)
[195.203775] [016/130] (822s left) gem_exec_schedule (pi-shared-iova)
[195.389872] Starting subtest: pi-shared-iova
[195.392212] Starting dynamic subtest: rcs0
[195.464141] Dynamic subtest rcs0: SUCCESS (0.076s)
[195.474780] Starting dynamic subtest: vcs0
[195.516669] Dynamic subtest vcs0: SUCCESS (0.053s)
[195.526402] Starting dynamic subtest: vcs1
[195.568844] Dynamic subtest vcs1: SUCCESS (0.052s)
[195.578815] Starting dynamic subtest: vecs0
[195.619596] Dynamic subtest vecs0: SUCCESS (0.051s)
[195.628584] Starting dynamic subtest: ccs0
[195.684716] Dynamic subtest ccs0: SUCCESS (0.065s)
[195.687155] Subtest pi-shared-iova: SUCCESS (0.298s)
[196.978701] [017/130] (821s left) kms_rotation_crc (cursor-rotation-180)
[197.083055] Starting subtest: cursor-rotation-180
[198.566714] Subtest cursor-rotation-180: SUCCESS (1.483s)
[199.764305] [018/130] (818s left) gem_exec_balancer (parallel-keep-in-fence)
[200.045026] Starting subtest: parallel-keep-in-fence
[201.115588] Subtest parallel-keep-in-fence: SUCCESS (1.072s)
[201.215611] [019/130] (816s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[201.319333] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[205.041071] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.725s)
[206.234918] [020/130] (811s left) kms_psr (fbc-pr-dpms)
[206.323476] Starting subtest: fbc-pr-dpms
[206.328222] Subtest fbc-pr-dpms: SKIP (0.000s)
[206.395627] [021/130] (811s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[206.497405] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[211.203379] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.710s)
[212.308150] [022/130] (805s left) gem_mmap_offset (isolation)
[212.368798] Starting subtest: isolation
[212.387743] Subtest isolation: SUCCESS (0.005s)
[212.484893] [023/130] (805s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[212.592257] Starting subtest: short-flip-before-cursor-toggle
[213.518197] Subtest short-flip-before-cursor-toggle: SUCCESS (0.925s)
[214.326273] [024/130] (804s left) kms_universal_plane (disable-primary-vs-flip)
[214.418070] Starting subtest: disable-primary-vs-flip
[214.420226] Starting dynamic subtest: pipe-A-eDP-1
[215.994552] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.575s)
[216.003134] Starting dynamic subtest: pipe-B-eDP-1
[218.129210] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.130s)
[218.137917] Starting dynamic subtest: pipe-C-eDP-1
[220.283129] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.156s)
[220.290999] Starting dynamic subtest: pipe-D-eDP-1
[222.424299] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.139s)
[222.426621] Subtest disable-primary-vs-flip: SUCCESS (8.004s)
[223.202061] [025/130] (795s left) gem_exec_params (sol-reset-not-gen7)
[223.254410] Starting subtest: sol-reset-not-gen7
[223.259602] Subtest sol-reset-not-gen7: SUCCESS (0.002s)
[223.388665] [026/130] (795s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[223.493972] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[223.498635] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[223.588624] [027/130] (794s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[223.695437] Starting subtest: cursorB-vs-flipB-atomic-transitions
[223.700177] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s)
[223.836893] [028/130] (794s left) kms_pm_rpm (cursor-dpms)
[226.076148] Starting subtest: cursor-dpms
[226.081278] Subtest cursor-dpms: SKIP (0.000s)
[226.441180] [029/130] (792s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[226.535935] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[226.540274] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[226.630196] [030/130] (791s left) kms_psr2_su (frontbuffer-xrgb8888)
[226.686621] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[226.755209] [031/130] (791s left) kms_writeback (writeback-check-output-xrgb2101010)
[226.841397] Subtest writeback-check-output-XRGB2101010: SKIP (0.000s)
[226.887214] [032/130] (791s left) kms_getfb (getfb-repeated-different-handles)
[226.985411] Starting subtest: getfb-repeated-different-handles
[226.987670] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[227.094738] [033/130] (791s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[227.188104] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[227.192029] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[227.290142] [034/130] (791s left) gem_mmap_gtt (big-copy-xy)
[227.344983] Subtest big-copy-XY: SKIP (0.000s)
[227.402603] [035/130] (791s left) kms_content_protection (legacy)
[227.572147] Starting subtest: legacy
[231.431783] Subtest legacy: SKIP (3.855s)
[232.623796] [036/130] (786s left) gem_ctx_shared (disjoint-timelines)
[232.682738] Starting subtest: disjoint-timelines
[232.705804] Subtest disjoint-timelines: SUCCESS (0.023s)
[232.954365] [037/130] (785s left) i915_pm_rpm (debugfs-read)
[235.003075] Starting subtest: debugfs-read
[237.383488] Subtest debugfs-read: SUCCESS (2.373s)
[237.738916] [038/130] (781s left) kms_pm_rpm (universal-planes-dpms)
[240.087210] Starting subtest: universal-planes-dpms
[240.089774] Starting dynamic subtest: plane-33
[248.876444] Dynamic subtest plane-33: SUCCESS (8.791s)
[248.887079] Starting dynamic subtest: plane-43
[257.178730] Dynamic subtest plane-43: SUCCESS (8.302s)
[257.189605] Starting dynamic subtest: plane-53
[265.482031] Dynamic subtest plane-53: SUCCESS (8.302s)
[265.492597] Starting dynamic subtest: plane-63
[273.783269] Dynamic subtest plane-63: SUCCESS (8.299s)
[273.794080] Starting dynamic subtest: plane-73
[282.173382] Dynamic subtest plane-73: SUCCESS (8.389s)
[282.183605] Starting dynamic subtest: plane-83
[290.545048] Dynamic subtest plane-83: SUCCESS (8.369s)
[290.548079] Subtest universal-planes-dpms: SUCCESS (50.460s)
[290.901392] [039/130] (727s left) kms_fbcon_fbt (psr)
[290.964068] Starting subtest: psr
[298.383504] Subtest psr: SUCCESS (7.420s)
[298.453094] [040/130] (720s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[298.550758] Starting subtest: yf-tiled-64bpp-rotate-180
[298.555371] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[298.657483] [041/130] (720s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[298.719308] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[298.723789] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[298.900076] [042/130] (720s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[299.000074] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[300.042909] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.044s)
[300.185824] [043/130] (718s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[300.286438] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[306.694646] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.411s)
[306.805259] [044/130] (712s left) gem_ctx_exec (basic-norecovery)
[306.858985] Starting subtest: basic-norecovery
[307.205756] Subtest basic-norecovery: SUCCESS (0.344s)
[307.358820] [045/130] (711s left) kms_psr (pr-sprite-blt)
[307.454612] Starting subtest: pr-sprite-blt
[307.458638] Subtest pr-sprite-blt: SKIP (0.000s)
[307.526230] [046/130] (711s left) i915_drm_fdinfo (busy)
[307.564479] Starting subtest: busy
[307.566465] Starting dynamic subtest: rcs0
[307.597772] Dynamic subtest rcs0: SKIP (0.034s)
[307.607885] Starting dynamic subtest: bcs0
[307.612050] Dynamic subtest bcs0: SKIP (0.001s)
[307.619629] Starting dynamic subtest: vcs0
[307.624068] Dynamic subtest vcs0: SKIP (0.000s)
[307.631454] Starting dynamic subtest: vcs1
[307.635235] Dynamic subtest vcs1: SKIP (0.000s)
[307.643882] Starting dynamic subtest: vecs0
[307.647710] Dynamic subtest vecs0: SKIP (0.000s)
[307.654701] Starting dynamic subtest: ccs0
[307.658184] Dynamic subtest ccs0: SKIP (0.000s)
[307.661575] Subtest busy: SKIP (0.039s)
[307.694892] [047/130] (711s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[307.795440] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[307.799069] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[307.899611] [048/130] (711s left) gem_lmem_swapping (parallel-multi)
[307.938727] Subtest parallel-multi: SKIP (0.000s)
[307.982314] [049/130] (711s left) kms_flip (2x-plain-flip)
[308.061468] Starting subtest: 2x-plain-flip
[308.072293] Subtest 2x-plain-flip: SKIP (0.010s)
[308.149646] [050/130] (711s left) gem_pxp (create-regular-buffer)
[308.272224] Starting subtest: create-regular-buffer
[308.273993] Subtest create-regular-buffer: SUCCESS (0.000s)
[308.391649] [051/130] (710s left) kms_color (legacy-gamma-reset)
[308.481776] Starting subtest: legacy-gamma-reset
[308.483842] Starting dynamic subtest: pipe-A-eDP-1
[308.855146] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.373s)
[308.863194] Starting dynamic subtest: pipe-B-eDP-1
[308.868218] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[308.875649] Starting dynamic subtest: pipe-C-eDP-1
[308.877965] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[308.885318] Starting dynamic subtest: pipe-D-eDP-1
[308.890461] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[308.892820] Subtest legacy-gamma-reset: SUCCESS (0.406s)
[309.716816] [052/130] (709s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[309.813396] Starting subtest: bad-pixel-format-y-tiled-ccs
[309.815865] Starting dynamic subtest: pipe-A-eDP-1
[309.838678] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[309.848988] Starting dynamic subtest: pipe-B-eDP-1
[309.870190] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[309.877451] Starting dynamic subtest: pipe-C-eDP-1
[309.898217] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[309.905494] Starting dynamic subtest: pipe-D-eDP-1
[309.926582] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[309.930545] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.004s)
[311.970973] [053/130] (707s left) gem_linear_blits (interruptible)
[312.273835] Starting subtest: interruptible
[316.558260] Subtest interruptible: SUCCESS (4.285s)
[316.728798] [054/130] (702s left) gem_exec_schedule (submit-golden-slice)
[316.836064] Starting subtest: submit-golden-slice
[316.838068] Starting dynamic subtest: rcs0
[316.886724] Dynamic subtest rcs0: SUCCESS (0.059s)
[316.895402] Starting dynamic subtest: bcs0
[316.948393] Dynamic subtest bcs0: SUCCESS (0.061s)
[316.959218] Starting dynamic subtest: vcs0
[316.999291] Dynamic subtest vcs0: SUCCESS (0.051s)
[317.009939] Starting dynamic subtest: vcs1
[317.054685] Dynamic subtest vcs1: SUCCESS (0.054s)
[317.066294] Starting dynamic subtest: vecs0
[317.106912] Dynamic subtest vecs0: SUCCESS (0.052s)
[317.120153] Starting dynamic subtest: ccs0
[317.170914] Dynamic subtest ccs0: SUCCESS (0.063s)
[317.173213] Subtest submit-golden-slice: SUCCESS (0.343s)
[319.032148] [055/130] (700s left) syncobj_wait (invalid-reset-zero-handles)
[319.098689] Starting subtest: invalid-reset-zero-handles
[319.101107] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[319.206143] [056/130] (700s left) kms_debugfs (display-off-read-all)
[319.311084] Starting subtest: display-off-read-all
[319.598902] Subtest display-off-read-all: SUCCESS (0.287s)
[320.400334] [057/130] (699s left) kms_lease (cursor-implicit-plane)
[320.492458] Starting subtest: cursor-implicit-plane
[320.494438] Starting dynamic subtest: pipe-A-eDP-1
[320.964724] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.472s)
[320.972988] Starting dynamic subtest: pipe-B-eDP-1
[322.103251] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.137s)
[322.112911] Starting dynamic subtest: pipe-C-eDP-1
[323.223764] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.121s)
[323.231772] Starting dynamic subtest: pipe-D-eDP-1
[324.342064] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.115s)
[324.344682] Subtest cursor-implicit-plane: SUCCESS (3.851s)
[325.201533] [058/130] (694s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[325.305182] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[329.884903] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.583s)
[331.072427] [059/130] (688s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[331.167135] Starting subtest: plane-primary-overlay-mutable-zpos
[334.582761] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.411s)
[335.759674] [060/130] (683s left) kms_cdclk (mode-transition-all-outputs)
[335.850119] Starting subtest: mode-transition-all-outputs
[336.141098] Subtest mode-transition-all-outputs: SKIP (0.285s)
[336.973048] [061/130] (682s left) kms_big_fb (linear-32bpp-rotate-90)
[337.079868] Starting subtest: linear-32bpp-rotate-90
[337.098489] Subtest linear-32bpp-rotate-90: SKIP (0.018s)
[337.230016] [062/130] (682s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[337.332700] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[337.337070] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[337.449959] [063/130] (682s left) kms_dp_link_training (non-uhbr-sst)
[337.552840] Starting subtest: non-uhbr-sst
[337.561632] Subtest non-uhbr-sst: SKIP (0.000s)
[337.623462] [064/130] (682s left) gem_mmap_wc (write-gtt-read-wc)
[337.687251] Subtest write-gtt-read-wc: SKIP (0.000s)
[337.752259] [065/130] (682s left) kms_chamelium_frames (hdmi-frame-dump)
[338.126999] Subtest hdmi-frame-dump: SKIP (0.000s)
[338.890549] [066/130] (681s left) gem_partial_pwrite_pread (write)
[338.956731] Subtest write: SKIP (0.000s)
[339.059414] [067/130] (680s left) kms_cursor_crc (cursor-random-64x21)
[339.248764] Starting subtest: cursor-random-64x21
[339.306619] Subtest cursor-random-64x21: SKIP (0.051s)
[339.560081] [068/130] (680s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[339.664638] Starting subtest: psr-2p-pri-indfb-multidraw
[339.669119] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[339.776108] [069/130] (680s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[339.839725] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[339.941990] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.103s)
[340.014883] [070/130] (680s left) gem_exec_whisper (basic-queues-priority-all)
[340.076838] Starting subtest: basic-queues-priority-all
[362.315159] Subtest basic-queues-priority-all: SUCCESS (22.234s)
[362.501515] [071/130] (657s left) gem_reg_read (bad-register)
[362.558979] Starting subtest: bad-register
[362.561139] Subtest bad-register: SUCCESS (0.000s)
[362.676189] [072/130] (657s left) gem_eio (wait-wedge-immediate)
[362.914895] Starting subtest: wait-wedge-immediate
[364.013751] Subtest wait-wedge-immediate: SUCCESS (1.098s)
[364.171841] [073/130] (656s left) gem_watchdog (default-virtual)
[364.246318] Starting subtest: default-virtual
[370.518582] Subtest default-virtual: SUCCESS (6.282s)
[370.623096] [074/130] (649s left) syncobj_timeline (single-wait-available-signaled)
[370.694309] Starting subtest: single-wait-available-signaled
[370.696267] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[370.804270] [075/130] (649s left) api_intel_bb (blit-noreloc-purge-cache)
[370.862345] Starting subtest: blit-noreloc-purge-cache
[370.876767] Subtest blit-noreloc-purge-cache: SUCCESS (0.017s)
[370.970447] [076/130] (649s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[371.076817] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[371.446383] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[374.167104] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.720s)
[374.177875] Starting dynamic subtest: pipe-A-eDP-1-4
[376.454077] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.286s)
[376.463121] Starting dynamic subtest: pipe-A-eDP-1-4
[378.464070] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[378.475991] Starting dynamic subtest: pipe-A-eDP-1-x
[380.764390] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.300s)
[381.132176] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[383.892828] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.768s)
[383.904467] Starting dynamic subtest: pipe-B-eDP-1-4
[386.189399] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.296s)
[386.200039] Starting dynamic subtest: pipe-B-eDP-1-4
[388.199478] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[388.212049] Starting dynamic subtest: pipe-B-eDP-1-x
[390.490477] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.289s)
[390.850779] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[393.606748] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.761s)
[393.618927] Starting dynamic subtest: pipe-C-eDP-1-4
[395.883401] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.276s)
[395.894926] Starting dynamic subtest: pipe-C-eDP-1-4
[397.892692] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[397.901829] Starting dynamic subtest: pipe-C-eDP-1-x
[400.182065] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.289s)
[400.549268] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[403.333774] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.794s)
[403.345939] Starting dynamic subtest: pipe-D-eDP-1-4
[405.618078] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.284s)
[405.628032] Starting dynamic subtest: pipe-D-eDP-1-4
[407.628702] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.010s)
[407.639072] Starting dynamic subtest: pipe-D-eDP-1-x
[409.930177] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.300s)
[409.932734] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.853s)
[411.107171] [077/130] (609s left) syncobj_timeline (etime-single-wait-submitted)
[411.167712] Starting subtest: etime-single-wait-submitted
[411.270806] Subtest etime-single-wait-submitted: SUCCESS (0.103s)
[411.343266] [078/130] (609s left) i915_power (sanity)
[411.400128] Starting subtest: sanity
[415.449170] Subtest sanity: SUCCESS (4.041s)
[416.912842] [079/130] (603s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[417.040481] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[447.884305] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (30.843s)
[448.728427] [080/130] (571s left) gem_shrink (reclaim)
[448.808340] Starting subtest: reclaim
[451.164079] Subtest reclaim: SUCCESS (2.358s)
[451.310965] [081/130] (569s left) kms_addfb_basic (bo-too-small)
[451.407204] Starting subtest: bo-too-small
[451.409501] Subtest bo-too-small: SUCCESS (0.000s)
[451.505224] [082/130] (569s left) kms_invalid_mode (bad-hsync-end)
[451.601068] Starting subtest: bad-hsync-end
[451.603331] Starting dynamic subtest: pipe-A-eDP-1
[451.882719] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.282s)
[451.891854] Starting dynamic subtest: pipe-B-eDP-1
[451.894098] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[451.902592] Starting dynamic subtest: pipe-C-eDP-1
[451.904714] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[451.913061] Starting dynamic subtest: pipe-D-eDP-1
[451.914869] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[451.917160] Subtest bad-hsync-end: SUCCESS (0.287s)
[452.750309] [083/130] (567s left) kms_plane (plane-panning-bottom-right-suspend)
[452.841133] Starting subtest: plane-panning-bottom-right-suspend
[452.843503] Starting dynamic subtest: pipe-A
[470.280835] Dynamic subtest pipe-A: SUCCESS (2.945s)
[470.291866] Starting dynamic subtest: pipe-B
[488.262147] Dynamic subtest pipe-B: SUCCESS (3.295s)
[488.264169] Subtest plane-panning-bottom-right-suspend: SUCCESS (6.242s)
[489.121076] [084/130] (531s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[489.228790] Starting subtest: plane-upscale-20x20-with-modifiers
[489.231215] Starting dynamic subtest: pipe-A
[489.575579] Dynamic subtest pipe-A: SUCCESS (0.338s)
[489.592727] Starting dynamic subtest: pipe-B
[491.054462] Dynamic subtest pipe-B: SUCCESS (1.444s)
[491.072650] Starting dynamic subtest: pipe-C
[492.502090] Dynamic subtest pipe-C: SUCCESS (1.421s)
[492.512155] Starting dynamic subtest: pipe-D
[493.946819] Dynamic subtest pipe-D: SUCCESS (1.422s)
[493.949050] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.630s)
[495.132833] [085/130] (525s left) kms_psr (fbc-psr-cursor-blt)
[495.237906] Starting subtest: fbc-psr-cursor-blt
[495.239877] Starting dynamic subtest: eDP-1
[495.244122] Dynamic subtest eDP-1: SKIP (0.000s)
[495.248359] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[495.312662] [086/130] (525s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[495.416988] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[502.448163] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (6.982s)
[502.586155] [087/130] (518s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[502.682190] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[502.686219] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[502.782631] [088/130] (518s left) dmabuf_sync_file (export-before-signal)
[502.821545] Starting subtest: export-before-signal
[502.823354] Subtest export-before-signal: SUCCESS (0.000s)
[502.876793] [089/130] (517s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[502.969290] Starting subtest: fbc-rgb565-draw-mmap-cpu
[506.996752] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (4.017s)
[508.178183] [090/130] (512s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[508.261616] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[508.264291] Starting dynamic subtest: pipe-A
[508.600744] Dynamic subtest pipe-A: SUCCESS (0.339s)
[508.611634] Starting dynamic subtest: pipe-B
[510.048707] Dynamic subtest pipe-B: SUCCESS (1.444s)
[510.059075] Starting dynamic subtest: pipe-C
[511.478890] Dynamic subtest pipe-C: SUCCESS (1.427s)
[511.488854] Starting dynamic subtest: pipe-D
[512.904015] Dynamic subtest pipe-D: SUCCESS (1.422s)
[512.906336] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.634s)
[514.080472] [091/130] (506s left) kms_flip (dpms-off-confusion-interruptible)
[514.185799] Starting subtest: dpms-off-confusion-interruptible
[514.188105] Starting dynamic subtest: A-eDP1
[522.871960] Dynamic subtest A-eDP1: SUCCESS (8.682s)
[522.883385] Starting dynamic subtest: B-eDP1
[531.512499] Dynamic subtest B-eDP1: SUCCESS (8.640s)
[531.523514] Starting dynamic subtest: C-eDP1
[540.216702] Dynamic subtest C-eDP1: SUCCESS (8.702s)
[540.227537] Starting dynamic subtest: D-eDP1
[548.842495] Dynamic subtest D-eDP1: SUCCESS (8.622s)
[548.844946] Subtest dpms-off-confusion-interruptible: SUCCESS (34.654s)
[550.007448] [092/130] (470s left) gem_tiled_fence_blits (normal)
[550.075303] Subtest normal: SKIP (0.000s)
[550.159591] [093/130] (470s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[550.539739] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[551.314399] [094/130] (469s left) perf_pmu (busy-double-start)
[551.355043] Starting subtest: busy-double-start
[551.357079] Starting dynamic subtest: rcs0
[555.000145] Dynamic subtest rcs0: FAIL (3.589s)
[555.012646] Starting dynamic subtest: bcs0
[558.516397] Dynamic subtest bcs0: SUCCESS (3.571s)
[558.528327] Starting dynamic subtest: vcs0
[562.498512] Dynamic subtest vcs0: SUCCESS (3.979s)
[562.511055] Starting dynamic subtest: vcs1
[566.592900] Dynamic subtest vcs1: FAIL (4.019s)
[566.603942] Starting dynamic subtest: vecs0
[570.493415] Dynamic subtest vecs0: SUCCESS (3.971s)
[570.506324] Starting dynamic subtest: ccs0
[574.131662] Dynamic subtest ccs0: FAIL (3.563s)
[574.134063] Subtest busy-double-start: FAIL (22.699s)
[574.177834] [095/130] (446s left) kms_big_fb (linear-64bpp-rotate-0)
[574.277489] Starting subtest: linear-64bpp-rotate-0
[576.624223] Subtest linear-64bpp-rotate-0: SUCCESS (2.345s)
[576.847077] [096/130] (444s left) api_intel_bb (simple-bb-ctx)
[576.904285] Starting subtest: simple-bb-ctx
[576.912564] Subtest simple-bb-ctx: SUCCESS (0.009s)
[577.036728] [097/130] (444s left) kms_properties (invalid-properties-legacy)
[577.125017] Starting subtest: invalid-properties-legacy
[577.229366] Subtest invalid-properties-legacy: SUCCESS (0.103s)
[577.301455] [098/130] (443s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[577.395727] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[584.027488] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.634s)
[584.172316] [099/130] (437s left) gem_mmap_gtt (zero-extend)
[584.223240] Subtest zero-extend: SKIP (0.000s)
[584.290195] [100/130] (437s left) kms_cursor_crc (cursor-sliding-512x170)
[584.554450] Starting subtest: cursor-sliding-512x170
[584.559061] Subtest cursor-sliding-512x170: SKIP (0.001s)
[584.716205] [101/130] (436s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[589.663927] Starting subtest: fbc-pr-cursor-plane-update-sf
[589.668690] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.002s)
[590.515532] [102/130] (430s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[590.561015] Starting subtest: multi-wait-for-submit-submitted-signaled
[590.562948] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[590.672527] [103/130] (430s left) kms_force_connector_basic (force-edid)
[590.759047] Starting subtest: force-edid
[591.044957] Subtest force-edid: SUCCESS (0.286s)
[591.187001] [104/130] (430s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[591.291203] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[591.295315] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[591.407666] [105/130] (430s left) sriov_basic (enable-vfs-bind-unbind-each)
[591.454652] Starting subtest: enable-vfs-bind-unbind-each
[591.456464] Starting dynamic subtest: numvfs-1
[591.518657] Dynamic subtest numvfs-1: FAIL (0.005s)
[591.529849] Starting dynamic subtest: numvfs-2
[591.587680] Dynamic subtest numvfs-2: FAIL (0.003s)
[591.596786] Starting dynamic subtest: numvfs-3
[591.653203] Dynamic subtest numvfs-3: FAIL (0.003s)
[591.661656] Starting dynamic subtest: numvfs-4
[591.718376] Dynamic subtest numvfs-4: FAIL (0.003s)
[591.727094] Starting dynamic subtest: numvfs-5
[591.786330] Dynamic subtest numvfs-5: FAIL (0.003s)
[591.797075] Starting dynamic subtest: numvfs-6
[591.856367] Dynamic subtest numvfs-6: FAIL (0.003s)
[591.866369] Starting dynamic subtest: numvfs-7
[591.925728] Dynamic subtest numvfs-7: FAIL (0.003s)
[591.935677] Starting dynamic subtest: numvfs-random
[591.994364] Dynamic subtest numvfs-random: FAIL (0.003s)
[591.996441] Subtest enable-vfs-bind-unbind-each: FAIL (0.033s)
[592.032696] [106/130] (429s left) syncobj_wait (wait-any-snapshot)
[592.079584] Starting subtest: wait-any-snapshot
[592.161154] Subtest wait-any-snapshot: SUCCESS (0.081s)
[592.240628] [107/130] (429s left) gem_exec_schedule (implicit-boths)
[592.311785] Starting subtest: implicit-boths
[592.313511] Starting dynamic subtest: rcs0
[592.416714] Dynamic subtest rcs0: SUCCESS (0.111s)
[592.429559] Starting dynamic subtest: vcs0
[592.495229] Dynamic subtest vcs0: SUCCESS (0.078s)
[592.507807] Starting dynamic subtest: vcs1
[592.569207] Dynamic subtest vcs1: SUCCESS (0.074s)
[592.582341] Starting dynamic subtest: vecs0
[592.645808] Dynamic subtest vecs0: SUCCESS (0.076s)
[592.658890] Starting dynamic subtest: ccs0
[592.725841] Dynamic subtest ccs0: SUCCESS (0.079s)
[592.727861] Subtest implicit-boths: SUCCESS (0.421s)
[594.098080] [108/130] (427s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[594.208337] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[594.212511] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[594.308403] [109/130] (427s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[594.403989] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[594.406396] Starting dynamic subtest: pipe-A-eDP-1
[594.429640] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[594.439752] Starting dynamic subtest: pipe-B-eDP-1
[594.460906] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[594.471187] Starting dynamic subtest: pipe-C-eDP-1
[594.493552] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[594.504038] Starting dynamic subtest: pipe-D-eDP-1
[594.525991] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[594.530451] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[596.629053] [110/130] (425s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[596.730826] Starting subtest: psr-indfb-scaledprimary
[602.379213] Subtest psr-indfb-scaledprimary: SUCCESS (5.651s)
[602.536135] [111/130] (419s left) kms_dsc (dsc-with-output-formats)
[602.627538] Starting subtest: dsc-with-output-formats
[602.650918] Subtest dsc-with-output-formats: SKIP (0.001s)
[602.705325] [112/130] (419s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[602.771999] Subtest tiled-to-untiled: SKIP (0.000s)
[602.840862] [113/130] (418s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[602.932515] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[602.935079] Starting dynamic subtest: pipe-A-eDP-1
[602.957529] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[602.969193] Starting dynamic subtest: pipe-B-eDP-1
[602.990468] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[602.999757] Starting dynamic subtest: pipe-C-eDP-1
[603.021679] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[603.030900] Starting dynamic subtest: pipe-D-eDP-1
[603.052937] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[603.057005] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[605.129179] [114/130] (416s left) kms_properties (crtc-properties-legacy)
[605.213829] Starting subtest: crtc-properties-legacy
[605.216472] Starting dynamic subtest: pipe-A-eDP-1
[605.665189] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.447s)
[605.676905] Starting dynamic subtest: pipe-B-eDP-1
[606.854509] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.191s)
[606.864270] Starting dynamic subtest: pipe-C-eDP-1
[608.056486] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.200s)
[608.070093] Starting dynamic subtest: pipe-D-eDP-1
[609.243028] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.186s)
[609.245392] Subtest crtc-properties-legacy: SUCCESS (4.029s)
[610.032508] [115/130] (411s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[610.098862] Starting subtest: yf-tiled-to-vebox-x-tiled
[610.103402] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[610.282853] [116/130] (411s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[610.395326] Starting subtest: y-tiled-16bpp-rotate-180
[610.399387] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[610.522023] [117/130] (411s left) gem_ctx_persistence (heartbeat-close)
[610.584529] Starting subtest: heartbeat-close
[610.589133] Subtest heartbeat-close: SKIP (0.000s)
[610.699558] [118/130] (411s left) kms_psr (fbc-psr-suspend)
[610.798338] Starting subtest: fbc-psr-suspend
[610.800578] Starting dynamic subtest: eDP-1
[610.805029] Dynamic subtest eDP-1: SKIP (0.000s)
[610.810041] Subtest fbc-psr-suspend: SKIP (0.001s)
[610.870530] [119/130] (411s left) kms_plane_alpha_blend (alpha-transparent-fb)
[610.955683] Starting subtest: alpha-transparent-fb
[611.384026] Starting dynamic subtest: pipe-A-eDP-1
[612.014320] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.629s)
[612.026988] Starting dynamic subtest: pipe-D-eDP-1
[613.306817] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.291s)
[613.309125] Subtest alpha-transparent-fb: SUCCESS (2.350s)
[614.129050] [120/130] (407s left) perf_pmu (idle)
[614.165381] Starting subtest: idle
[614.167281] Starting dynamic subtest: rcs0
[614.727615] Dynamic subtest rcs0: SUCCESS (0.561s)
[614.738159] Starting dynamic subtest: bcs0
[615.253292] Dynamic subtest bcs0: SUCCESS (0.523s)
[615.263410] Starting dynamic subtest: vcs0
[615.772432] Dynamic subtest vcs0: SUCCESS (0.517s)
[615.784007] Starting dynamic subtest: vcs1
[616.302014] Dynamic subtest vcs1: SUCCESS (0.526s)
[616.312812] Starting dynamic subtest: vecs0
[616.834525] Dynamic subtest vecs0: SUCCESS (0.526s)
[616.844561] Starting dynamic subtest: ccs0
[617.358293] Dynamic subtest ccs0: SUCCESS (0.520s)
[617.360490] Subtest idle: SUCCESS (3.190s)
[617.461871] [121/130] (404s left) gem_userptr_blits (sd-probe)
[617.525591] Starting subtest: sd-probe
[617.527611] Subtest sd-probe: SUCCESS (0.000s)
[617.656297] [122/130] (404s left) gem_exec_reloc (basic-cpu-read)
[617.720087] Subtest basic-cpu-read: SKIP (0.000s)
[617.789386] [123/130] (404s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[617.888001] Starting subtest: addfb25-y-tiled-small-legacy
[617.892548] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[617.998238] [124/130] (404s left) gem_exec_capture (capture)
[618.053382] Starting subtest: capture
[618.055923] Starting dynamic subtest: rcs0-smem
[618.879152] Dynamic subtest rcs0-smem: SUCCESS (0.825s)
[618.897126] Starting dynamic subtest: bcs0-smem
[619.699774] Dynamic subtest bcs0-smem: SUCCESS (0.820s)
[619.710525] Starting dynamic subtest: vcs0-smem
[620.540654] Dynamic subtest vcs0-smem: SUCCESS (0.840s)
[620.551814] Starting dynamic subtest: vcs1-smem
[621.865448] Dynamic subtest vcs1-smem: SUCCESS (1.324s)
[621.876658] Starting dynamic subtest: vecs0-smem
[622.746981] Dynamic subtest vecs0-smem: FAIL (0.813s)
[622.758283] Starting dynamic subtest: ccs0-smem
[624.000501] Dynamic subtest ccs0-smem: SUCCESS (1.322s)
[624.002946] Subtest capture: FAIL (5.947s)
[624.134275] [125/130] (398s left) syncobj_wait (wait-delayed-signal)
[624.191375] Starting subtest: wait-delayed-signal
[624.291984] Subtest wait-delayed-signal: SUCCESS (0.102s)
[624.371696] [126/130] (397s left) gem_exec_reloc (basic-cpu)
[624.437938] Subtest basic-cpu: SKIP (0.000s)
[624.531389] [127/130] (397s left) kms_psr (psr-no-drrs)
[624.625530] Starting subtest: psr-no-drrs
[624.627854] Starting dynamic subtest: eDP-1
[626.280273] Dynamic subtest eDP-1: SUCCESS (1.656s)
[626.282736] Subtest psr-no-drrs: SUCCESS (1.657s)
[627.137636] [128/130] (395s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[627.248959] Starting subtest: fbc-shrfb-scaledprimary
[632.257082] Subtest fbc-shrfb-scaledprimary: SUCCESS (5.010s)
[633.442282] [129/130] (389s left) gem_eio (banned)
[633.625846] Starting subtest: banned
[634.166556] Subtest banned: SUCCESS (0.540s)
[634.331292] [130/130] (388s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[634.431041] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[634.434451] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[634.542230] Closing watchdogs
results: parsing output: 0/ for test: i915_hangman
results: parsing output: 1/ for test: gem_exec_balancer
results: parsing output: 2/ for test: kms_sequence
results: parsing output: 3/ for test: gem_busy
results: parsing output: 4/ for test: kms_atomic_interruptible
results: parsing output: 5/ for test: core_auth
results: parsing output: 6/ for test: kms_flip_scaled_crc
results: parsing output: 7/ for test: gem_exec_fence
results: parsing output: 8/ for test: kms_ccs
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: syncobj_timeline
results: parsing output: 11/ for test: api_intel_allocator
results: parsing output: 12/ for test: gem_userptr_blits
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_flip_tiling
results: parsing output: 15/ for test: gem_exec_schedule
results: parsing output: 16/ for test: kms_rotation_crc
results: parsing output: 17/ for test: gem_exec_balancer
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_mmap_offset
results: parsing output: 22/ for test: kms_cursor_legacy
results: parsing output: 23/ for test: kms_universal_plane
results: parsing output: 24/ for test: gem_exec_params
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_cursor_legacy
results: parsing output: 27/ for test: kms_pm_rpm
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: kms_psr2_su
results: parsing output: 30/ for test: kms_writeback
results: parsing output: 31/ for test: kms_getfb
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: gem_mmap_gtt
results: parsing output: 34/ for test: kms_content_protection
results: parsing output: 35/ for test: gem_ctx_shared
results: parsing output: 36/ for test: i915_pm_rpm
results: parsing output: 37/ for test: kms_pm_rpm
results: parsing output: 38/ for test: kms_fbcon_fbt
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: gem_render_copy
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gem_ctx_exec
results: parsing output: 44/ for test: kms_psr
results: parsing output: 45/ for test: i915_drm_fdinfo
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: gem_lmem_swapping
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: gem_pxp
results: parsing output: 50/ for test: kms_color
results: parsing output: 51/ for test: kms_ccs
results: parsing output: 52/ for test: gem_linear_blits
results: parsing output: 53/ for test: gem_exec_schedule
results: parsing output: 54/ for test: syncobj_wait
results: parsing output: 55/ for test: kms_debugfs
results: parsing output: 56/ for test: kms_lease
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_atomic
results: parsing output: 59/ for test: kms_cdclk
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_dp_link_training
results: parsing output: 63/ for test: gem_mmap_wc
results: parsing output: 64/ for test: kms_chamelium_frames
results: parsing output: 65/ for test: gem_partial_pwrite_pread
results: parsing output: 66/ for test: kms_cursor_crc
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: syncobj_timeline
results: parsing output: 69/ for test: gem_exec_whisper
results: parsing output: 70/ for test: gem_reg_read
results: parsing output: 71/ for test: gem_eio
results: parsing output: 72/ for test: gem_watchdog
results: parsing output: 73/ for test: syncobj_timeline
results: parsing output: 74/ for test: api_intel_bb
results: parsing output: 75/ for test: kms_async_flips
results: parsing output: 76/ for test: syncobj_timeline
results: parsing output: 77/ for test: i915_power
results: parsing output: 78/ for test: kms_cursor_legacy
results: parsing output: 79/ for test: gem_shrink
results: parsing output: 80/ for test: kms_addfb_basic
results: parsing output: 81/ for test: kms_invalid_mode
results: parsing output: 82/ for test: kms_plane
results: parsing output: 83/ for test: kms_plane_scaling
results: parsing output: 84/ for test: kms_psr
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: dmabuf_sync_file
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_plane_scaling
results: parsing output: 90/ for test: kms_flip
results: parsing output: 91/ for test: gem_tiled_fence_blits
results: parsing output: 92/ for test: kms_chamelium_edid
results: parsing output: 93/ for test: perf_pmu
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: api_intel_bb
results: parsing output: 96/ for test: kms_properties
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: gem_mmap_gtt
results: parsing output: 99/ for test: kms_cursor_crc
results: parsing output: 100/ for test: kms_psr2_sf
results: parsing output: 101/ for test: syncobj_wait
results: parsing output: 102/ for test: kms_force_connector_basic
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: sriov_basic
results: parsing output: 105/ for test: syncobj_wait
results: parsing output: 106/ for test: gem_exec_schedule
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_ccs
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_dsc
results: parsing output: 111/ for test: gem_set_tiling_vs_blt
results: parsing output: 112/ for test: kms_ccs
results: parsing output: 113/ for test: kms_properties
results: parsing output: 114/ for test: gem_render_copy
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: gem_ctx_persistence
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: kms_plane_alpha_blend
results: parsing output: 119/ for test: perf_pmu
results: parsing output: 120/ for test: gem_userptr_blits
results: parsing output: 121/ for test: gem_exec_reloc
results: parsing output: 122/ for test: kms_addfb_basic
results: parsing output: 123/ for test: gem_exec_capture
results: parsing output: 124/ for test: syncobj_wait
results: parsing output: 125/ for test: gem_exec_reloc
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: gem_eio
results: parsing output: 129/ for test: kms_frontbuffer_tracking
Done.