[58.793429] Initializing watchdogs
[58.793549]   /dev/watchdog0
[58.808072] [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]
[58.812400] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.815128] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.817844] [001/131] (960s left) kms_cursor_edge_walk (256x256-top-bottom)
[58.943890] Starting subtest: 256x256-top-bottom
[58.946237] Starting dynamic subtest: pipe-A-eDP-1
[62.369912] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.426s)
[62.380890] Starting dynamic subtest: pipe-D-eDP-1
[65.488213] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.117s)
[65.490566] Subtest 256x256-top-bottom: SUCCESS (6.546s)
[66.316179] [002/131] (953s left) kms_legacy_colorkey (basic)
[66.409853] Starting subtest: basic
[66.412155] Starting dynamic subtest: pipe-A
[66.453063] Dynamic subtest pipe-A: SUCCESS (0.045s)
[66.462623] Starting dynamic subtest: pipe-B
[66.464960] Dynamic subtest pipe-B: SUCCESS (0.001s)
[66.471836] Starting dynamic subtest: pipe-C
[66.474056] Dynamic subtest pipe-C: SUCCESS (0.000s)
[66.480594] Starting dynamic subtest: pipe-D
[66.482476] Dynamic subtest pipe-D: SUCCESS (0.000s)
[66.484403] Subtest basic: SUCCESS (0.048s)
[66.543974] [003/131] (952s left) gem_exec_balancer (parallel-out-fence)
[66.808159] Starting subtest: parallel-out-fence
[68.408085] Subtest parallel-out-fence: SUCCESS (1.601s)
[68.554889] [004/131] (950s left) kms_force_connector_basic (force-connector-state)
[68.625776] Starting subtest: force-connector-state
[69.236389] Subtest force-connector-state: SUCCESS (0.613s)
[70.145725] [005/131] (949s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[70.218476] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[70.320514] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.101s)
[70.417633] [006/131] (949s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[70.512794] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[70.515158] Starting dynamic subtest: pipe-A-default-mode
[70.813823] Dynamic subtest pipe-A-default-mode: SKIP (0.297s)
[70.818539] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.298s)
[71.641294] [007/131] (947s left) kms_psr (fbc-psr-basic)
[71.732982] Starting subtest: fbc-psr-basic
[71.735203] Starting dynamic subtest: eDP-1
[71.739557] Dynamic subtest eDP-1: SKIP (0.000s)
[71.744337] Subtest fbc-psr-basic: SKIP (0.000s)
[71.825908] [008/131] (947s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[71.934052] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[71.938247] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[72.079777] [009/131] (947s left) kms_flip_tiling (flip-change-tiling)
[72.176698] Starting subtest: flip-change-tiling
[72.178920] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs
[72.358795] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.181s)
[72.367042] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs
[72.502626] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.144s)
[72.512735] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[72.647033] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.144s)
[72.657139] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4
[72.790293] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.143s)
[72.800512] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x
[72.934023] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.144s)
[72.944814] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear
[73.106659] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.171s)
[73.118658] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs
[73.239701] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.133s)
[73.249094] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs
[73.351263] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.110s)
[73.360377] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[73.485933] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.133s)
[73.495099] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4
[73.629104] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.143s)
[73.638692] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x
[73.772978] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.143s)
[73.781553] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear
[73.917404] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.144s)
[73.926197] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[74.051088] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.133s)
[74.060684] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[74.185684] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.133s)
[74.194813] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[74.295440] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.110s)
[74.304707] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4
[74.446864] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.149s)
[74.456856] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x
[74.567430] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.121s)
[74.578081] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear
[74.689506] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.121s)
[74.699000] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs
[74.822681] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.132s)
[74.833159] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs
[74.968078] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.144s)
[74.979244] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc
[75.111980] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.143s)
[75.122701] Starting dynamic subtest: pipe-A-eDP-1-4-to-4
[75.234219] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.121s)
[75.243546] Starting dynamic subtest: pipe-A-eDP-1-4-to-x
[75.378152] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.144s)
[75.388428] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear
[75.522154] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.144s)
[75.532882] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs
[75.655464] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.133s)
[75.665809] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs
[75.800186] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.144s)
[75.809603] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc
[75.933302] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.132s)
[75.943977] Starting dynamic subtest: pipe-A-eDP-1-x-to-4
[76.077940] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.144s)
[76.086770] Starting dynamic subtest: pipe-A-eDP-1-x-to-x
[76.200324] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.121s)
[76.210725] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear
[76.344902] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.144s)
[76.355468] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs
[76.489102] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.144s)
[76.500545] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs
[76.633154] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.144s)
[76.642473] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc
[76.778320] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.143s)
[76.787560] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4
[76.933671] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.154s)
[76.943769] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x
[77.078676] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.143s)
[77.088956] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear
[77.202141] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.121s)
[77.251161] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs
[78.465381] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.219s)
[78.475877] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs
[78.599920] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.133s)
[78.610992] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[78.733370] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.132s)
[78.744083] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4
[78.876037] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.144s)
[78.886910] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x
[79.020558] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.144s)
[79.031226] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear
[79.164818] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.144s)
[79.175216] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs
[79.299046] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.133s)
[79.310069] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs
[79.409388] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.110s)
[79.419484] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[79.544337] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.132s)
[79.554128] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4
[79.687666] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.144s)
[79.697977] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x
[79.831449] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.144s)
[79.841694] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear
[79.975898] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.144s)
[79.985473] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[80.110275] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.132s)
[80.121068] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[80.244434] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.132s)
[80.253741] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[80.354148] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.110s)
[80.362540] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4
[80.487312] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.133s)
[80.497945] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x
[80.631561] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.143s)
[80.641963] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear
[80.775984] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.143s)
[80.786240] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs
[80.910047] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.133s)
[80.921043] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs
[81.054373] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.144s)
[81.066829] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc
[81.199098] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.144s)
[81.210515] Starting dynamic subtest: pipe-B-eDP-1-4-to-4
[81.320568] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.121s)
[81.330443] Starting dynamic subtest: pipe-B-eDP-1-4-to-x
[81.477904] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.154s)
[81.487952] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear
[81.620186] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.143s)
[81.631243] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs
[81.764561] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.144s)
[81.774608] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs
[81.909103] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.144s)
[81.918919] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc
[82.053993] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.144s)
[82.063512] Starting dynamic subtest: pipe-B-eDP-1-x-to-4
[82.208984] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.154s)
[82.218948] Starting dynamic subtest: pipe-B-eDP-1-x-to-x
[82.331916] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.121s)
[82.342330] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear
[82.487995] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.155s)
[82.501076] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs
[82.631339] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.144s)
[82.641344] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs
[82.775775] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.144s)
[82.786214] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc
[82.920312] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.143s)
[82.929572] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4
[83.064875] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.143s)
[83.075206] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x
[83.209431] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.144s)
[83.219831] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear
[83.343107] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.133s)
[83.394548] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs
[84.667181] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.278s)
[84.678045] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs
[84.766763] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.099s)
[84.776375] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[84.867193] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.099s)
[84.876672] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4
[84.966330] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.099s)
[84.977293] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x
[85.077464] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.110s)
[85.087250] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear
[85.188533] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.111s)
[85.198445] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs
[85.288480] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.099s)
[85.298874] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs
[85.389071] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.099s)
[85.399277] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[85.489147] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.099s)
[85.498027] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4
[85.588562] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.099s)
[85.598573] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x
[85.699158] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.110s)
[85.710997] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear
[85.810308] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.111s)
[85.820324] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[85.910995] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.100s)
[85.920728] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[86.010895] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.099s)
[86.020271] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[86.111021] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.099s)
[86.119104] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4
[86.210850] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.099s)
[86.219370] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x
[86.310379] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.099s)
[86.319317] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear
[86.422071] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.110s)
[86.432844] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs
[86.533023] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.110s)
[86.541464] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs
[86.644574] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.110s)
[86.654867] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc
[86.755639] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.110s)
[86.765788] Starting dynamic subtest: pipe-C-eDP-1-4-to-4
[86.866654] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.110s)
[86.876883] Starting dynamic subtest: pipe-C-eDP-1-4-to-x
[86.977051] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.110s)
[86.986912] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear
[87.088229] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.110s)
[87.097774] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs
[87.188577] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.100s)
[87.198473] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs
[87.299245] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.110s)
[87.309117] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc
[87.410360] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.110s)
[87.418996] Starting dynamic subtest: pipe-C-eDP-1-x-to-4
[87.521980] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.111s)
[87.530536] Starting dynamic subtest: pipe-C-eDP-1-x-to-x
[87.633666] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.110s)
[87.645060] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear
[87.744501] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.110s)
[87.755383] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs
[87.855069] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.110s)
[87.863607] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs
[87.966305] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.110s)
[87.978255] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc
[88.077640] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.110s)
[88.089079] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4
[88.199526] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.121s)
[88.208313] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x
[88.310854] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.110s)
[88.321043] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear
[88.421804] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.110s)
[88.462610] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs
[89.665990] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.209s)
[89.675816] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs
[89.765962] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.099s)
[89.776091] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[89.866238] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.099s)
[89.878514] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4
[89.976717] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.110s)
[89.989715] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x
[90.087430] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.111s)
[90.096143] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear
[90.199048] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.110s)
[90.208993] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs
[90.298790] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.099s)
[90.309088] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs
[90.399253] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.099s)
[90.409685] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[90.510728] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.110s)
[90.519944] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4
[90.631898] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.121s)
[90.642456] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x
[90.743149] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.110s)
[90.753098] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear
[90.865633] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.122s)
[90.878284] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[90.965877] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.099s)
[90.976281] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[91.077044] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.110s)
[91.087491] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[91.176673] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.099s)
[91.186596] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4
[91.276812] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.099s)
[91.287221] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x
[91.387430] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.111s)
[91.397355] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear
[91.498283] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.110s)
[91.508087] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs
[91.609977] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.110s)
[91.620076] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs
[91.722045] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.110s)
[91.732301] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc
[91.821692] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.099s)
[91.832531] Starting dynamic subtest: pipe-D-eDP-1-4-to-4
[91.932338] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.110s)
[91.942279] Starting dynamic subtest: pipe-D-eDP-1-4-to-x
[92.042856] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.110s)
[92.053109] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear
[92.154154] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.110s)
[92.164492] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs
[92.254058] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.099s)
[92.263948] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs
[92.365049] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.111s)
[92.375180] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc
[92.465299] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.099s)
[92.475174] Starting dynamic subtest: pipe-D-eDP-1-x-to-4
[92.576293] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.110s)
[92.586211] Starting dynamic subtest: pipe-D-eDP-1-x-to-x
[92.688113] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.110s)
[92.698654] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear
[92.799379] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.110s)
[92.810786] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs
[92.910019] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.110s)
[92.920255] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs
[93.021499] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.110s)
[93.030066] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc
[93.132142] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.110s)
[93.141743] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4
[93.243112] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.110s)
[93.251855] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x
[93.393683] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.149s)
[93.404066] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear
[93.504426] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.110s)
[93.537070] Subtest flip-change-tiling: SUCCESS (21.362s)
[94.742690] [010/131] (924s left) gem_media_vme
[94.873261] [011/131] (924s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[94.974193] Starting subtest: yf-tiled-32bpp-rotate-90
[94.978619] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[95.111586] [012/131] (924s left) i915_pm_rps (min-max-config-idle)
[95.184716] Starting subtest: min-max-config-idle
[95.189042] Subtest min-max-config-idle: SKIP (0.001s)
[95.315771] [013/131] (924s left) gen7_exec_parse (basic-rejected)
[95.386173] Subtest basic-rejected: SKIP (0.000s)
[95.492533] [014/131] (924s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[95.586070] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[100.054050] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.471s)
[101.259122] [015/131] (918s left) sriov_basic (enable-vfs-bind-unbind-each)
[101.318972] Starting subtest: enable-vfs-bind-unbind-each
[101.321566] Starting dynamic subtest: numvfs-1
[101.403984] Dynamic subtest numvfs-1: FAIL (0.030s)
[101.411487] Starting dynamic subtest: numvfs-2
[101.485859] Dynamic subtest numvfs-2: FAIL (0.004s)
[101.494806] Starting dynamic subtest: numvfs-3
[101.569082] Dynamic subtest numvfs-3: FAIL (0.004s)
[101.578041] Starting dynamic subtest: numvfs-4
[101.650231] Dynamic subtest numvfs-4: FAIL (0.003s)
[101.660055] Starting dynamic subtest: numvfs-5
[101.732894] Dynamic subtest numvfs-5: FAIL (0.004s)
[101.741469] Starting dynamic subtest: numvfs-6
[101.813777] Dynamic subtest numvfs-6: FAIL (0.004s)
[101.822330] Starting dynamic subtest: numvfs-7
[101.895810] Dynamic subtest numvfs-7: FAIL (0.004s)
[101.905279] Starting dynamic subtest: numvfs-random
[101.978621] Dynamic subtest numvfs-random: FAIL (0.004s)
[101.980637] Subtest enable-vfs-bind-unbind-each: FAIL (0.059s)
[102.014766] [016/131] (917s left) kms_dirtyfb (drrs-dirtyfb-ioctl)
[102.112286] Starting subtest: drrs-dirtyfb-ioctl
[102.125615] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s)
[102.230284] [017/131] (917s left) syncobj_basic (test-valid-cycle)
[102.294369] Starting subtest: test-valid-cycle
[102.296542] Subtest test-valid-cycle: SUCCESS (0.000s)
[102.409254] [018/131] (917s left) gem_ctx_sseu (mmap-args)
[102.478340] Subtest mmap-args: SKIP (0.000s)
[102.603703] [019/131] (917s left) kms_invalid_mode (bad-vsync-end)
[102.705084] Starting subtest: bad-vsync-end
[102.706995] Starting dynamic subtest: pipe-A-eDP-1
[102.988399] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[102.997743] Starting dynamic subtest: pipe-B-eDP-1
[103.000051] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[103.007474] Starting dynamic subtest: pipe-C-eDP-1
[103.009811] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[103.017030] Starting dynamic subtest: pipe-D-eDP-1
[103.018950] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[103.020912] Subtest bad-vsync-end: SUCCESS (0.289s)
[103.845977] [020/131] (916s left) perf_pmu (busy-idle-no-semaphores)
[103.886410] Starting subtest: busy-idle-no-semaphores
[103.888717] Starting dynamic subtest: rcs0
[104.547339] Dynamic subtest rcs0: SUCCESS (0.661s)
[104.556672] Starting dynamic subtest: bcs0
[105.195396] Dynamic subtest bcs0: SUCCESS (0.647s)
[105.206695] Starting dynamic subtest: vcs0
[105.847754] Dynamic subtest vcs0: SUCCESS (0.651s)
[105.859036] Starting dynamic subtest: vcs1
[107.516740] Dynamic subtest vcs1: SUCCESS (1.667s)
[107.527203] Starting dynamic subtest: vecs0
[109.503526] Dynamic subtest vecs0: SUCCESS (1.986s)
[109.513840] Starting dynamic subtest: ccs0
[111.549029] Dynamic subtest ccs0: SUCCESS (2.045s)
[111.551989] Subtest busy-idle-no-semaphores: SUCCESS (7.663s)
[111.708538] [021/131] (908s left) gem_userptr_blits (set-cache-level)
[111.776802] Starting subtest: set-cache-level
[111.781184] Subtest set-cache-level: SKIP (0.000s)
[111.946012] [022/131] (908s left) kms_plane_alpha_blend (constant-alpha-min)
[112.041259] Starting subtest: constant-alpha-min
[112.321154] Starting dynamic subtest: pipe-A-eDP-1
[113.031500] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.709s)
[113.040420] Starting dynamic subtest: pipe-D-eDP-1
[114.487411] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.455s)
[114.489861] Subtest constant-alpha-min: SUCCESS (2.445s)
[115.348345] [023/131] (904s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[115.455920] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[116.669607] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: FAIL (0.616s)
[116.714333] [024/131] (903s left) kms_content_protection (atomic)
[116.853257] Starting subtest: atomic
[116.856826] Subtest atomic: SKIP (0.000s)
[117.023570] [025/131] (903s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[117.106438] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[117.108400] Starting dynamic subtest: pipe-A-default-mode
[119.786339] Dynamic subtest pipe-A-default-mode: SUCCESS (2.679s)
[119.788809] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.680s)
[120.646725] [026/131] (899s left) gem_mmap_wc (fault-concurrent)
[120.708093] Subtest fault-concurrent: SKIP (0.000s)
[120.776250] [027/131] (899s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[120.904294] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[121.858622] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.955s)
[122.732255] [028/131] (897s left) gem_create (busy-create)
[122.790804] Starting subtest: busy-create
[122.792764] Starting dynamic subtest: smem0
[155.893283] Dynamic subtest smem0: SUCCESS (33.102s)
[155.895901] Subtest busy-create: SUCCESS (33.103s)
[156.101871] [029/131] (864s left) gem_pread (snoop)
[156.171464] Subtest snoop: SKIP (0.000s)
[156.234934] [030/131] (864s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[156.338650] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[156.342602] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[156.475310] [031/131] (864s left) gem_userptr_blits (input-checking)
[156.541819] Starting subtest: input-checking
[156.544049] Subtest input-checking: SUCCESS (0.000s)
[156.730746] [032/131] (863s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[156.822227] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[156.824568] Starting dynamic subtest: pipe-A-eDP-1
[157.328776] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.483s)
[157.337786] Starting dynamic subtest: pipe-B-eDP-1
[158.738291] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.402s)
[158.748539] Starting dynamic subtest: pipe-C-eDP-1
[160.197124] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.458s)
[160.206163] Starting dynamic subtest: pipe-D-eDP-1
[161.604058] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.404s)
[161.606077] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.751s)
[162.839776] [033/131] (857s left) gem_mmap_wc (read-write-distinct)
[162.904396] Subtest read-write-distinct: SKIP (0.000s)
[162.961885] [034/131] (857s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[163.069794] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[163.074244] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[163.199070] [035/131] (857s left) core_getversion (all-cards)
[163.236758] Starting subtest: all-cards
[163.245138] Subtest all-cards: SUCCESS (0.011s)
[163.282819] [036/131] (857s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[163.372082] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[163.376057] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[163.502891] [037/131] (857s left) kms_addfb_basic (basic)
[163.563292] Starting subtest: basic
[163.565261] Subtest basic: SUCCESS (0.000s)
[163.715250] [038/131] (857s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[163.814439] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[163.816249] Starting dynamic subtest: pipe-A-eDP-1
[163.836477] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[163.844331] Starting dynamic subtest: pipe-B-eDP-1
[163.863925] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[163.871287] Starting dynamic subtest: pipe-C-eDP-1
[163.890248] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[163.898571] Starting dynamic subtest: pipe-D-eDP-1
[163.917846] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[163.921345] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[166.046479] [039/131] (854s left) gem_busy (close-race)
[166.105340] Starting subtest: close-race
[189.907629] Subtest close-race: SUCCESS (23.799s)
[190.329108] [FACT gem_busy (close-race)] new: kernel.kmod_is_loaded.vgem: true
[190.333272] [040/131] (830s left) gem_ccs (block-multicopy-compressed)
[190.444152] Starting subtest: block-multicopy-compressed
[190.448800] Subtest block-multicopy-compressed: SKIP (0.000s)
[190.585283] [041/131] (830s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[190.691170] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[190.695354] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[190.827561] [042/131] (830s left) gem_userptr_blits (process-exit)
[190.898159] Starting subtest: process-exit
[190.907793] Subtest process-exit: SUCCESS (0.010s)
[191.075669] [043/131] (829s left) gem_ringfill (legacy-basic)
[196.890320] Starting subtest: legacy-basic
[196.892344] Starting dynamic subtest: default
[196.960063] Dynamic subtest default: SUCCESS (0.071s)
[196.971628] Starting dynamic subtest: render
[197.002853] Dynamic subtest render: SUCCESS (0.041s)
[197.013243] Starting dynamic subtest: bsd
[197.042995] Dynamic subtest bsd: SUCCESS (0.039s)
[197.052430] Starting dynamic subtest: bsd1
[197.085038] Dynamic subtest bsd1: SUCCESS (0.040s)
[197.095067] Starting dynamic subtest: bsd2
[197.125169] Dynamic subtest bsd2: SUCCESS (0.038s)
[197.134751] Starting dynamic subtest: blt
[197.171046] Dynamic subtest blt: SUCCESS (0.044s)
[197.181251] Starting dynamic subtest: vebox
[197.213791] Dynamic subtest vebox: SUCCESS (0.041s)
[197.216116] Subtest legacy-basic: SUCCESS (0.327s)
[197.315617] [044/131] (823s left) gem_render_copy (linear-to-vebox-y-tiled)
[197.384970] Starting subtest: linear-to-vebox-y-tiled
[197.389466] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[197.605070] [045/131] (823s left) perf_pmu (module-unload)
[197.703544] Starting subtest: module-unload
[204.451550] Subtest module-unload: FAIL (6.645s)
[204.482449] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[204.483166] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[204.486100] [046/131] (816s left) gem_exec_schedule (noreorder-priority)
[206.171530] Starting subtest: noreorder-priority
[206.173845] Starting dynamic subtest: rcs0
[207.329691] Dynamic subtest rcs0: SUCCESS (1.158s)
[207.341652] Starting dynamic subtest: vcs0
[208.942454] Dynamic subtest vcs0: SUCCESS (1.609s)
[208.954078] Starting dynamic subtest: vcs1
[210.922973] Dynamic subtest vcs1: SUCCESS (1.979s)
[210.934281] Starting dynamic subtest: vecs0
[212.865848] Dynamic subtest vecs0: SUCCESS (1.940s)
[212.880940] Starting dynamic subtest: ccs0
[214.017539] Dynamic subtest ccs0: SUCCESS (1.151s)
[214.020316] Subtest noreorder-priority: SUCCESS (7.846s)
[214.196182] [FACT gem_exec_schedule (noreorder-priority)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[214.197526] [FACT gem_exec_schedule (noreorder-priority)] new: kernel.kmod_is_loaded.i915: true
[214.201183] [047/131] (807s left) i915_query (query-regions-garbage-items)
[214.272903] Starting subtest: query-regions-garbage-items
[214.275039] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[214.385130] [048/131] (806s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[214.486977] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[214.489310] Starting dynamic subtest: pipe-A-eDP-1
[214.512448] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[214.522665] Starting dynamic subtest: pipe-B-eDP-1
[214.544738] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[214.552878] Starting dynamic subtest: pipe-C-eDP-1
[214.574350] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[214.582337] Starting dynamic subtest: pipe-D-eDP-1
[214.604177] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[214.608216] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[216.778256] [049/131] (804s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[216.883044] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[216.885309] Starting dynamic subtest: pipe-A-eDP-1
[249.751017] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.674s)
[249.761150] Starting dynamic subtest: pipe-B-eDP-1
[282.654142] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.718s)
[282.664091] Starting dynamic subtest: pipe-C-eDP-1
[315.665262] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.641s)
[315.676233] Starting dynamic subtest: pipe-D-eDP-1
[348.652923] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.623s)
[348.655746] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (17.662s)
[349.912664] [050/131] (671s left) kms_plane (plane-panning-top-left)
[350.031446] Starting subtest: plane-panning-top-left
[350.034241] Starting dynamic subtest: pipe-A
[351.750490] Dynamic subtest pipe-A: SUCCESS (1.723s)
[351.760133] Starting dynamic subtest: pipe-B
[354.194731] Dynamic subtest pipe-B: SUCCESS (2.441s)
[354.197337] Subtest plane-panning-top-left: SUCCESS (4.167s)
[355.029819] [051/131] (666s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[355.162111] Starting subtest: cursor-vs-flip-toggle
[386.096173] Subtest cursor-vs-flip-toggle: SUCCESS (30.923s)
[386.969467] [052/131] (634s left) sw_sync (sync_multi_timeline_wait)
[387.011577] Starting subtest: sync_multi_timeline_wait
[387.014243] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[387.087754] [053/131] (634s left) syncobj_timeline (wait-for-submit-delayed-submit)
[387.159220] Starting subtest: wait-for-submit-delayed-submit
[387.260632] Subtest wait-for-submit-delayed-submit: SUCCESS (0.104s)
[387.363807] [054/131] (634s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[392.421269] Starting subtest: fbc-pr-overlay-plane-move-continuous-sf
[392.427209] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.002s)
[393.291807] [055/131] (628s left) kms_big_fb (yf-tiled-addfb)
[393.391586] Starting subtest: yf-tiled-addfb
[393.396689] Subtest yf-tiled-addfb: SKIP (0.000s)
[393.499599] [056/131] (628s left) gem_exec_balancer (bonded-pair)
[393.558653] Starting subtest: bonded-pair
[393.564276] Subtest bonded-pair: SKIP (0.000s)
[393.906443] [057/131] (627s left) perf (invalid-oa-exponent)
[394.074768] Starting subtest: invalid-oa-exponent
[394.088437] Subtest invalid-oa-exponent: SUCCESS (0.014s)
[394.156137] [058/131] (627s left) gem_render_copy (y-tiled)
[394.229256] Starting subtest: y-tiled
[394.234207] Subtest y-tiled: SKIP (0.000s)
[394.466572] [059/131] (627s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[394.527262] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[394.530175] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[394.659682] [060/131] (627s left) kms_content_protection (lic-type-1)
[394.805072] Starting subtest: lic-type-1
[394.810340] Subtest lic-type-1: SKIP (0.000s)
[394.969557] [061/131] (626s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[395.077431] Starting subtest: fbcpsr-shrfb-scaledprimary
[400.894881] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.819s)
[401.078232] [062/131] (620s left) kms_scaling_modes (scaling-mode-full)
[401.174153] Starting subtest: scaling-mode-full
[401.176788] Starting dynamic subtest: pipe-A-eDP-1
[401.270280] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.098s)
[401.280289] Starting dynamic subtest: pipe-B-eDP-1
[402.449415] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.177s)
[402.461267] Starting dynamic subtest: pipe-C-eDP-1
[403.560292] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.109s)
[403.570274] Starting dynamic subtest: pipe-D-eDP-1
[404.714275] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.150s)
[404.717235] Subtest scaling-mode-full: SUCCESS (3.540s)
[405.893299] [063/131] (616s left) syncobj_wait (multi-wait-all-signaled)
[405.952632] Starting subtest: multi-wait-all-signaled
[405.955258] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[406.075712] [064/131] (615s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[406.138072] Starting subtest: invalid-signal-one-illegal-handle
[406.140999] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[406.254724] [065/131] (615s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[406.349992] Starting subtest: primary-x-tiled-reflect-x-180
[413.502286] Subtest primary-x-tiled-reflect-x-180: SUCCESS (7.151s)
[414.777945] [066/131] (607s left) kms_addfb_basic (addfb25-4-tiled)
[414.883833] Starting subtest: addfb25-4-tiled
[414.886328] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[414.992313] [067/131] (607s left) kms_psr (psr2-cursor-blt)
[415.087930] Starting subtest: psr2-cursor-blt
[415.090245] Starting dynamic subtest: eDP-1
[416.826270] Dynamic subtest eDP-1: SUCCESS (1.737s)
[416.829014] Subtest psr2-cursor-blt: SUCCESS (1.738s)
[417.647813] [068/131] (604s left) gem_exec_reloc (basic-active)
[417.715574] Subtest basic-active: SKIP (0.000s)
[417.798169] [069/131] (604s left) kms_rotation_crc (cursor-rotation-180)
[417.884253] Starting subtest: cursor-rotation-180
[419.414355] Subtest cursor-rotation-180: SUCCESS (1.529s)
[420.614667] [070/131] (601s left) kms_vrr (seamless-rr-switch-drrs)
[420.716817] Starting subtest: seamless-rr-switch-drrs
[420.724107] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[420.815373] [071/131] (601s left) gem_mmap_offset (open-flood)
[420.863119] Starting subtest: open-flood
[442.357166] Subtest open-flood: SUCCESS (21.490s)
[442.505940] [072/131] (579s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[442.701201] Starting subtest: cursor-rapid-movement-64x21
[442.747321] Subtest cursor-rapid-movement-64x21: SKIP (0.042s)
[443.023338] [073/131] (579s left) kms_flip (2x-absolute-wf_vblank)
[443.122439] Starting subtest: 2x-absolute-wf_vblank
[443.131359] Subtest 2x-absolute-wf_vblank: SKIP (0.010s)
[443.238395] [074/131] (579s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[443.331763] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[443.333792] Starting dynamic subtest: pipe-A
[443.397910] Dynamic subtest pipe-A: SUCCESS (0.067s)
[443.408953] Starting dynamic subtest: pipe-B
[444.521860] Dynamic subtest pipe-B: SUCCESS (1.123s)
[444.534461] Starting dynamic subtest: pipe-C
[445.623321] Dynamic subtest pipe-C: SUCCESS (1.100s)
[445.634654] Starting dynamic subtest: pipe-D
[446.750922] Dynamic subtest pipe-D: SUCCESS (1.126s)
[446.753449] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.421s)
[447.940055] [075/131] (574s left) kms_atomic_interruptible (legacy-setmode)
[448.037678] Starting subtest: legacy-setmode
[448.040261] Starting dynamic subtest: pipe-A-eDP-1
[454.941448] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.899s)
[454.943983] Subtest legacy-setmode: SUCCESS (6.900s)
[455.838756] [076/131] (566s left) api_intel_allocator (simple-allocator)
[455.918720] Starting subtest: simple-allocator
[455.921445] Starting dynamic subtest: basic
[455.924332] Dynamic subtest basic: SUCCESS (0.004s)
[455.939363] Starting dynamic subtest: parallel-one
[456.122673] Dynamic subtest parallel-one: SUCCESS (0.201s)
[456.132284] Starting dynamic subtest: print
[456.134644] Dynamic subtest print: SUCCESS (0.000s)
[456.144768] Starting dynamic subtest: reuse
[456.147329] Dynamic subtest reuse: SUCCESS (0.000s)
[456.156904] Starting dynamic subtest: reserve
[456.159318] Dynamic subtest reserve: SUCCESS (0.000s)
[456.168759] Starting dynamic subtest: fork-reopen-allocator
[456.171298] Dynamic subtest fork-reopen-allocator: SUCCESS (0.013s)
[456.174142] Subtest simple-allocator: SUCCESS (0.222s)
[456.290357] [077/131] (566s left) gem_exec_schedule (u-submit-golden-slice)
[456.377259] Starting subtest: u-submit-golden-slice
[456.380053] Starting dynamic subtest: rcs0
[456.399445] Dynamic subtest rcs0: SUCCESS (0.035s)
[456.410809] Starting dynamic subtest: bcs0
[456.429167] Dynamic subtest bcs0: SUCCESS (0.029s)
[456.439152] Starting dynamic subtest: vcs0
[456.466091] Dynamic subtest vcs0: SUCCESS (0.036s)
[456.477140] Starting dynamic subtest: vcs1
[456.498105] Dynamic subtest vcs1: SUCCESS (0.031s)
[456.509204] Starting dynamic subtest: vecs0
[456.530318] Dynamic subtest vecs0: SUCCESS (0.032s)
[456.539747] Starting dynamic subtest: ccs0
[456.566107] Dynamic subtest ccs0: SUCCESS (0.034s)
[456.569263] Subtest u-submit-golden-slice: SUCCESS (0.203s)
[458.149652] [078/131] (564s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[458.256399] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[465.190395] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.934s)
[465.364600] [079/131] (557s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[465.466263] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[465.478120] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.011s)
[465.605078] [080/131] (557s left) perf (invalid-oa-metric-set-id)
[465.711023] Starting subtest: invalid-oa-metric-set-id
[465.721936] Subtest invalid-oa-metric-set-id: SUCCESS (0.011s)
[465.762710] [081/131] (557s left) gem_exec_whisper (basic-queues-priority-all)
[465.826461] Starting subtest: basic-queues-priority-all
[489.179264] Subtest basic-queues-priority-all: SUCCESS (23.343s)
[489.384829] [082/131] (533s left) gem_pxp (create-regular-buffer)
[489.520752] Starting subtest: create-regular-buffer
[489.523406] Subtest create-regular-buffer: SUCCESS (0.000s)
[489.674320] [083/131] (533s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[489.784053] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[497.356413] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (7.573s)
[497.542042] [084/131] (525s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[498.119305] Starting subtest: syncobj-backward-timeline-chain-engines
[498.225906] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.110s)
[499.153828] [085/131] (523s left) gem_exec_suspend (basic-s3-devices)
[499.229978] Starting subtest: basic-S3-devices
[499.232749] Starting dynamic subtest: smem
[510.025881] Dynamic subtest smem: SUCCESS (10.795s)
[510.028806] Subtest basic-S3-devices: SUCCESS (10.797s)
[510.233812] [086/131] (512s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[510.344262] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[510.347204] Starting dynamic subtest: pipe-A
[510.680032] Dynamic subtest pipe-A: SUCCESS (0.338s)
[510.696979] Starting dynamic subtest: pipe-B
[512.061471] Dynamic subtest pipe-B: SUCCESS (1.380s)
[512.078158] Starting dynamic subtest: pipe-C
[513.497821] Dynamic subtest pipe-C: SUCCESS (1.435s)
[513.508265] Starting dynamic subtest: pipe-D
[514.925651] Dynamic subtest pipe-D: SUCCESS (1.428s)
[514.928345] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.587s)
[516.122061] [087/131] (506s left) gem_ctx_param (invalid-set-no-zeromap)
[516.190029] Starting subtest: invalid-set-no-zeromap
[516.192962] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[516.289598] [088/131] (506s left) kms_pm_rpm (universal-planes)
[518.233702] Starting subtest: universal-planes
[518.236265] Starting dynamic subtest: plane-33
[526.917460] Dynamic subtest plane-33: SUCCESS (8.691s)
[526.929789] Starting dynamic subtest: plane-63
[535.506808] Dynamic subtest plane-63: SUCCESS (8.589s)
[535.520423] Starting dynamic subtest: plane-93
[543.810434] Dynamic subtest plane-93: SUCCESS (8.302s)
[543.822715] Starting dynamic subtest: plane-123
[552.104815] Dynamic subtest plane-123: SUCCESS (8.291s)
[552.118727] Starting dynamic subtest: plane-133
[560.391907] Dynamic subtest plane-133: SUCCESS (8.285s)
[560.403432] Starting dynamic subtest: plane-143
[568.782396] Dynamic subtest plane-143: SUCCESS (8.388s)
[568.785047] Subtest universal-planes: SUCCESS (50.561s)
[569.187081] [089/131] (453s left) kms_rotation_crc (sprite-rotation-180)
[569.286701] Starting subtest: sprite-rotation-180
[576.386430] Subtest sprite-rotation-180: SUCCESS (7.100s)
[577.649836] [090/131] (445s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[577.777167] Starting subtest: flip-vs-cursor-busy-crc-legacy
[578.590288] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.810s)
[579.488568] [091/131] (443s left) kms_flip (flip-vs-expired-vblank)
[579.584417] Starting subtest: flip-vs-expired-vblank
[579.587284] Starting dynamic subtest: A-eDP1
[588.263293] Dynamic subtest A-eDP1: SUCCESS (8.678s)
[588.274837] Starting dynamic subtest: B-eDP1
[596.901212] Dynamic subtest B-eDP1: SUCCESS (8.636s)
[596.912943] Starting dynamic subtest: C-eDP1
[605.531310] Dynamic subtest C-eDP1: SUCCESS (8.628s)
[605.546504] Starting dynamic subtest: D-eDP1
[614.152462] Dynamic subtest D-eDP1: SUCCESS (8.619s)
[614.155105] Subtest flip-vs-expired-vblank: SUCCESS (34.570s)
[615.349963] [092/131] (407s left) gen3_render_linear_blits
[615.473804] [093/131] (407s left) kms_psr (psr2-sprite-plane-onoff)
[615.574356] Starting subtest: psr2-sprite-plane-onoff
[615.577108] Starting dynamic subtest: eDP-1
[617.356469] Dynamic subtest eDP-1: SUCCESS (1.781s)
[617.358858] Subtest psr2-sprite-plane-onoff: SUCCESS (1.783s)
[618.241790] [094/131] (405s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[618.342260] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[618.347203] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[618.483623] [095/131] (404s left) kms_cursor_crc (cursor-onscreen-64x21)
[618.669405] Starting subtest: cursor-onscreen-64x21
[618.716829] Subtest cursor-onscreen-64x21: SKIP (0.042s)
[619.012553] [096/131] (404s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[619.106876] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[619.111451] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[619.248175] [097/131] (404s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[619.354101] Starting subtest: x-tiled-16bpp-rotate-0
[620.646212] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.291s)
[620.818872] [098/131] (402s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[620.919248] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[628.267026] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.348s)
[628.417744] [099/131] (395s left) i915_hangman (gt-error-state-capture)
[628.494412] Starting subtest: gt-error-state-capture
[628.497212] Starting dynamic subtest: rcs0
[638.953078] Dynamic subtest rcs0: SUCCESS (10.458s)
[638.967530] Starting dynamic subtest: bcs0
[650.984595] Dynamic subtest bcs0: SUCCESS (12.027s)
[650.998430] Starting dynamic subtest: vcs0
[662.952733] Dynamic subtest vcs0: SUCCESS (11.964s)
[662.970705] Starting dynamic subtest: vcs1
[673.897014] Dynamic subtest vcs1: SUCCESS (10.940s)
[673.910563] Starting dynamic subtest: vecs0
[684.906749] Dynamic subtest vecs0: SUCCESS (11.005s)
[684.920923] Starting dynamic subtest: ccs0
[695.976317] Dynamic subtest ccs0: SUCCESS (11.065s)
[695.978899] Subtest gt-error-state-capture: SUCCESS (67.476s)
[696.141936] [100/131] (327s left) syncobj_wait (wait-any-interrupted)
[696.199225] Starting subtest: wait-any-interrupted
[696.300409] Subtest wait-any-interrupted: SUCCESS (0.102s)
[696.406674] [101/131] (327s left) i915_drm_fdinfo (context-close-stress)
[696.447892] Starting subtest: context-close-stress
[707.195418] Subtest context-close-stress: SUCCESS (10.747s)
[707.300295] [102/131] (316s left) api_intel_bb (simple-bb-ctx)
[707.492154] Starting subtest: simple-bb-ctx
[707.507412] Subtest simple-bb-ctx: SUCCESS (0.018s)
[707.667692] [103/131] (316s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[708.057271] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[708.835087] [104/131] (314s left) kms_atomic_transition (plane-all-transition-nonblocking)
[708.934152] Starting subtest: plane-all-transition-nonblocking
[708.936456] Starting dynamic subtest: pipe-A-eDP-1
[711.427933] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[711.745686] Starting dynamic subtest: pipe-B-eDP-1
[714.989912] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.254s)
[715.297996] Subtest plane-all-transition-nonblocking: SUCCESS (6.362s)
[716.137080] [105/131] (307s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[716.238436] Starting subtest: y-tiled-32bpp-rotate-90
[716.244068] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[716.376630] [106/131] (307s left) gem_exec_schedule (u-semaphore-codependency)
[716.463743] Starting subtest: u-semaphore-codependency
[716.472016] Subtest u-semaphore-codependency: SUCCESS (0.016s)
[716.860737] [107/131] (307s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[716.967996] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[716.972994] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[717.101026] [108/131] (306s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[717.214420] Starting subtest: psr-farfromfence-mmap-gtt
[717.220442] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[717.393155] [109/131] (306s left) gem_eio (in-flight-internal-immediate)
[717.645063] Starting subtest: in-flight-internal-immediate
[719.060917] Subtest in-flight-internal-immediate: SUCCESS (1.415s)
[719.244619] [110/131] (304s left) gem_exec_reloc (basic-gtt-active)
[719.307269] Subtest basic-gtt-active: SKIP (0.000s)
[719.388819] [111/131] (304s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[719.490448] Starting subtest: fbc-rgb101010-draw-pwrite
[724.918680] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.431s)
[726.149799] [112/131] (298s left) kms_psr (pr-primary-blt)
[726.250272] Starting subtest: pr-primary-blt
[726.255471] Subtest pr-primary-blt: SKIP (0.000s)
[726.352289] [113/131] (297s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[731.400330] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf
[731.403270] Starting dynamic subtest: pipe-A-eDP-1
[742.833025] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.427s)
[742.845131] Starting dynamic subtest: pipe-B-eDP-1
[754.265324] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.432s)
[754.268184] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.862s)
[755.131115] [114/131] (269s left) kms_async_flips (test-cursor)
[755.252146] Starting subtest: test-cursor
[755.256928] Subtest test-cursor: SKIP (0.000s)
[756.465910] [115/131] (267s left) gem_exec_params (invalid-bsd1-flag-on-render)
[756.527904] Starting subtest: invalid-bsd1-flag-on-render
[756.530434] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[756.658837] [116/131] (267s left) gem_ctx_persistence (heartbeat-hostile)
[756.730409] Starting subtest: heartbeat-hostile
[756.736201] Subtest heartbeat-hostile: SKIP (0.000s)
[756.873922] [117/131] (267s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[756.966135] Starting subtest: fbc-pr-sprite-mmap-gtt
[756.971096] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[757.062624] [118/131] (267s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[757.127176] Starting subtest: multi-wait-available-unsubmitted-signaled
[757.129253] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[757.258699] [119/131] (267s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[759.178623] Starting subtest: modeset-lpsp-stress-no-wait
[768.905953] Subtest modeset-lpsp-stress-no-wait: SUCCESS (9.724s)
[769.010812] [120/131] (255s left) syncobj_wait (invalid-signal-illegal-handle)
[769.079326] Starting subtest: invalid-signal-illegal-handle
[769.082234] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[769.202801] [121/131] (255s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[769.305131] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[769.310247] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[769.432374] [122/131] (255s left) kms_vblank (query-busy-hang)
[769.529444] Starting subtest: query-busy-hang
[769.532178] Starting dynamic subtest: pipe-A-eDP-1
[796.747672] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.212s)
[796.765305] Starting dynamic subtest: pipe-D-eDP-1
[821.779250] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.021s)
[821.782020] Subtest query-busy-hang: SUCCESS (52.238s)
[822.656795] [123/131] (202s left) gem_exec_flush (basic-wb-ro-default)
[822.725623] Starting subtest: basic-wb-ro-default
[828.189402] Subtest basic-wb-ro-default: SUCCESS (5.464s)
[828.415041] [124/131] (196s left) kms_frontbuffer_tracking (fbc-2p-rte)
[828.511227] Starting subtest: fbc-2p-rte
[828.516333] Subtest fbc-2p-rte: SKIP (0.000s)
[828.642674] [125/131] (196s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[828.754534] Starting subtest: 4-tiled-64bpp-rotate-0
[830.401027] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.646s)
[830.579113] [126/131] (194s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[830.689687] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[830.693961] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[830.826234] [127/131] (194s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[830.930948] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[830.935064] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[831.063993] [128/131] (193s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[831.145996] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[831.148113] Starting dynamic subtest: pipe-A-eDP-1
[831.170077] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[831.186747] Starting dynamic subtest: pipe-B-eDP-1
[831.210714] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[831.222281] Starting dynamic subtest: pipe-C-eDP-1
[831.244156] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[831.254253] Starting dynamic subtest: pipe-D-eDP-1
[831.277289] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[831.281856] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[833.427642] [129/131] (191s left) kms_chamelium_frames (dp-crc-multiple)
[833.813198] Subtest dp-crc-multiple: SKIP (0.000s)
[834.620344] [130/131] (190s left) gem_softpin (evict-prime-sanity-check)
[834.682225] Starting subtest: evict-prime-sanity-check
[834.685270] Starting dynamic subtest: rcs0
[835.844944] Dynamic subtest rcs0: SUCCESS (1.162s)
[835.859658] Starting dynamic subtest: bcs0
[836.956541] Dynamic subtest bcs0: SUCCESS (1.110s)
[836.969162] Starting dynamic subtest: vcs0
[839.014440] Dynamic subtest vcs0: SUCCESS (2.053s)
[839.027438] Starting dynamic subtest: vcs1
[841.048930] Dynamic subtest vcs1: SUCCESS (2.032s)
[841.061677] Starting dynamic subtest: vecs0
[843.036431] Dynamic subtest vecs0: SUCCESS (1.984s)
[843.047705] Starting dynamic subtest: ccs0
[844.178832] Dynamic subtest ccs0: SUCCESS (1.141s)
[844.191375] Starting dynamic subtest: all
[845.306446] Dynamic subtest all: SUCCESS (1.126s)
[845.309302] Subtest evict-prime-sanity-check: SUCCESS (10.622s)
[845.415266] [131/131] (179s left) kms_draw_crc (draw-method-pwrite)
[845.521131] Starting subtest: draw-method-pwrite
[845.523337] Starting dynamic subtest: xrgb8888-untiled
[846.085323] Dynamic subtest xrgb8888-untiled: SUCCESS (0.566s)
[846.097205] Starting dynamic subtest: rgb565-untiled
[846.507687] Dynamic subtest rgb565-untiled: SUCCESS (0.421s)
[846.518704] Starting dynamic subtest: xrgb2101010-untiled
[847.040460] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.533s)
[847.054471] Starting dynamic subtest: xbgr16161616f-untiled
[847.796854] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.753s)
[847.808087] Starting dynamic subtest: xrgb8888-xtiled
[849.552363] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.755s)
[849.563441] Starting dynamic subtest: rgb565-xtiled
[850.585989] Dynamic subtest rgb565-xtiled: SUCCESS (1.032s)
[850.597425] Starting dynamic subtest: xrgb2101010-xtiled
[852.287182] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.697s)
[852.298408] Starting dynamic subtest: xbgr16161616f-xtiled
[855.475814] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.186s)
[855.487473] Starting dynamic subtest: xrgb8888-4tiled
[856.543187] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.066s)
[856.554673] Starting dynamic subtest: rgb565-4tiled
[857.076075] Dynamic subtest rgb565-4tiled: SUCCESS (0.533s)
[857.090438] Starting dynamic subtest: xrgb2101010-4tiled
[858.143122] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.066s)
[858.154968] Starting dynamic subtest: xbgr16161616f-4tiled
[861.043947] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (2.899s)
[861.046441] Subtest draw-method-pwrite: SUCCESS (15.523s)
[861.162098] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_edge_walk
results: parsing output: 1/ for test: kms_legacy_colorkey
results: parsing output: 2/ for test: gem_exec_balancer
results: parsing output: 3/ for test: kms_force_connector_basic
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: kms_flip_scaled_crc
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_flip_tiling
results: parsing output: 9/ for test: gem_media_vme
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: i915_pm_rps
results: parsing output: 12/ for test: gen7_exec_parse
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: sriov_basic
results: parsing output: 15/ for test: kms_dirtyfb
results: parsing output: 16/ for test: syncobj_basic
results: parsing output: 17/ for test: gem_ctx_sseu
results: parsing output: 18/ for test: kms_invalid_mode
results: parsing output: 19/ for test: perf_pmu
results: parsing output: 20/ for test: gem_userptr_blits
results: parsing output: 21/ for test: kms_plane_alpha_blend
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: kms_content_protection
results: parsing output: 24/ for test: kms_flip_scaled_crc
results: parsing output: 25/ for test: gem_mmap_wc
results: parsing output: 26/ for test: kms_cursor_legacy
results: parsing output: 27/ for test: gem_create
results: parsing output: 28/ for test: gem_pread
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: gem_userptr_blits
results: parsing output: 31/ for test: kms_ccs
results: parsing output: 32/ for test: gem_mmap_wc
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: core_getversion
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_addfb_basic
results: parsing output: 37/ for test: kms_ccs
results: parsing output: 38/ for test: gem_busy
results: parsing output: 39/ for test: gem_ccs
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gem_userptr_blits
results: parsing output: 42/ for test: gem_ringfill
results: parsing output: 43/ for test: gem_render_copy
results: parsing output: 44/ for test: perf_pmu
results: parsing output: 45/ for test: gem_exec_schedule
results: parsing output: 46/ for test: i915_query
results: parsing output: 47/ for test: kms_ccs
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: kms_plane
results: parsing output: 50/ for test: kms_cursor_legacy
results: parsing output: 51/ for test: sw_sync
results: parsing output: 52/ for test: syncobj_timeline
results: parsing output: 53/ for test: kms_psr2_sf
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: gem_exec_balancer
results: parsing output: 56/ for test: perf
results: parsing output: 57/ for test: gem_render_copy
results: parsing output: 58/ for test: syncobj_timeline
results: parsing output: 59/ for test: kms_content_protection
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_scaling_modes
results: parsing output: 62/ for test: syncobj_wait
results: parsing output: 63/ for test: syncobj_timeline
results: parsing output: 64/ for test: kms_rotation_crc
results: parsing output: 65/ for test: kms_addfb_basic
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: gem_exec_reloc
results: parsing output: 68/ for test: kms_rotation_crc
results: parsing output: 69/ for test: kms_vrr
results: parsing output: 70/ for test: gem_mmap_offset
results: parsing output: 71/ for test: kms_cursor_crc
results: parsing output: 72/ for test: kms_flip
results: parsing output: 73/ for test: kms_plane_scaling
results: parsing output: 74/ for test: kms_atomic_interruptible
results: parsing output: 75/ for test: api_intel_allocator
results: parsing output: 76/ for test: gem_exec_schedule
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_flip
results: parsing output: 79/ for test: perf
results: parsing output: 80/ for test: gem_exec_whisper
results: parsing output: 81/ for test: gem_pxp
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: gem_exec_fence
results: parsing output: 84/ for test: gem_exec_suspend
results: parsing output: 85/ for test: kms_plane_scaling
results: parsing output: 86/ for test: gem_ctx_param
results: parsing output: 87/ for test: kms_pm_rpm
results: parsing output: 88/ for test: kms_rotation_crc
results: parsing output: 89/ for test: kms_cursor_legacy
results: parsing output: 90/ for test: kms_flip
results: parsing output: 91/ for test: gen3_render_linear_blits
results: parsing output: 92/ for test: kms_psr
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_cursor_crc
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: i915_hangman
results: parsing output: 99/ for test: syncobj_wait
results: parsing output: 100/ for test: i915_drm_fdinfo
results: parsing output: 101/ for test: api_intel_bb
results: parsing output: 102/ for test: kms_chamelium_hpd
results: parsing output: 103/ for test: kms_atomic_transition
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: gem_exec_schedule
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_eio
results: parsing output: 109/ for test: gem_exec_reloc
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_psr
results: parsing output: 112/ for test: kms_psr2_sf
results: parsing output: 113/ for test: kms_async_flips
results: parsing output: 114/ for test: gem_exec_params
results: parsing output: 115/ for test: gem_ctx_persistence
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: syncobj_timeline
results: parsing output: 118/ for test: kms_pm_rpm
results: parsing output: 119/ for test: syncobj_wait
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_vblank
results: parsing output: 122/ for test: gem_exec_flush
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_ccs
results: parsing output: 128/ for test: kms_chamelium_frames
results: parsing output: 129/ for test: gem_softpin
results: parsing output: 130/ for test: kms_draw_crc
Done.