[56.966961] Initializing watchdogs
[56.967041]   /dev/watchdog0
[56.981080] [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.985455] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.988092] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.991379] [001/133] (960s left) perf_pmu (invalid-init)
[57.059970] Starting subtest: invalid-init
[57.062442] Subtest invalid-init: SUCCESS (0.000s)
[57.166734] [002/133] (960s left) gem_exec_schedule (manyslice)
[57.230825] Starting subtest: manyslice
[57.232856] Starting dynamic subtest: rcs0
[63.942886] Dynamic subtest rcs0: SUCCESS (6.694s)
[63.953656] Starting dynamic subtest: bcs0
[70.575405] Dynamic subtest bcs0: SUCCESS (6.623s)
[70.588736] Starting dynamic subtest: vcs0
[76.663345] Dynamic subtest vcs0: SUCCESS (6.084s)
[76.674999] Starting dynamic subtest: vcs1
[82.736682] Dynamic subtest vcs1: SUCCESS (6.071s)
[82.750502] Starting dynamic subtest: vecs0
[88.810036] Dynamic subtest vecs0: SUCCESS (6.071s)
[88.823675] Starting dynamic subtest: ccs0
[94.974684] Dynamic subtest ccs0: SUCCESS (6.161s)
[94.977666] Subtest manyslice: SUCCESS (37.707s)
[95.274734] [003/133] (922s left) kms_chamelium_edid (dp-edid-resolution-list)
[95.654446] Subtest dp-edid-resolution-list: SKIP (0.000s)
[96.443302] [004/133] (921s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[96.535644] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[96.539932] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[96.665007] [005/133] (920s left) kms_content_protection (content-type-change)
[96.807867] Starting subtest: content-type-change
[96.812594] Subtest content-type-change: SKIP (0.000s)
[96.931459] [006/133] (920s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[97.058136] Starting subtest: verify-pxp-execution-after-suspend-resume
[104.903305] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.844s)
[105.054910] [007/133] (912s left) gem_pread (display)
[105.133157] Subtest display: SKIP (0.000s)
[105.194679] [008/133] (912s left) gem_pipe_control_store_loop (reused-buffer)
[105.246428] Starting subtest: reused-buffer
[107.400625] Subtest reused-buffer: SUCCESS (2.154s)
[107.526105] [009/133] (910s left) gen3_render_tiledy_blits
[107.637558] [010/133] (910s left) gem_mmap_gtt (ptrace)
[107.692956] Subtest ptrace: SKIP (0.000s)
[107.743533] [011/133] (910s left) gem_exec_fence (syncobj-import)
[108.221258] Starting subtest: syncobj-import
[108.227433] Subtest syncobj-import: SUCCESS (0.009s)
[110.020461] [FACT gem_exec_fence (syncobj-import)] new: kernel.kmod_is_loaded.vgem: true
[110.023397] [012/133] (907s left) kms_pm_rpm (modeset-lpsp)
[112.084665] Starting subtest: modeset-lpsp
[113.570461] Subtest modeset-lpsp: SUCCESS (1.488s)
[113.659407] [013/133] (904s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[113.750968] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[113.753305] Starting dynamic subtest: pipe-A
[114.086415] Dynamic subtest pipe-A: SUCCESS (0.338s)
[114.094558] Starting dynamic subtest: pipe-B
[115.519506] Dynamic subtest pipe-B: SUCCESS (1.433s)
[115.533247] Starting dynamic subtest: pipe-C
[116.945297] Dynamic subtest pipe-C: SUCCESS (1.425s)
[116.953051] Starting dynamic subtest: pipe-D
[118.379308] Dynamic subtest pipe-D: SUCCESS (1.433s)
[118.381479] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.631s)
[119.531855] [014/133] (898s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[119.624896] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[119.629129] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[119.709658] [015/133] (898s left) api_intel_bb (object-reloc-purge-cache)
[119.766807] Starting subtest: object-reloc-purge-cache
[119.771451] Subtest object-reloc-purge-cache: SKIP (0.003s)
[119.863904] [016/133] (898s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[119.958416] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[119.963267] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[120.077516] [017/133] (898s left) gem_ctx_param (basic-default)
[120.137780] Starting subtest: basic-default
[120.140347] Subtest basic-default: SUCCESS (0.000s)
[120.213115] [018/133] (897s left) perf_pmu (most-busy-check-all)
[120.254832] Starting subtest: most-busy-check-all
[120.257163] Starting dynamic subtest: rcs0
[121.948773] Dynamic subtest rcs0: SUCCESS (1.693s)
[121.960605] Starting dynamic subtest: bcs0
[123.929599] Dynamic subtest bcs0: SUCCESS (1.979s)
[123.941661] Starting dynamic subtest: vcs0
[125.912686] Dynamic subtest vcs0: SUCCESS (1.981s)
[125.925061] Starting dynamic subtest: vcs1
[127.895702] Dynamic subtest vcs1: SUCCESS (1.982s)
[127.905791] Starting dynamic subtest: vecs0
[129.880411] Dynamic subtest vecs0: SUCCESS (1.983s)
[129.891835] Starting dynamic subtest: ccs0
[131.928895] Dynamic subtest ccs0: SUCCESS (2.047s)
[131.931937] Subtest most-busy-check-all: SUCCESS (11.674s)
[132.039115] [019/133] (886s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[132.136642] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[132.147968] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.010s)
[132.246471] [020/133] (885s left) kms_flip_tiling (flip-change-tiling)
[132.352220] Starting subtest: flip-change-tiling
[132.354479] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs
[132.526274] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.176s)
[132.536986] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs
[132.661209] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.133s)
[132.672574] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[132.794256] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.132s)
[132.805262] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4
[132.937641] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.143s)
[132.947599] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x
[133.081967] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.144s)
[133.100064] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear
[133.226200] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.144s)
[133.237832] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs
[133.360031] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.132s)
[133.370633] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs
[133.470783] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.110s)
[133.481691] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[133.605402] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.132s)
[133.617063] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4
[133.748430] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.144s)
[133.760450] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x
[133.893461] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.144s)
[133.907214] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear
[134.036995] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.143s)
[134.047245] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[134.170941] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.133s)
[134.183977] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[134.305284] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.132s)
[134.315068] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[134.415497] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.110s)
[134.424498] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4
[134.560370] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.144s)
[134.573540] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x
[134.703763] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.143s)
[134.714726] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear
[134.837043] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.132s)
[134.847502] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs
[134.981462] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.144s)
[134.992416] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs
[135.126543] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.144s)
[135.140817] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc
[135.270927] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.144s)
[135.282820] Starting dynamic subtest: pipe-A-eDP-1-4-to-4
[135.392577] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.121s)
[135.403487] Starting dynamic subtest: pipe-A-eDP-1-4-to-x
[135.548254] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.155s)
[135.558908] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear
[135.692263] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.143s)
[135.702636] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs
[135.838861] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.144s)
[135.854222] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs
[135.981370] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.143s)
[135.994076] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc
[136.126036] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.144s)
[136.137144] Starting dynamic subtest: pipe-A-eDP-1-x-to-4
[136.270500] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.144s)
[136.281938] Starting dynamic subtest: pipe-A-eDP-1-x-to-x
[136.392951] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.121s)
[136.404128] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear
[136.537827] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.144s)
[136.549085] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs
[136.681624] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.144s)
[136.692900] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs
[136.825919] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s)
[136.835917] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc
[136.970962] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.143s)
[136.981731] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4
[137.114681] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.144s)
[137.125581] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x
[137.259681] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.143s)
[137.270614] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear
[137.382035] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.122s)
[137.433335] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs
[138.700594] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.272s)
[138.711066] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs
[138.834952] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.133s)
[138.845395] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[138.968606] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.132s)
[138.979734] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4
[139.112536] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.144s)
[139.124052] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x
[139.255851] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s)
[139.271604] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear
[139.389059] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.133s)
[139.400182] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs
[139.522835] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.132s)
[139.534217] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs
[139.634368] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.110s)
[139.645309] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[139.768462] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.133s)
[139.780062] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4
[139.901063] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.132s)
[139.911941] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x
[140.044901] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.144s)
[140.055363] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear
[140.177823] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.132s)
[140.188179] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[140.311822] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.133s)
[140.323121] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[140.446624] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.132s)
[140.457980] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[140.556385] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.110s)
[140.567995] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4
[140.713094] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.155s)
[140.724551] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x
[140.855902] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.143s)
[140.866194] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear
[140.988994] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.132s)
[141.000255] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs
[141.134065] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.143s)
[141.145286] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs
[141.278515] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.143s)
[141.290295] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc
[141.423286] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.143s)
[141.434830] Starting dynamic subtest: pipe-B-eDP-1-4-to-4
[141.545197] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.121s)
[141.556994] Starting dynamic subtest: pipe-B-eDP-1-4-to-x
[141.689417] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.143s)
[141.701086] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear
[141.833437] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.144s)
[141.845066] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs
[141.977695] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.143s)
[141.988297] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs
[142.122638] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.144s)
[142.133619] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc
[142.256467] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.132s)
[142.267884] Starting dynamic subtest: pipe-B-eDP-1-x-to-4
[142.400061] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.143s)
[142.411366] Starting dynamic subtest: pipe-B-eDP-1-x-to-x
[142.522426] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.121s)
[142.534057] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear
[142.667470] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.144s)
[142.678829] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs
[142.810967] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.143s)
[142.822580] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs
[142.955321] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.143s)
[142.965529] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc
[143.088869] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.133s)
[143.101796] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4
[143.233118] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.143s)
[143.243937] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x
[143.378071] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.143s)
[143.388868] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear
[143.500644] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.121s)
[143.551756] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs
[144.747536] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.201s)
[144.762615] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs
[144.847066] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.099s)
[144.857430] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[144.946997] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.099s)
[144.958301] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4
[145.047117] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.099s)
[145.058980] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x
[145.157683] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.110s)
[145.168937] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear
[145.257379] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.099s)
[145.267840] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs
[145.358428] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.099s)
[145.369771] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs
[145.458299] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.099s)
[145.469519] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[145.558209] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.099s)
[145.568090] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4
[145.668737] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.110s)
[145.678072] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x
[145.779315] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.110s)
[145.788080] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear
[145.879309] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.099s)
[145.889801] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[145.979934] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.099s)
[145.990710] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[146.079824] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.099s)
[146.089645] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[146.179724] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.099s)
[146.190868] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4
[146.279708] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.099s)
[146.289343] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x
[146.390479] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.110s)
[146.400931] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear
[146.512988] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.122s)
[146.523150] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs
[146.612918] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.099s)
[146.622994] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs
[146.724681] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.110s)
[146.736843] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc
[146.824783] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.099s)
[146.834875] Starting dynamic subtest: pipe-C-eDP-1-4-to-4
[146.935815] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.110s)
[146.946239] Starting dynamic subtest: pipe-C-eDP-1-4-to-x
[147.046335] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.110s)
[147.054708] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear
[147.157458] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.110s)
[147.166883] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs
[147.268436] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.111s)
[147.278111] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs
[147.379655] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.110s)
[147.390705] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc
[147.479667] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.099s)
[147.488502] Starting dynamic subtest: pipe-C-eDP-1-x-to-4
[147.590824] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.111s)
[147.601258] Starting dynamic subtest: pipe-C-eDP-1-x-to-x
[147.702556] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.110s)
[147.713586] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear
[147.813566] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.110s)
[147.828303] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs
[147.924215] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.110s)
[147.932574] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs
[148.023876] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.099s)
[148.033486] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc
[148.124036] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.099s)
[148.133099] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4
[148.235216] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.110s)
[148.243907] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x
[148.346538] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.110s)
[148.358996] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear
[148.458037] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.110s)
[148.500400] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs
[149.770340] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.277s)
[149.781736] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs
[149.869745] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.099s)
[149.880933] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[149.970067] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.099s)
[149.981559] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4
[150.081231] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.110s)
[150.094913] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x
[150.192152] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.110s)
[150.207535] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear
[150.303226] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.110s)
[150.316083] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs
[150.403834] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.099s)
[150.415152] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs
[150.504049] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.099s)
[150.515415] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[150.603706] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.099s)
[150.615077] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4
[150.714663] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.110s)
[150.725232] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x
[150.825197] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.110s)
[150.838249] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear
[150.925071] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.099s)
[150.935279] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[151.025570] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.099s)
[151.036353] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[151.125465] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.099s)
[151.142810] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[151.225498] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.099s)
[151.234912] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4
[151.336590] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.110s)
[151.346048] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x
[151.447300] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.110s)
[151.458639] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear
[151.547328] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.099s)
[151.558925] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs
[151.647522] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.099s)
[151.660542] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs
[151.747701] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.099s)
[151.758667] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc
[151.847840] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.099s)
[151.857641] Starting dynamic subtest: pipe-D-eDP-1-4-to-4
[151.958753] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.110s)
[151.969464] Starting dynamic subtest: pipe-D-eDP-1-4-to-x
[152.069210] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.110s)
[152.079488] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear
[152.180277] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.110s)
[152.189533] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs
[152.292278] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.111s)
[152.303038] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs
[152.391559] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.098s)
[152.402531] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc
[152.491704] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.099s)
[152.502547] Starting dynamic subtest: pipe-D-eDP-1-x-to-4
[152.602802] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.110s)
[152.616588] Starting dynamic subtest: pipe-D-eDP-1-x-to-x
[152.725296] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.122s)
[152.734412] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear
[152.836788] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.110s)
[152.845905] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs
[152.947466] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.110s)
[152.957048] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs
[153.059207] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.110s)
[153.069864] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc
[153.158485] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.099s)
[153.168860] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4
[153.269315] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.110s)
[153.279523] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x
[153.381028] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.110s)
[153.391933] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear
[153.491956] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.110s)
[153.524898] Subtest flip-change-tiling: SUCCESS (21.175s)
[154.685338] [021/133] (863s left) dumb_buffer (invalid-bpp)
[154.749102] Starting subtest: invalid-bpp
[154.751544] Subtest invalid-bpp: SUCCESS (0.000s)
[154.847616] [022/133] (863s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[154.956077] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[154.960509] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[155.050506] [023/133] (863s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[155.139084] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[155.143590] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[156.235931] [024/133] (862s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[156.339147] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[156.343514] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[156.429556] [025/133] (861s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[156.537804] Starting subtest: 2x-plain-flip-ts-check-interruptible
[156.555278] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.016s)
[156.631744] [026/133] (861s left) syncobj_timeline (single-wait-all-available-signaled)
[156.689015] Starting subtest: single-wait-all-available-signaled
[156.691220] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[156.789685] [027/133] (861s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[156.887874] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[156.892351] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[156.991235] [028/133] (861s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[157.081615] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[157.085896] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[157.191783] [029/133] (861s left) gem_pxp (create-regular-buffer)
[157.297468] Starting subtest: create-regular-buffer
[157.299597] Subtest create-regular-buffer: SUCCESS (0.000s)
[157.401824] [030/133] (861s left) gem_lmem_swapping (heavy-verify-random-ccs)
[157.453822] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[157.498196] [031/133] (861s left) gem_ctx_persistence (legacy-engines-mixed)
[157.545098] Starting subtest: legacy-engines-mixed
[157.547042] Starting dynamic subtest: render
[157.588193] Dynamic subtest render: SUCCESS (0.042s)
[157.598064] Starting dynamic subtest: bsd1
[157.655355] Dynamic subtest bsd1: SUCCESS (0.066s)
[157.665034] Starting dynamic subtest: bsd2
[157.711516] Dynamic subtest bsd2: SUCCESS (0.055s)
[157.721118] Starting dynamic subtest: blt
[157.766922] Dynamic subtest blt: SUCCESS (0.053s)
[157.777061] Starting dynamic subtest: vebox
[157.808518] Dynamic subtest vebox: SUCCESS (0.040s)
[157.810586] Subtest legacy-engines-mixed: SUCCESS (0.263s)
[157.889588] [032/133] (860s left) gem_ctx_isolation (nonpriv)
[157.949775] Starting subtest: nonpriv
[157.951802] Starting dynamic subtest: rcs0
[158.175556] Dynamic subtest rcs0: SUCCESS (0.226s)
[158.187996] Starting dynamic subtest: bcs0
[158.405510] Dynamic subtest bcs0: SUCCESS (0.229s)
[158.416147] Starting dynamic subtest: vcs0
[158.656392] Dynamic subtest vcs0: SUCCESS (0.250s)
[158.666775] Starting dynamic subtest: vcs1
[160.128810] Dynamic subtest vcs1: SUCCESS (1.471s)
[160.138950] Starting dynamic subtest: vecs0
[162.097639] Dynamic subtest vecs0: SUCCESS (1.968s)
[162.109697] Starting dynamic subtest: ccs0
[164.195082] Dynamic subtest ccs0: SUCCESS (2.097s)
[164.197374] Subtest nonpriv: SUCCESS (6.245s)
[164.433416] [033/133] (854s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[164.538579] Starting subtest: fbcpsr-rgb565-draw-pwrite
[171.504179] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (6.968s)
[171.625296] [034/133] (847s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[171.738228] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[171.740543] Starting dynamic subtest: pipe-A-eDP-1
[171.884520] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.138s)
[171.895413] Starting dynamic subtest: pipe-B-eDP-1
[171.916252] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[171.925028] Starting dynamic subtest: pipe-C-eDP-1
[171.944462] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[171.952413] Starting dynamic subtest: pipe-D-eDP-1
[171.971151] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[171.973241] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.172s)
[174.206595] [035/133] (844s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[174.260096] Starting subtest: multi-wait-all-for-submit-submitted
[174.364557] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.104s)
[174.440233] [036/133] (844s left) kms_hdmi_inject (inject-4k)
[174.776569] Starting subtest: inject-4k
[175.095791] Subtest inject-4k: SUCCESS (0.319s)
[175.673658] [037/133] (843s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[175.744775] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[175.808218] [038/133] (843s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[175.894567] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[175.898971] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[175.992118] [039/133] (843s left) perf (unprivileged-single-ctx-counters)
[176.137500] Starting subtest: unprivileged-single-ctx-counters
[176.142005] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[176.182713] [040/133] (842s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[176.275203] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[180.778959] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.507s)
[181.947041] [041/133] (837s left) kms_cursor_edge_walk (256x256-top-edge)
[182.051799] Starting subtest: 256x256-top-edge
[182.054097] Starting dynamic subtest: pipe-A-eDP-1
[185.520378] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.468s)
[185.530039] Starting dynamic subtest: pipe-D-eDP-1
[188.670377] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.149s)
[188.672645] Subtest 256x256-top-edge: SUCCESS (6.620s)
[189.539920] [042/133] (829s left) kms_flip (flip-vs-suspend-interruptible)
[189.652521] Starting subtest: flip-vs-suspend-interruptible
[189.654848] Starting dynamic subtest: A-eDP1
[239.091294] Dynamic subtest A-eDP1: SUCCESS (4.564s)
[239.101244] Starting dynamic subtest: B-eDP1
[288.081231] Dynamic subtest B-eDP1: SUCCESS (4.434s)
[288.097738] Starting dynamic subtest: C-eDP1
[337.098382] Dynamic subtest C-eDP1: SUCCESS (4.558s)
[337.107545] Starting dynamic subtest: D-eDP1
[386.090284] Dynamic subtest D-eDP1: SUCCESS (4.440s)
[386.092637] Subtest flip-vs-suspend-interruptible: SUCCESS (18.006s)
[387.278342] [043/133] (631s left) gem_close (many-handles-one-vma)
[387.360360] Starting subtest: many-handles-one-vma
[387.404197] Subtest many-handles-one-vma: SUCCESS (0.045s)
[387.516167] [044/133] (631s left) gem_render_copy_redux (normal)
[387.575248] Starting subtest: normal
[387.839648] Subtest normal: SUCCESS (0.258s)
[387.963749] [045/133] (631s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[388.065636] Starting subtest: yf-tiled-64bpp-rotate-0
[388.069881] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[388.157219] [046/133] (631s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[388.237354] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[388.239256] Starting dynamic subtest: pipe-A-eDP-1
[388.246946] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[388.257793] Starting dynamic subtest: pipe-B-eDP-1
[388.265356] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[388.274297] Starting dynamic subtest: pipe-C-eDP-1
[388.281314] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[388.288980] Starting dynamic subtest: pipe-D-eDP-1
[388.295986] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[388.299319] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[390.520556] [047/133] (628s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping)
[390.628903] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping
[390.633029] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[390.705708] [048/133] (628s left) prime_busy (before-wait)
[390.763650] Starting subtest: before-wait
[390.765913] Starting dynamic subtest: rcs0
[390.794369] Dynamic subtest rcs0: SUCCESS (0.030s)
[390.804699] Starting dynamic subtest: bcs0
[390.834060] Dynamic subtest bcs0: SUCCESS (0.039s)
[390.843214] Starting dynamic subtest: vcs0
[390.874123] Dynamic subtest vcs0: SUCCESS (0.039s)
[390.882939] Starting dynamic subtest: vcs1
[390.915881] Dynamic subtest vcs1: SUCCESS (0.040s)
[390.924738] Starting dynamic subtest: vecs0
[390.956420] Dynamic subtest vecs0: SUCCESS (0.039s)
[390.965557] Starting dynamic subtest: ccs0
[390.997276] Dynamic subtest ccs0: SUCCESS (0.039s)
[391.107833] Subtest before-wait: SUCCESS (0.340s)
[391.184447] [049/133] (628s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[391.282771] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[391.285206] Starting dynamic subtest: pipe-A-eDP-1
[391.310473] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[391.319996] Starting dynamic subtest: pipe-B-eDP-1
[391.341037] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[391.348734] Starting dynamic subtest: pipe-C-eDP-1
[391.370006] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[391.378016] Starting dynamic subtest: pipe-D-eDP-1
[391.399891] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[391.404099] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[393.565708] [050/133] (625s left) kms_cursor_crc (cursor-offscreen-512x170)
[393.868491] Starting subtest: cursor-offscreen-512x170
[393.872865] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[394.010422] [051/133] (625s left) kms_flip (2x-wf_vblank-ts-check)
[394.107055] Starting subtest: 2x-wf_vblank-ts-check
[394.118137] Subtest 2x-wf_vblank-ts-check: SKIP (0.010s)
[394.198982] [052/133] (625s left) i915_pm_rps (waitboost)
[394.264678] Starting subtest: waitboost
[400.357881] Subtest waitboost: SUCCESS (6.055s)
[400.473925] [053/133] (619s left) kms_vblank (wait-busy)
[400.577741] Starting subtest: wait-busy
[400.579874] Starting dynamic subtest: pipe-A-eDP-1
[402.479842] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.894s)
[402.493399] Starting dynamic subtest: pipe-D-eDP-1
[405.052194] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.564s)
[405.054455] Subtest wait-busy: SUCCESS (4.461s)
[405.931043] [054/133] (613s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[406.041001] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[407.132334] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.089s)
[407.230241] [055/133] (612s left) kms_big_fb (linear-8bpp-rotate-90)
[407.333174] Starting subtest: linear-8bpp-rotate-90
[407.353700] Subtest linear-8bpp-rotate-90: SKIP (0.020s)
[407.501234] [056/133] (612s left) kms_properties (crtc-properties-atomic)
[407.593919] Starting subtest: crtc-properties-atomic
[407.595948] Starting dynamic subtest: pipe-A-eDP-1
[408.035429] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.439s)
[408.044851] Starting dynamic subtest: pipe-B-eDP-1
[409.168604] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.131s)
[409.178376] Starting dynamic subtest: pipe-C-eDP-1
[410.349994] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.178s)
[410.358854] Starting dynamic subtest: pipe-D-eDP-1
[411.572179] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.216s)
[411.574277] Subtest crtc-properties-atomic: SUCCESS (3.969s)
[412.440552] [057/133] (607s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[412.534034] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[412.624104] [058/133] (607s left) i915_drm_fdinfo (busy-idle)
[412.669330] Starting subtest: busy-idle
[412.671245] Starting dynamic subtest: rcs0
[412.704894] Dynamic subtest rcs0: SKIP (0.035s)
[412.713894] Starting dynamic subtest: bcs0
[412.717926] Dynamic subtest bcs0: SKIP (0.001s)
[412.726749] Starting dynamic subtest: vcs0
[412.731183] Dynamic subtest vcs0: SKIP (0.000s)
[412.739442] Starting dynamic subtest: vcs1
[412.743534] Dynamic subtest vcs1: SKIP (0.000s)
[412.751428] Starting dynamic subtest: vecs0
[412.755525] Dynamic subtest vecs0: SKIP (0.000s)
[412.763261] Starting dynamic subtest: ccs0
[412.767360] Dynamic subtest ccs0: SKIP (0.000s)
[412.771454] Subtest busy-idle: SKIP (0.042s)
[412.810156] [059/133] (607s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[412.909220] Starting subtest: flip-primary-invalidate-overlay
[424.588551] Subtest flip-primary-invalidate-overlay: SUCCESS (11.682s)
[424.755416] [060/133] (595s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[424.857384] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area
[424.859278] Starting dynamic subtest: pipe-A-eDP-1
[424.965642] Dynamic subtest pipe-A-eDP-1: SKIP (0.111s)
[424.977326] Starting dynamic subtest: pipe-B-eDP-1
[426.077530] Dynamic subtest pipe-B-eDP-1: SKIP (1.110s)
[426.082276] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.223s)
[427.330214] [061/133] (592s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[427.418154] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[431.998780] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.585s)
[433.146389] [062/133] (586s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[433.256589] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[440.043979] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.789s)
[440.196625] [063/133] (579s left) gem_exec_balancer (hang)
[440.452208] Starting subtest: hang
[442.239274] Subtest hang: SUCCESS (1.789s)
[442.356354] [064/133] (577s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[442.468099] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[442.470333] Starting dynamic subtest: pipe-A-default-mode
[443.660777] Dynamic subtest pipe-A-default-mode: SKIP (1.192s)
[443.665109] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.193s)
[443.822464] [065/133] (576s left) gem_create (create-ext-placement-all)
[443.995608] Starting subtest: create-ext-placement-all
[443.998484] Subtest create-ext-placement-all: SUCCESS (0.000s)
[444.089605] [066/133] (576s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[444.200309] Starting subtest: fbc-pr-overlay-plane-move-continuous-sf
[444.204496] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[444.272301] [067/133] (575s left) kms_chamelium_color (ctm-blue-to-red)
[444.382101] Subtest ctm-blue-to-red: SKIP (0.000s)
[444.429027] [068/133] (575s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[444.533069] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[448.915691] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.386s)
[450.047130] [069/133] (570s left) gem_exec_schedule (u-semaphore-noskip)
[450.122348] Starting subtest: u-semaphore-noskip
[450.521732] Subtest u-semaphore-noskip: SUCCESS (0.406s)
[450.864212] [070/133] (569s left) gem_exec_reloc (basic-concurrent16)
[450.917646] Subtest basic-concurrent16: SKIP (0.000s)
[451.001045] [071/133] (569s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[451.066000] Starting subtest: y-tiled-to-vebox-yf-tiled
[451.070459] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[451.256153] [072/133] (569s left) perf (per-context-mode-unprivileged)
[451.386062] Starting subtest: per-context-mode-unprivileged
[451.391266] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[451.430136] [073/133] (568s left) kms_atomic_interruptible (legacy-setmode)
[451.525972] Starting subtest: legacy-setmode
[451.528260] Starting dynamic subtest: pipe-A-eDP-1
[458.408558] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.880s)
[458.410908] Subtest legacy-setmode: SUCCESS (6.882s)
[459.252297] [074/133] (561s left) gem_exec_async (concurrent-writes)
[459.325509] Starting subtest: concurrent-writes
[459.327955] Starting dynamic subtest: rcs0
[459.341665] Dynamic subtest rcs0: SUCCESS (0.016s)
[459.354649] Starting dynamic subtest: bcs0
[459.356913] Dynamic subtest bcs0: SUCCESS (0.005s)
[459.366130] Starting dynamic subtest: vcs0
[459.368067] Dynamic subtest vcs0: SUCCESS (0.004s)
[459.377119] Starting dynamic subtest: vcs1
[459.379303] Dynamic subtest vcs1: SUCCESS (0.006s)
[459.387996] Starting dynamic subtest: vecs0
[459.390220] Dynamic subtest vecs0: SUCCESS (0.005s)
[459.398914] Starting dynamic subtest: ccs0
[459.401171] Dynamic subtest ccs0: SUCCESS (0.005s)
[459.403431] Subtest concurrent-writes: SUCCESS (0.045s)
[459.604878] [075/133] (560s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[459.698318] Starting subtest: y-tiled-8bpp-rotate-90
[459.702609] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[459.790269] [076/133] (560s left) gem_tiled_wc
[459.907702] [077/133] (560s left) gem_exec_nop (basic-series)
[459.985375] Starting subtest: basic-series
[476.292632] Subtest basic-series: SUCCESS (16.309s)
[476.519309] [078/133] (544s left) kms_atomic (plane-overlay-legacy)
[476.616739] Starting subtest: plane-overlay-legacy
[476.618761] Starting dynamic subtest: pipe-A-eDP-1
[477.058555] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.441s)
[477.061003] Subtest plane-overlay-legacy: SUCCESS (0.442s)
[477.923299] [079/133] (542s left) kms_sequence (queue-busy)
[478.003967] Starting subtest: queue-busy
[478.006128] Starting dynamic subtest: pipe-A-eDP-1
[479.931167] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.925s)
[479.941421] Starting dynamic subtest: pipe-B-eDP-1
[482.489543] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.557s)
[482.499335] Starting dynamic subtest: pipe-C-eDP-1
[485.077666] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.589s)
[485.086598] Starting dynamic subtest: pipe-D-eDP-1
[487.682105] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.604s)
[487.684287] Subtest queue-busy: SUCCESS (9.680s)
[488.545584] [080/133] (532s left) kms_pm_lpsp (kms-lpsp)
[489.653411] Starting subtest: kms-lpsp
[489.655536] Starting dynamic subtest: pipe-A-eDP-1
[489.798056] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.148s)
[490.093752] Subtest kms-lpsp: SUCCESS (0.444s)
[490.926158] [081/133] (529s left) kms_hdr (static-toggle-suspend)
[491.021966] Starting subtest: static-toggle-suspend
[491.028103] Subtest static-toggle-suspend: SKIP (0.000s)
[491.103679] [082/133] (529s left) gem_mmap (short-mmap)
[491.152975] Subtest short-mmap: SKIP (0.000s)
[491.207364] [083/133] (529s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[491.298183] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[491.302456] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[491.390182] [084/133] (529s left) i915_module_load (resize-bar)
[491.427489] Starting subtest: resize-bar
[491.433962] Subtest resize-bar: SKIP (0.006s)
[491.473941] [085/133] (529s left) vgem_basic (second-client)
[491.518981] Starting subtest: second-client
[491.544123] Subtest second-client: SUCCESS (0.022s)
[491.596828] [086/133] (529s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[491.648849] Starting subtest: etime-single-wait-for-submit-submitted
[491.757209] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.108s)
[491.832621] [087/133] (529s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[491.942317] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[491.946419] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[492.043231] [088/133] (528s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[492.139057] Starting subtest: fbcpsr-stridechange
[498.472898] Subtest fbcpsr-stridechange: SUCCESS (6.338s)
[498.598150] [089/133] (522s left) kms_plane_scaling (invalid-num-scalers)
[498.706913] Starting subtest: invalid-num-scalers
[498.709035] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[498.732895] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.025s)
[498.742130] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[498.767510] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.034s)
[498.783339] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[498.801156] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.033s)
[498.811210] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[498.836720] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.033s)
[498.839035] Subtest invalid-num-scalers: SUCCESS (0.132s)
[498.932388] [090/133] (522s left) gem_userptr_blits (unsync-unmap-cycles)
[498.991090] Subtest unsync-unmap-cycles: SKIP (0.000s)
[499.101576] [091/133] (522s left) kms_psr (pr-sprite-mmap-gtt)
[499.192046] Starting subtest: pr-sprite-mmap-gtt
[499.196319] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[499.268292] [092/133] (521s left) kms_draw_crc (draw-method-mmap-wc)
[499.357752] Starting subtest: draw-method-mmap-wc
[499.359898] Starting dynamic subtest: xrgb8888-untiled
[499.588869] Dynamic subtest xrgb8888-untiled: SUCCESS (0.233s)
[499.599233] Starting dynamic subtest: rgb565-untiled
[499.810899] Dynamic subtest rgb565-untiled: SUCCESS (0.220s)
[499.819793] Starting dynamic subtest: xrgb2101010-untiled
[500.033357] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[500.042552] Starting dynamic subtest: xbgr16161616f-untiled
[500.244690] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.210s)
[500.253324] Starting dynamic subtest: xrgb8888-xtiled
[500.378427] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.131s)
[500.391384] Starting dynamic subtest: rgb565-xtiled
[500.511114] Dynamic subtest rgb565-xtiled: SUCCESS (0.131s)
[500.519859] Starting dynamic subtest: xrgb2101010-xtiled
[500.622511] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s)
[500.631197] Starting dynamic subtest: xbgr16161616f-xtiled
[500.744618] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.120s)
[500.753304] Starting dynamic subtest: xrgb8888-4tiled
[500.888485] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.143s)
[500.896958] Starting dynamic subtest: rgb565-4tiled
[501.021979] Dynamic subtest rgb565-4tiled: SUCCESS (0.133s)
[501.033079] Starting dynamic subtest: xrgb2101010-4tiled
[501.177654] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.154s)
[501.186721] Starting dynamic subtest: xbgr16161616f-4tiled
[501.344484] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.166s)
[501.346471] Subtest draw-method-mmap-wc: SUCCESS (1.991s)
[501.461455] [093/133] (519s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[501.579287] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[502.204141] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.626s)
[502.378990] [094/133] (518s left) perf_pmu (busy-double-start)
[502.420728] Starting subtest: busy-double-start
[502.422958] Starting dynamic subtest: rcs0
[506.060288] Dynamic subtest rcs0: FAIL (3.589s)
[506.071871] Starting dynamic subtest: bcs0
[509.581843] Dynamic subtest bcs0: SUCCESS (3.572s)
[509.593604] Starting dynamic subtest: vcs0
[513.811596] Dynamic subtest vcs0: SUCCESS (4.228s)
[513.822859] Starting dynamic subtest: vcs1
[517.765788] Dynamic subtest vcs1: SUCCESS (3.951s)
[517.777566] Starting dynamic subtest: vecs0
[521.803426] Dynamic subtest vecs0: SUCCESS (4.035s)
[521.814955] Starting dynamic subtest: ccs0
[525.442912] Dynamic subtest ccs0: FAIL (3.565s)
[525.445278] Subtest busy-double-start: FAIL (22.951s)
[525.491592] [095/133] (495s left) kms_psr (fbc-psr-cursor-blt)
[525.586889] Starting subtest: fbc-psr-cursor-blt
[525.589253] Starting dynamic subtest: eDP-1
[525.593490] Dynamic subtest eDP-1: SKIP (0.000s)
[525.597672] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[525.661314] [096/133] (495s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[525.753500] Starting subtest: fbcpsr-1p-rte
[532.643346] Subtest fbcpsr-1p-rte: SUCCESS (6.892s)
[532.773434] [097/133] (488s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[532.866183] Starting subtest: fbc-psr2-primary-mmap-gtt
[532.868097] Starting dynamic subtest: eDP-1
[532.872155] Dynamic subtest eDP-1: SKIP (0.000s)
[532.876268] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s)
[532.938781] [098/133] (488s left) kms_debugfs (display-on-read-all)
[533.033178] Starting subtest: display-on-read-all
[533.198194] Subtest display-on-read-all: SUCCESS (0.167s)
[533.345085] [099/133] (488s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[533.407909] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[533.516904] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.107s)
[533.593999] [100/133] (487s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[533.747608] Starting subtest: cursor-rapid-movement-32x32
[533.799098] Subtest cursor-rapid-movement-32x32: SKIP (0.046s)
[534.057626] [101/133] (487s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[534.111219] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[534.113516] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[534.220268] [102/133] (487s left) gem_spin_batch (legacy)
[534.278048] Starting subtest: legacy
[534.280457] Starting dynamic subtest: default
[537.518031] Dynamic subtest default: SUCCESS (3.234s)
[537.530153] Starting dynamic subtest: render
[540.756856] Dynamic subtest render: SUCCESS (3.235s)
[540.768124] Starting dynamic subtest: bsd
[543.992973] Dynamic subtest bsd: SUCCESS (3.232s)
[544.002043] Starting dynamic subtest: bsd1
[547.231365] Dynamic subtest bsd1: SUCCESS (3.236s)
[547.240251] Starting dynamic subtest: bsd2
[550.467911] Dynamic subtest bsd2: SUCCESS (3.233s)
[550.479157] Starting dynamic subtest: blt
[553.708106] Dynamic subtest blt: SUCCESS (3.236s)
[553.720167] Starting dynamic subtest: vebox
[556.947738] Dynamic subtest vebox: SUCCESS (3.234s)
[556.950074] Subtest legacy: SUCCESS (22.662s)
[557.329556] [103/133] (464s left) kms_properties (get_properties-sanity-atomic)
[557.432184] Starting subtest: get_properties-sanity-atomic
[557.434453] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[557.507271] [104/133] (464s left) i915_pm_rpm (gem-mmap-type)
[559.421160] Starting subtest: gem-mmap-type
[559.424002] Starting dynamic subtest: wb-smem0
[563.235901] Dynamic subtest wb-smem0: SUCCESS (3.813s)
[563.244941] Starting dynamic subtest: wc-smem0
[566.107747] Dynamic subtest wc-smem0: SUCCESS (2.871s)
[566.116510] Starting dynamic subtest: uc-smem0
[569.270959] Dynamic subtest uc-smem0: SUCCESS (3.159s)
[569.273103] Subtest gem-mmap-type: SUCCESS (9.847s)
[569.357731] [105/133] (452s left) kms_color (legacy-gamma)
[569.453902] Starting subtest: legacy-gamma
[569.456029] Starting dynamic subtest: pipe-A-eDP-1
[570.156895] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.702s)
[570.167269] Starting dynamic subtest: pipe-B-eDP-1
[571.640188] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.483s)
[571.648829] Starting dynamic subtest: pipe-C-eDP-1
[572.953466] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.309s)
[572.972076] Starting dynamic subtest: pipe-D-eDP-1
[574.341114] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.389s)
[574.343446] Subtest legacy-gamma: SUCCESS (4.888s)
[575.136093] [106/133] (446s left) kms_chamelium_hpd (hdmi-hpd)
[575.523548] Subtest hdmi-hpd: SKIP (0.000s)
[576.306872] [107/133] (445s left) gem_exec_capture (capture-invisible)
[576.385720] Starting subtest: capture-invisible
[576.388042] Starting dynamic subtest: smem0
[576.392103] Dynamic subtest smem0: SKIP (0.000s)
[576.396174] Subtest capture-invisible: SKIP (0.001s)
[576.509889] [108/133] (445s left) prime_self_import (basic-with_fd_dup)
[576.549838] Starting subtest: basic-with_fd_dup
[576.571503] Subtest basic-with_fd_dup: SUCCESS (0.025s)
[576.676431] [109/133] (445s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[576.782786] Starting subtest: x-tiled-32bpp-rotate-0
[578.250636] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.467s)
[578.369874] [110/133] (443s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[578.457366] Starting subtest: stress-xrgb8888-ytiled
[578.461092] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[578.521913] [111/133] (443s left) gem_bad_reloc (negative-reloc-lut)
[578.581883] Subtest negative-reloc-lut: SKIP (0.000s)
[578.645340] [112/133] (443s left) kms_psr (psr-cursor-mmap-cpu)
[578.735453] Starting subtest: psr-cursor-mmap-cpu
[578.737370] Starting dynamic subtest: eDP-1
[580.499477] Dynamic subtest eDP-1: SUCCESS (1.762s)
[580.501427] Subtest psr-cursor-mmap-cpu: SUCCESS (1.763s)
[581.328994] [113/133] (440s left) gen9_exec_parse (batch-without-end)
[581.399934] Subtest batch-without-end: SKIP (0.000s)
[581.472298] [114/133] (440s left) gem_userptr_blits (stress-purge)
[581.532623] Starting subtest: stress-purge
[586.910237] Subtest stress-purge: SUCCESS (5.378s)
[587.044311] [115/133] (435s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[587.182208] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[593.816909] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.633s)
[593.954717] [116/133] (428s left) gem_partial_pwrite_pread (write-uncached)
[594.021474] Subtest write-uncached: SKIP (0.000s)
[594.089517] [117/133] (428s left) sysfs_preempt_timeout (timeout)
[594.143297] Starting subtest: timeout
[594.145716] Starting dynamic subtest: vecs0
[604.283665] Dynamic subtest vecs0: SUCCESS (10.133s)
[604.296316] Starting dynamic subtest: ccs0
[605.582480] Dynamic subtest ccs0: SUCCESS (1.298s)
[605.593324] Starting dynamic subtest: vcs0
[615.228121] Dynamic subtest vcs0: SUCCESS (9.642s)
[615.240041] Starting dynamic subtest: bcs0
[616.455690] Dynamic subtest bcs0: SUCCESS (1.226s)
[616.467939] Starting dynamic subtest: rcs0
[617.679658] Dynamic subtest rcs0: SUCCESS (1.224s)
[617.693653] Starting dynamic subtest: vcs1
[627.261662] Dynamic subtest vcs1: SUCCESS (9.580s)
[627.264370] Subtest timeout: SUCCESS (33.115s)
[627.336853] [118/133] (394s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[627.414770] Starting subtest: map-fixed-invalidate-overlap
[627.419201] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[627.539705] [119/133] (394s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[627.664235] Starting subtest: cursorA-vs-flipA-toggle
[638.843501] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.179s)
[639.643228] [120/133] (382s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[639.713605] Starting subtest: multi-wait-available-submitted-signaled
[639.716023] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s)
[639.817160] [121/133] (382s left) gem_media_fill (media-fill)
[639.885378] Subtest media-fill: SKIP (0.000s)
[639.999203] [122/133] (382s left) gem_exec_params (secure-non-root)
[640.056503] Starting subtest: secure-non-root
[640.061128] Subtest secure-non-root: SKIP (0.000s)
[640.151175] [123/133] (382s left) kms_plane_multiple (2x-tiling-none)
[640.257024] Starting subtest: 2x-tiling-none
[640.261358] Subtest 2x-tiling-none: SKIP (0.000s)
[640.331893] [124/133] (382s left) kms_addfb_basic (no-handle)
[640.388732] Starting subtest: no-handle
[640.391017] Subtest no-handle: SUCCESS (0.000s)
[640.528521] [125/133] (382s left) syncobj_wait (reset-during-wait-for-submit)
[640.579700] Starting subtest: reset-during-wait-for-submit
[640.682455] Subtest reset-during-wait-for-submit: SUCCESS (0.102s)
[640.782178] [126/133] (381s left) api_intel_allocator (two-level-inception-interruptible)
[640.831002] Starting subtest: two-level-inception-interruptible
[646.238039] Subtest two-level-inception-interruptible: SUCCESS (5.408s)
[646.373113] [127/133] (376s left) syncobj_basic (bad-flags-fd-to-handle)
[646.436556] Starting subtest: bad-flags-fd-to-handle
[646.438419] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[646.558358] [128/133] (376s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[646.670628] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[646.674646] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[646.780110] [129/133] (375s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[646.922271] Starting subtest: flip-vs-cursor-busy-crc-legacy
[647.711325] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.790s)
[648.547866] [130/133] (374s left) kms_lease (multimaster-lease)
[648.680356] Starting subtest: multimaster-lease
[648.685212] Subtest multimaster-lease: SUCCESS (0.007s)
[648.813261] [131/133] (374s left) kms_psr (fbc-pr-dpms)
[648.931385] Starting subtest: fbc-pr-dpms
[648.935783] Subtest fbc-pr-dpms: SKIP (0.000s)
[649.030186] [132/133] (373s left) gem_exec_whisper (basic-forked-all)
[649.121551] Starting subtest: basic-forked-all
[662.282078] Subtest basic-forked-all: SUCCESS (13.163s)
[662.471189] [133/133] (360s left) i915_query (query-garbage)
[662.520869] Starting subtest: query-garbage
[662.523046] Subtest query-garbage: SUCCESS (0.000s)
[662.651294] Closing watchdogs
results: parsing output: 0/ for test: perf_pmu
results: parsing output: 1/ for test: gem_exec_schedule
results: parsing output: 2/ for test: kms_chamelium_edid
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_content_protection
results: parsing output: 5/ for test: gem_pxp
results: parsing output: 6/ for test: gem_pread
results: parsing output: 7/ for test: gem_pipe_control_store_loop
results: parsing output: 8/ for test: gen3_render_tiledy_blits
results: parsing output: 9/ for test: gem_mmap_gtt
results: parsing output: 10/ for test: gem_exec_fence
results: parsing output: 11/ for test: kms_pm_rpm
results: parsing output: 12/ for test: kms_plane_scaling
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: api_intel_bb
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: gem_ctx_param
results: parsing output: 17/ for test: perf_pmu
results: parsing output: 18/ for test: kms_flip
results: parsing output: 19/ for test: kms_flip_tiling
results: parsing output: 20/ for test: dumb_buffer
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_ccs
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_flip
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: gem_pxp
results: parsing output: 29/ for test: gem_lmem_swapping
results: parsing output: 30/ for test: gem_ctx_persistence
results: parsing output: 31/ for test: gem_ctx_isolation
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_ccs
results: parsing output: 34/ for test: syncobj_wait
results: parsing output: 35/ for test: kms_hdmi_inject
results: parsing output: 36/ for test: kms_pipe_b_c_ivb
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: perf
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_cursor_edge_walk
results: parsing output: 41/ for test: kms_flip
results: parsing output: 42/ for test: gem_close
results: parsing output: 43/ for test: gem_render_copy_redux
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: kms_ccs
results: parsing output: 46/ for test: kms_plane
results: parsing output: 47/ for test: prime_busy
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: kms_cursor_crc
results: parsing output: 50/ for test: kms_flip
results: parsing output: 51/ for test: i915_pm_rps
results: parsing output: 52/ for test: kms_vblank
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: kms_properties
results: parsing output: 56/ for test: kms_addfb_basic
results: parsing output: 57/ for test: i915_drm_fdinfo
results: parsing output: 58/ for test: kms_psr_stress_test
results: parsing output: 59/ for test: kms_psr2_sf
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: gem_exec_balancer
results: parsing output: 63/ for test: kms_flip_scaled_crc
results: parsing output: 64/ for test: gem_create
results: parsing output: 65/ for test: kms_psr2_sf
results: parsing output: 66/ for test: kms_chamelium_color
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_exec_schedule
results: parsing output: 69/ for test: gem_exec_reloc
results: parsing output: 70/ for test: gem_render_copy
results: parsing output: 71/ for test: perf
results: parsing output: 72/ for test: kms_atomic_interruptible
results: parsing output: 73/ for test: gem_exec_async
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: gem_tiled_wc
results: parsing output: 76/ for test: gem_exec_nop
results: parsing output: 77/ for test: kms_atomic
results: parsing output: 78/ for test: kms_sequence
results: parsing output: 79/ for test: kms_pm_lpsp
results: parsing output: 80/ for test: kms_hdr
results: parsing output: 81/ for test: gem_mmap
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: i915_module_load
results: parsing output: 84/ for test: vgem_basic
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_plane_scaling
results: parsing output: 89/ for test: gem_userptr_blits
results: parsing output: 90/ for test: kms_psr
results: parsing output: 91/ for test: kms_draw_crc
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: perf_pmu
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_psr
results: parsing output: 97/ for test: kms_debugfs
results: parsing output: 98/ for test: syncobj_timeline
results: parsing output: 99/ for test: kms_cursor_crc
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: gem_spin_batch
results: parsing output: 102/ for test: kms_properties
results: parsing output: 103/ for test: i915_pm_rpm
results: parsing output: 104/ for test: kms_color
results: parsing output: 105/ for test: kms_chamelium_hpd
results: parsing output: 106/ for test: gem_exec_capture
results: parsing output: 107/ for test: prime_self_import
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: kms_pipe_stress
results: parsing output: 110/ for test: gem_bad_reloc
results: parsing output: 111/ for test: kms_psr
results: parsing output: 112/ for test: gen9_exec_parse
results: parsing output: 113/ for test: gem_userptr_blits
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: gem_partial_pwrite_pread
results: parsing output: 116/ for test: sysfs_preempt_timeout
results: parsing output: 117/ for test: gem_userptr_blits
results: parsing output: 118/ for test: kms_cursor_legacy
results: parsing output: 119/ for test: syncobj_timeline
results: parsing output: 120/ for test: gem_media_fill
results: parsing output: 121/ for test: gem_exec_params
results: parsing output: 122/ for test: kms_plane_multiple
results: parsing output: 123/ for test: kms_addfb_basic
results: parsing output: 124/ for test: syncobj_wait
results: parsing output: 125/ for test: api_intel_allocator
results: parsing output: 126/ for test: syncobj_basic
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_cursor_legacy
results: parsing output: 129/ for test: kms_lease
results: parsing output: 130/ for test: kms_psr
results: parsing output: 131/ for test: gem_exec_whisper
results: parsing output: 132/ for test: i915_query
Done.