[57.704659] Initializing watchdogs
[57.704726]   /dev/watchdog0
[57.724414] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[57.735091] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[57.738903] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.741385] [001/131] (960s left) kms_getfb (getfb-handle-valid)
[57.935214] Starting subtest: getfb-handle-valid
[57.936142] Subtest getfb-handle-valid: SUCCESS (0.000s)
[58.083244] [002/131] (960s left) kms_plane (pixel-format-source-clamping)
[58.269124] Starting subtest: pixel-format-source-clamping
[58.311102] Starting dynamic subtest: pipe-A-plane-0
[66.573465] Dynamic subtest pipe-A-plane-0: SUCCESS (8.285s)
[66.606198] Starting dynamic subtest: pipe-A-plane-3
[70.850307] Dynamic subtest pipe-A-plane-3: SUCCESS (4.282s)
[70.858409] Starting dynamic subtest: pipe-A-plane-5
[70.859259] Dynamic subtest pipe-A-plane-5: SUCCESS (0.000s)
[71.089063] Starting dynamic subtest: pipe-B-plane-0
[78.973245] Dynamic subtest pipe-B-plane-0: SUCCESS (7.900s)
[78.981272] Starting dynamic subtest: pipe-B-plane-3
[83.290269] Dynamic subtest pipe-B-plane-3: SUCCESS (4.317s)
[83.299539] Starting dynamic subtest: pipe-B-plane-5
[83.300803] Dynamic subtest pipe-B-plane-5: SUCCESS (0.000s)
[83.381204] Subtest pixel-format-source-clamping: SUCCESS (25.142s)
[83.673334] [003/131] (934s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[83.861274] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.000s)
[83.921673] [004/131] (934s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[84.127265] Starting subtest: yf-tiled-32bpp-rotate-0
[84.128923] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[84.276160] [005/131] (934s left) gem_flink_race (flink_name)
[84.319738] Starting subtest: flink_name
[89.718414] Subtest flink_name: SUCCESS (5.398s)
[89.942154] [006/131] (928s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs)
[90.057794] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs
[90.059713] Subtest yf-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[90.278280] [007/131] (928s left) perf_pmu (semaphore-wait-idle)
[90.345377] Starting subtest: semaphore-wait-idle
[90.346286] Starting dynamic subtest: rcs0
[90.884874] Dynamic subtest rcs0: SUCCESS (0.538s)
[90.895777] Starting dynamic subtest: bcs0
[91.397976] Dynamic subtest bcs0: SUCCESS (0.512s)
[91.408807] Starting dynamic subtest: vcs0
[91.910882] Dynamic subtest vcs0: SUCCESS (0.513s)
[91.922023] Starting dynamic subtest: vcs1
[92.424053] Dynamic subtest vcs1: SUCCESS (0.512s)
[92.434761] Starting dynamic subtest: vecs0
[92.937800] Dynamic subtest vecs0: SUCCESS (0.513s)
[92.948790] Starting dynamic subtest: vecs1
[93.450120] Dynamic subtest vecs1: SUCCESS (0.512s)
[93.461053] Starting dynamic subtest: ccs0
[93.962517] Dynamic subtest ccs0: SUCCESS (0.512s)
[93.964303] Subtest semaphore-wait-idle: SUCCESS (3.616s)
[94.160215] [008/131] (924s left) gen7_exec_parse (basic-allocation)
[94.243602] Subtest basic-allocation: SKIP (0.000s)
[94.330692] [009/131] (924s left) sw_sync (sync_merge_invalid)
[94.374174] Starting subtest: sync_merge_invalid
[94.417992] Subtest sync_merge_invalid: SUCCESS (0.044s)
[94.489378] [010/131] (924s left) kms_frontbuffer_tracking (psr-slowdraw)
[94.679685] Starting subtest: psr-slowdraw
[94.681391] Subtest psr-slowdraw: SKIP (0.000s)
[94.821024] [011/131] (924s left) core_getclient
[95.045226] [012/131] (924s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[95.232496] Starting subtest: flip-vs-cursor-busy-crc-atomic
[96.010808] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.777s)
[96.287336] [013/131] (922s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[96.358966] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[96.359937] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[96.473400] [014/131] (922s left) gem_exec_fence (basic-wait)
[96.699293] Starting subtest: basic-wait
[96.700691] Starting dynamic subtest: rcs0
[96.793667] Dynamic subtest rcs0: SUCCESS (0.095s)
[96.804074] Starting dynamic subtest: bcs0
[96.849986] Dynamic subtest bcs0: SUCCESS (0.056s)
[96.862235] Starting dynamic subtest: vcs0
[96.907885] Dynamic subtest vcs0: SUCCESS (0.057s)
[96.933268] Starting dynamic subtest: vcs1
[96.965747] Dynamic subtest vcs1: SUCCESS (0.057s)
[96.999577] Starting dynamic subtest: vecs0
[97.026871] Dynamic subtest vecs0: SUCCESS (0.061s)
[97.044491] Starting dynamic subtest: vecs1
[97.078094] Dynamic subtest vecs1: SUCCESS (0.051s)
[97.107665] Starting dynamic subtest: ccs0
[97.133877] Dynamic subtest ccs0: SUCCESS (0.055s)
[97.134920] Subtest basic-wait: SUCCESS (0.435s)
[97.880800] [FACT gem_exec_fence (basic-wait)] new: kernel.kmod_is_loaded.vgem: true
[97.882789] [015/131] (921s left) perf_pmu (busy-idle)
[97.953481] Starting subtest: busy-idle
[97.954421] Starting dynamic subtest: rcs0
[98.692842] Dynamic subtest rcs0: SUCCESS (0.738s)
[98.705867] Starting dynamic subtest: bcs0
[99.357688] Dynamic subtest bcs0: SUCCESS (0.664s)
[99.370676] Starting dynamic subtest: vcs0
[100.021710] Dynamic subtest vcs0: SUCCESS (0.663s)
[100.034895] Starting dynamic subtest: vcs1
[100.687674] Dynamic subtest vcs1: SUCCESS (0.665s)
[100.700571] Starting dynamic subtest: vecs0
[101.351934] Dynamic subtest vecs0: SUCCESS (0.663s)
[101.365505] Starting dynamic subtest: vecs1
[102.017776] Dynamic subtest vecs1: SUCCESS (0.665s)
[102.031493] Starting dynamic subtest: ccs0
[102.680665] Dynamic subtest ccs0: SUCCESS (0.662s)
[102.682445] Subtest busy-idle: SUCCESS (4.727s)
[102.821659] [016/131] (916s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[103.027464] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[103.075508] [017/131] (916s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[103.269102] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[103.269911] Starting dynamic subtest: pipe-A
[103.833915] Dynamic subtest pipe-A: SUCCESS (0.564s)
[103.854884] Starting dynamic subtest: pipe-B
[104.482798] Dynamic subtest pipe-B: SUCCESS (0.648s)
[104.506070] Starting dynamic subtest: pipe-C
[105.130797] Dynamic subtest pipe-C: SUCCESS (0.647s)
[105.154245] Starting dynamic subtest: pipe-D
[105.779618] Dynamic subtest pipe-D: SUCCESS (0.648s)
[105.780732] Subtest plane-downscale-factor-0-5-with-modifiers: SUCCESS (2.511s)
[106.127660] [018/131] (913s left) gem_exec_schedule (preempt-user)
[106.243557] Starting subtest: preempt-user
[106.244477] Starting dynamic subtest: rcs0
[106.312210] Dynamic subtest rcs0: SUCCESS (0.069s)
[106.321537] Starting dynamic subtest: bcs0
[106.345848] Dynamic subtest bcs0: SUCCESS (0.033s)
[106.355283] Starting dynamic subtest: vcs0
[106.381654] Dynamic subtest vcs0: SUCCESS (0.035s)
[106.391436] Starting dynamic subtest: vcs1
[106.417463] Dynamic subtest vcs1: SUCCESS (0.036s)
[106.426918] Starting dynamic subtest: vecs0
[106.451897] Dynamic subtest vecs0: SUCCESS (0.034s)
[106.461420] Starting dynamic subtest: vecs1
[106.486892] Dynamic subtest vecs1: SUCCESS (0.035s)
[106.496439] Starting dynamic subtest: ccs0
[106.524193] Dynamic subtest ccs0: SUCCESS (0.037s)
[106.525131] Subtest preempt-user: SUCCESS (0.281s)
[106.957341] [019/131] (912s left) gem_ctx_persistence (engines-hang)
[107.048310] Starting subtest: engines-hang
[107.049218] Starting dynamic subtest: rcs0
[107.169546] Dynamic subtest rcs0: SUCCESS (0.121s)
[107.179530] Starting dynamic subtest: bcs0
[107.258300] Dynamic subtest bcs0: SUCCESS (0.088s)
[107.271187] Starting dynamic subtest: vcs0
[107.358347] Dynamic subtest vcs0: SUCCESS (0.099s)
[107.397437] Starting dynamic subtest: vcs1
[107.398879] Dynamic subtest vcs1: SUCCESS (0.038s)
[107.415221] Starting dynamic subtest: vecs0
[107.520399] Dynamic subtest vecs0: SUCCESS (0.122s)
[107.560398] Starting dynamic subtest: vecs1
[107.574375] Dynamic subtest vecs1: SUCCESS (0.053s)
[107.592432] Starting dynamic subtest: ccs0
[107.682284] Dynamic subtest ccs0: SUCCESS (0.107s)
[107.684174] Subtest engines-hang: SUCCESS (0.634s)
[107.865846] [020/131] (911s left) gem_ctx_param (set-priority-invalid-size)
[107.944341] Starting subtest: set-priority-invalid-size
[107.945245] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[108.036841] [021/131] (911s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[108.112128] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[108.113030] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[108.240544] [022/131] (911s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[108.321118] Starting subtest: single-wait-all-for-submit-available-signaled
[108.322036] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[108.476714] [023/131] (911s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[108.676665] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[108.678376] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[108.838715] [024/131] (911s left) gem_exec_params (invalid-flag)
[108.920721] Starting subtest: invalid-flag
[108.921794] Subtest invalid-flag: SUCCESS (0.000s)
[109.055847] [025/131] (910s left) gem_exec_params (no-blt)
[109.141368] Starting subtest: no-blt
[109.143349] Subtest no-blt: SUCCESS (0.001s)
[109.319817] [026/131] (910s left) kms_content_protection (dp-mst-type-0)
[109.580130] Starting subtest: dp-mst-type-0
[109.581953] Subtest dp-mst-type-0: SKIP (0.000s)
[109.767112] [027/131] (910s left) gem_exec_reloc (basic-cpu-read)
[109.851767] Subtest basic-cpu-read: SKIP (0.000s)
[109.929229] [028/131] (910s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[110.136430] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[110.836197] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.699s)
[111.042634] [029/131] (909s left) gem_pxp (create-regular-context-2)
[113.649352] Starting subtest: create-regular-context-2
[113.651970] Subtest create-regular-context-2: SKIP (0.000s)
[113.762232] [030/131] (906s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc)
[113.958219] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc
[113.959158] Starting dynamic subtest: pipe-A-DP-3
[113.967462] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[113.976753] Starting dynamic subtest: pipe-B-DP-3
[113.985116] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[113.994279] Starting dynamic subtest: pipe-C-DP-3
[114.002495] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[114.011833] Starting dynamic subtest: pipe-D-DP-3
[114.022749] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[114.024923] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[114.434869] [031/131] (905s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[114.637040] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[114.638772] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[114.794110] [032/131] (905s left) i915_drm_fdinfo (memory-info-idle)
[114.865433] Starting subtest: memory-info-idle
[114.866389] Starting dynamic subtest: lmem0
[114.939131] Dynamic subtest lmem0: SUCCESS (0.073s)
[114.948475] Starting dynamic subtest: smem0
[114.981909] Dynamic subtest smem0: SUCCESS (0.042s)
[114.982940] Subtest memory-info-idle: SUCCESS (0.117s)
[115.085702] [033/131] (905s left) kms_busy (extended-modeset-hang-newfb)
[115.286249] Starting subtest: extended-modeset-hang-newfb
[115.288307] Starting dynamic subtest: pipe-A
[130.996392] Dynamic subtest pipe-A: SUCCESS (15.708s)
[131.014012] Starting dynamic subtest: pipe-D
[146.706788] Dynamic subtest pipe-D: SUCCESS (15.704s)
[146.710295] Subtest extended-modeset-hang-newfb: SUCCESS (31.422s)
[147.006236] [034/131] (873s left) kms_invalid_mode (zero-hdisplay)
[147.203039] Starting subtest: zero-hdisplay
[147.203944] Starting dynamic subtest: pipe-A-DP-3
[147.288040] Dynamic subtest pipe-A-DP-3: SUCCESS (0.085s)
[147.302247] Starting dynamic subtest: pipe-B-DP-3
[147.303513] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s)
[147.316055] Starting dynamic subtest: pipe-C-DP-3
[147.317063] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[147.329283] Starting dynamic subtest: pipe-D-DP-3
[147.330236] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s)
[147.331171] Subtest zero-hdisplay: SUCCESS (0.093s)
[147.531066] [035/131] (873s left) kms_atomic_transition (plane-all-transition)
[147.729368] Starting subtest: plane-all-transition
[147.731410] Starting dynamic subtest: pipe-A-DP-3
[151.471971] Dynamic subtest pipe-A-DP-3: SUCCESS (3.741s)
[151.610042] Starting dynamic subtest: pipe-B-DP-3
[155.503740] Dynamic subtest pipe-B-DP-3: SUCCESS (3.905s)
[155.610439] Subtest plane-all-transition: SUCCESS (7.880s)
[155.837235] [036/131] (864s left) kms_flip (wf_vblank-ts-check-interruptible)
[156.039838] Starting subtest: wf_vblank-ts-check-interruptible
[156.044449] Starting dynamic subtest: A-DP3
[164.135642] Dynamic subtest A-DP3: SUCCESS (8.091s)
[164.147671] Starting dynamic subtest: B-DP3
[172.163732] Dynamic subtest B-DP3: SUCCESS (8.027s)
[172.174308] Starting dynamic subtest: C-DP3
[180.200401] Dynamic subtest C-DP3: SUCCESS (8.036s)
[180.210820] Starting dynamic subtest: D-DP3
[188.239582] Dynamic subtest D-DP3: SUCCESS (8.038s)
[188.241928] Subtest wf_vblank-ts-check-interruptible: SUCCESS (32.202s)
[188.556732] [037/131] (832s left) prime_busy (after-wait)
[188.640739] Starting subtest: after-wait
[188.645487] Starting dynamic subtest: rcs0
[188.698869] Dynamic subtest rcs0: SUCCESS (0.053s)
[188.709392] Starting dynamic subtest: bcs0
[188.749998] Dynamic subtest bcs0: SUCCESS (0.050s)
[188.764176] Starting dynamic subtest: vcs0
[188.794301] Dynamic subtest vcs0: SUCCESS (0.043s)
[188.819349] Starting dynamic subtest: vcs1
[188.839130] Dynamic subtest vcs1: SUCCESS (0.043s)
[188.863010] Starting dynamic subtest: vecs0
[188.880290] Dynamic subtest vecs0: SUCCESS (0.040s)
[188.896039] Starting dynamic subtest: vecs1
[188.921580] Dynamic subtest vecs1: SUCCESS (0.040s)
[188.937372] Starting dynamic subtest: ccs0
[188.962988] Dynamic subtest ccs0: SUCCESS (0.040s)
[189.070599] Subtest after-wait: SUCCESS (0.430s)
[189.210075] [038/131] (831s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[189.405758] Starting subtest: cursorA-vs-flipA-atomic-transitions
[200.383270] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (10.977s)
[200.660216] [039/131] (820s left) gem_create (create-massive)
[200.740311] Starting subtest: create-massive
[200.741214] Subtest create-massive: SUCCESS (0.000s)
[200.947472] [040/131] (820s left) syncobj_wait (wait-all-delayed-signal)
[201.032488] Starting subtest: wait-all-delayed-signal
[201.136300] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[201.249597] [041/131] (819s left) gem_exec_balancer (parallel-keep-submit-fence)
[201.608424] Starting subtest: parallel-keep-submit-fence
[203.922103] Subtest parallel-keep-submit-fence: SUCCESS (2.322s)
[204.051805] [042/131] (817s left) i915_pm_rc6_residency (rc6-idle)
[204.129353] Starting subtest: rc6-idle
[204.150514] Starting dynamic subtest: gt0-rcs0
[228.388521] Dynamic subtest gt0-rcs0: SUCCESS (24.237s)
[228.406396] Starting dynamic subtest: gt0-bcs0
[252.631843] Dynamic subtest gt0-bcs0: SUCCESS (24.239s)
[252.644932] Starting dynamic subtest: gt0-vcs0
[276.961890] Dynamic subtest gt0-vcs0: SUCCESS (24.327s)
[276.972174] Starting dynamic subtest: gt0-vecs0
[301.280963] Dynamic subtest gt0-vecs0: SUCCESS (24.318s)
[301.290934] Starting dynamic subtest: gt0-ccs0
[325.529345] Dynamic subtest gt0-ccs0: SUCCESS (24.247s)
[325.533706] Subtest rc6-idle: SUCCESS (121.403s)
[325.695761] [043/131] (695s left) kms_color (gamma)
[325.891568] Starting subtest: gamma
[325.892425] Starting dynamic subtest: pipe-A-DP-3
[326.584025] Dynamic subtest pipe-A-DP-3: SUCCESS (0.690s)
[326.600889] Starting dynamic subtest: pipe-B-DP-3
[327.143054] Dynamic subtest pipe-B-DP-3: SUCCESS (0.556s)
[327.159814] Starting dynamic subtest: pipe-C-DP-3
[327.724457] Dynamic subtest pipe-C-DP-3: SUCCESS (0.581s)
[327.738236] Starting dynamic subtest: pipe-D-DP-3
[328.326259] Dynamic subtest pipe-D-DP-3: SUCCESS (0.599s)
[328.327231] Subtest gamma: SUCCESS (2.434s)
[328.594063] [044/131] (692s left) gem_lmem_swapping (verify-random)
[331.189120] Starting subtest: verify-random
[331.189938] Starting dynamic subtest: lmem0
[339.827518] Dynamic subtest lmem0: SUCCESS (8.638s)
[339.828479] Subtest verify-random: SUCCESS (8.640s)
[340.902851] [FACT gem_lmem_swapping (verify-random)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[340.904056] [FACT gem_lmem_swapping (verify-random)] deleted: kernel.kmod_is_loaded.i915: true
[340.906183] [045/131] (680s left) kms_lease (lease-again)
[342.552574] Starting subtest: lease-again
[342.555262] Starting dynamic subtest: pipe-A-DP-3
[342.557753] Dynamic subtest pipe-A-DP-3: SUCCESS (0.004s)
[342.568751] Starting dynamic subtest: pipe-B-DP-3
[342.569563] Dynamic subtest pipe-B-DP-3: SUCCESS (0.004s)
[342.579831] Starting dynamic subtest: pipe-C-DP-3
[342.580602] Dynamic subtest pipe-C-DP-3: SUCCESS (0.004s)
[342.589599] Starting dynamic subtest: pipe-D-DP-3
[342.590467] Dynamic subtest pipe-D-DP-3: SUCCESS (0.003s)
[342.591384] Subtest lease-again: SUCCESS (0.022s)
[342.703010] [FACT kms_lease (lease-again)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[342.705553] [FACT kms_lease (lease-again)] new: kernel.kmod_is_loaded.i915: true
[342.708533] [046/131] (678s left) dumb_buffer (create-clear)
[342.788556] Starting subtest: create-clear
[378.767224] Subtest create-clear: SUCCESS (35.978s)
[378.881274] [047/131] (642s left) kms_prime (basic-crc-vgem)
[379.084016] Subtest basic-crc-vgem: SKIP (0.000s)
[379.199468] [048/131] (642s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[379.295609] Starting subtest: invalid-bsd1-flag-on-vebox
[379.296551] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[379.422417] [049/131] (642s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[379.623531] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[379.625249] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[379.765947] [050/131] (641s left) kms_sequence (queue-busy)
[379.967519] Starting subtest: queue-busy
[379.969864] Starting dynamic subtest: pipe-A-DP-3
[382.559536] Dynamic subtest pipe-A-DP-3: SUCCESS (2.590s)
[382.572633] Starting dynamic subtest: pipe-B-DP-3
[385.067990] Dynamic subtest pipe-B-DP-3: SUCCESS (2.507s)
[385.081060] Starting dynamic subtest: pipe-C-DP-3
[387.543922] Dynamic subtest pipe-C-DP-3: SUCCESS (2.473s)
[387.553793] Starting dynamic subtest: pipe-D-DP-3
[390.018049] Dynamic subtest pipe-D-DP-3: SUCCESS (2.473s)
[390.019107] Subtest queue-busy: SUCCESS (10.051s)
[390.260178] [051/131] (631s left) gem_mmap_gtt (big-copy-odd)
[390.340239] Subtest big-copy-odd: SKIP (0.000s)
[390.403471] [052/131] (631s left) gem_softpin (allocator-nopin)
[390.492019] Starting subtest: allocator-nopin
[390.753342] Subtest allocator-nopin: SUCCESS (0.261s)
[390.916849] [053/131] (630s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[391.112536] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[391.115098] Starting dynamic subtest: pipe-A-DP-3
[391.123469] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[391.132553] Starting dynamic subtest: pipe-B-DP-3
[391.140988] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[391.150020] Starting dynamic subtest: pipe-C-DP-3
[391.158227] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[391.167380] Starting dynamic subtest: pipe-D-DP-3
[391.178537] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[391.180534] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.009s)
[391.573118] [054/131] (630s left) kms_addfb_basic (small-bo)
[391.768586] Starting subtest: small-bo
[391.769472] Subtest small-bo: SUCCESS (0.000s)
[391.926070] [055/131] (630s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[392.131986] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[392.133765] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[392.264634] [056/131] (629s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[392.346471] Starting subtest: single-wait-for-submit-unsubmitted
[392.452483] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[392.571282] [057/131] (629s left) kms_chamelium_hpd (hdmi-hpd-storm)
[392.858582] Subtest hdmi-hpd-storm: SKIP (0.000s)
[393.015387] [058/131] (629s left) gem_workarounds (suspend-resume)
[393.113431] Starting subtest: suspend-resume
[412.489344] Subtest suspend-resume: SUCCESS (3.831s)
[413.608165] [059/131] (609s left) gem_exec_whisper (basic-fds-priority)
[413.704550] Starting subtest: basic-fds-priority
[436.575117] Subtest basic-fds-priority: SUCCESS (22.869s)
[436.826227] [060/131] (586s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[437.036117] Starting subtest: x-tiled-8bpp-rotate-270
[437.100221] Subtest x-tiled-8bpp-rotate-270: SKIP (0.063s)
[437.277269] [061/131] (586s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[437.478727] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[437.480429] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[437.630830] [062/131] (585s left) kms_vrr (flip-basic-fastset)
[437.825259] Starting subtest: flip-basic-fastset
[437.827998] Subtest flip-basic-fastset: SKIP (0.000s)
[437.922449] [063/131] (585s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[438.117222] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[438.119725] Starting dynamic subtest: pipe-A-DP-3
[438.127827] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[438.139490] Starting dynamic subtest: pipe-B-DP-3
[438.147589] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[438.158963] Starting dynamic subtest: pipe-C-DP-3
[438.167134] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[438.178373] Starting dynamic subtest: pipe-D-DP-3
[438.189331] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[438.191340] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.007s)
[438.583450] [064/131] (584s left) gem_mmap_gtt (basic-wc)
[438.662132] Subtest basic-wc: SKIP (0.000s)
[438.755963] [065/131] (584s left) gem_exec_schedule (submit-late-slice)
[438.852013] Starting subtest: submit-late-slice
[438.852956] Starting dynamic subtest: rcs0
[438.932887] Dynamic subtest rcs0: SUCCESS (0.080s)
[438.944892] Starting dynamic subtest: bcs0
[438.986124] Dynamic subtest bcs0: SUCCESS (0.052s)
[438.997953] Starting dynamic subtest: vcs0
[439.035976] Dynamic subtest vcs0: SUCCESS (0.049s)
[439.050121] Starting dynamic subtest: vcs1
[439.089171] Dynamic subtest vcs1: SUCCESS (0.052s)
[439.102297] Starting dynamic subtest: vecs0
[439.137930] Dynamic subtest vecs0: SUCCESS (0.048s)
[439.149874] Starting dynamic subtest: vecs1
[439.190370] Dynamic subtest vecs1: SUCCESS (0.051s)
[439.202250] Starting dynamic subtest: ccs0
[439.240726] Dynamic subtest ccs0: SUCCESS (0.049s)
[439.241722] Subtest submit-late-slice: SUCCESS (0.389s)
[439.741754] [066/131] (583s left) gem_exec_params (secure-non-root)
[439.828733] Starting subtest: secure-non-root
[439.830425] Subtest secure-non-root: SKIP (0.000s)
[439.992822] [067/131] (583s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[440.193671] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[440.195421] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[440.346705] [068/131] (583s left) gem_exec_reloc (basic-gtt-active)
[440.436369] Subtest basic-gtt-active: SKIP (0.000s)
[440.537777] [069/131] (583s left) kms_draw_crc (draw-method-blt)
[440.737065] Starting subtest: draw-method-blt
[440.737954] Starting dynamic subtest: xrgb8888-untiled
[441.099142] Dynamic subtest xrgb8888-untiled: SUCCESS (0.362s)
[441.148149] Starting dynamic subtest: rgb565-untiled
[441.432618] Dynamic subtest rgb565-untiled: SUCCESS (0.325s)
[441.476295] Starting dynamic subtest: xrgb2101010-untiled
[441.749076] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.312s)
[441.787862] Starting dynamic subtest: xbgr16161616f-untiled
[442.065809] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.312s)
[442.106183] Starting dynamic subtest: xrgb8888-xtiled
[442.231429] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.162s)
[442.252805] Starting dynamic subtest: rgb565-xtiled
[442.382788] Dynamic subtest rgb565-xtiled: SUCCESS (0.149s)
[442.403399] Starting dynamic subtest: xrgb2101010-xtiled
[442.514674] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.128s)
[442.529602] Starting dynamic subtest: xbgr16161616f-xtiled
[442.649244] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[442.692005] Starting dynamic subtest: xrgb8888-4tiled
[442.816032] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.162s)
[442.860928] Starting dynamic subtest: rgb565-4tiled
[442.982492] Dynamic subtest rgb565-4tiled: SUCCESS (0.162s)
[443.024041] Starting dynamic subtest: xrgb2101010-4tiled
[443.132487] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.145s)
[443.175592] Starting dynamic subtest: xbgr16161616f-4tiled
[443.282502] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.145s)
[443.288510] Subtest draw-method-blt: SUCCESS (2.548s)
[443.475269] [070/131] (580s left) gem_exec_fence (syncobj-timeline-export)
[444.160859] Starting subtest: syncobj-timeline-export
[444.209184] Subtest syncobj-timeline-export: SUCCESS (0.053s)
[444.522262] [071/131] (579s left) sw_sync (sync_expired_merge)
[444.570890] Starting subtest: sync_expired_merge
[445.645609] Subtest sync_expired_merge: SUCCESS (1.074s)
[445.717293] [072/131] (578s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[445.926869] Starting subtest: 4-tiled-32bpp-rotate-180
[447.702548] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.774s)
[447.862218] [073/131] (576s left) i915_drm_fdinfo (busy-hang)
[447.932974] Starting subtest: busy-hang
[447.933942] Starting dynamic subtest: rcs0
[447.962172] Dynamic subtest rcs0: SKIP (0.028s)
[447.975317] Starting dynamic subtest: bcs0
[447.977257] Dynamic subtest bcs0: SKIP (0.001s)
[447.990233] Starting dynamic subtest: vcs0
[447.992321] Dynamic subtest vcs0: SKIP (0.001s)
[448.005287] Starting dynamic subtest: vcs1
[448.007630] Dynamic subtest vcs1: SKIP (0.001s)
[448.021985] Starting dynamic subtest: vecs0
[448.023947] Dynamic subtest vecs0: SKIP (0.001s)
[448.035460] Starting dynamic subtest: vecs1
[448.037332] Dynamic subtest vecs1: SKIP (0.001s)
[448.048820] Starting dynamic subtest: ccs0
[448.050880] Dynamic subtest ccs0: SKIP (0.001s)
[448.052750] Subtest busy-hang: SKIP (0.039s)
[448.099937] [074/131] (576s left) gem_eio (in-flight-10ms)
[448.388131] Starting subtest: in-flight-10ms
[453.489275] Subtest in-flight-10ms: SUCCESS (5.099s)
[453.736838] [075/131] (570s left) kms_psr (psr-sprite-blt)
[453.935929] Subtest psr-sprite-blt: SKIP (0.000s)
[454.002030] [076/131] (570s left) kms_psr (fbc-pr-sprite-render)
[454.196759] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[454.269504] [077/131] (570s left) dmabuf_sync_file (export-before-signal)
[454.322345] Starting subtest: export-before-signal
[454.323220] Subtest export-before-signal: SUCCESS (0.001s)
[454.417683] [078/131] (570s left) vgem_basic (bad-pad)
[454.472222] Starting subtest: bad-pad
[454.473132] Subtest bad-pad: SUCCESS (0.000s)
[454.592532] [079/131] (569s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[454.790336] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[454.792862] Starting dynamic subtest: pipe-A-valid-mode
[454.865534] Dynamic subtest pipe-A-valid-mode: SKIP (0.073s)
[454.867261] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.074s)
[455.087239] [080/131] (569s left) gem_pread (bench)
[455.164884] Subtest bench: SKIP (0.000s)
[455.236164] [081/131] (569s left) kms_hdr (bpc-switch)
[455.435246] Starting subtest: bpc-switch
[458.731906] Starting dynamic subtest: pipe-A-DP-3
[459.869976] Dynamic subtest pipe-A-DP-3: SUCCESS (1.138s)
[459.870933] Subtest bpc-switch: SUCCESS (4.434s)
[460.190200] [082/131] (564s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[460.385730] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[460.387791] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[460.533370] [083/131] (564s left) i915_pm_rps (engine-order)
[460.621649] Starting subtest: engine-order
[471.383496] Subtest engine-order: SUCCESS (10.759s)
[471.610589] [084/131] (553s left) gem_exec_params (rs-invalid)
[471.696509] Starting subtest: rs-invalid
[471.700142] Subtest rs-invalid: SUCCESS (0.003s)
[471.867820] [085/131] (553s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[472.067712] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[472.069563] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[472.226834] [086/131] (552s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[472.305221] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[472.413015] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.106s)
[472.540372] [087/131] (552s left) kms_flip (2x-flip-vs-fences)
[472.735779] Starting subtest: 2x-flip-vs-fences
[472.737535] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[472.909992] [088/131] (552s left) i915_suspend (forcewake)
[473.005970] Starting subtest: forcewake
[511.843549] Subtest forcewake: SUCCESS (6.983s)
[511.940933] [089/131] (513s left) kms_psr (fbc-psr-cursor-plane-onoff)
[512.138223] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s)
[512.210887] [090/131] (513s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[512.421017] Starting subtest: y-tiled-16bpp-rotate-0
[512.422692] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[512.579248] [091/131] (512s left) kms_psr (pr-sprite-plane-onoff)
[512.783300] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[512.843194] [092/131] (512s left) core_auth (basic-auth)
[512.924697] Starting subtest: basic-auth
[512.939399] Subtest basic-auth: SUCCESS (0.016s)
[513.101625] [093/131] (512s left) kms_pm_rpm (cursor)
[515.452126] Starting subtest: cursor
[515.455715] Subtest cursor: SKIP (0.000s)
[515.843045] [094/131] (509s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[516.048065] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[516.049820] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[516.180285] [095/131] (509s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[516.377714] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[516.604585] Starting dynamic subtest: pipe-A-DP-3-4-rc-ccs
[518.890917] Dynamic subtest pipe-A-DP-3-4-rc-ccs: SUCCESS (2.286s)
[518.904245] Starting dynamic subtest: pipe-A-DP-3-4
[521.072656] Dynamic subtest pipe-A-DP-3-4: SUCCESS (2.181s)
[521.086316] Starting dynamic subtest: pipe-A-DP-3-4
[523.089293] Dynamic subtest pipe-A-DP-3-4: SUCCESS (2.016s)
[523.104794] Starting dynamic subtest: pipe-A-DP-3-x
[525.289426] Dynamic subtest pipe-A-DP-3-x: SUCCESS (2.199s)
[525.513924] Starting dynamic subtest: pipe-B-DP-3-4-rc-ccs
[527.758428] Dynamic subtest pipe-B-DP-3-4-rc-ccs: SUCCESS (2.258s)
[527.771811] Starting dynamic subtest: pipe-B-DP-3-4
[529.923956] Dynamic subtest pipe-B-DP-3-4: SUCCESS (2.164s)
[529.937681] Starting dynamic subtest: pipe-B-DP-3-4
[531.940611] Dynamic subtest pipe-B-DP-3-4: SUCCESS (2.016s)
[531.954298] Starting dynamic subtest: pipe-B-DP-3-x
[534.107283] Dynamic subtest pipe-B-DP-3-x: SUCCESS (2.166s)
[534.304476] Starting dynamic subtest: pipe-C-DP-3-4-rc-ccs
[536.549296] Dynamic subtest pipe-C-DP-3-4-rc-ccs: SUCCESS (2.257s)
[536.562711] Starting dynamic subtest: pipe-C-DP-3-4
[538.714762] Dynamic subtest pipe-C-DP-3-4: SUCCESS (2.164s)
[538.728230] Starting dynamic subtest: pipe-C-DP-3-4
[540.731607] Dynamic subtest pipe-C-DP-3-4: SUCCESS (2.016s)
[540.744749] Starting dynamic subtest: pipe-C-DP-3-x
[542.898308] Dynamic subtest pipe-C-DP-3-x: SUCCESS (2.166s)
[543.086086] Starting dynamic subtest: pipe-D-DP-3-4-rc-ccs
[545.332900] Dynamic subtest pipe-D-DP-3-4-rc-ccs: SUCCESS (2.261s)
[545.346281] Starting dynamic subtest: pipe-D-DP-3-4
[547.497581] Dynamic subtest pipe-D-DP-3-4: SUCCESS (2.163s)
[547.514278] Starting dynamic subtest: pipe-D-DP-3-4
[549.514687] Dynamic subtest pipe-D-DP-3-4: SUCCESS (2.015s)
[549.528497] Starting dynamic subtest: pipe-D-DP-3-x
[551.681534] Dynamic subtest pipe-D-DP-3-x: SUCCESS (2.166s)
[551.682490] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (35.304s)
[552.102016] [096/131] (473s left) kms_cursor_crc (cursor-sliding-max-size)
[552.613508] Starting subtest: cursor-sliding-max-size
[552.616515] Subtest cursor-sliding-max-size: SKIP (0.000s)
[552.831426] [097/131] (473s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[553.032119] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[553.033873] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[553.172874] [098/131] (472s left) api_intel_bb (destroy-bb)
[553.252426] Starting subtest: destroy-bb
[553.287650] Subtest destroy-bb: SUCCESS (0.034s)
[553.452263] [099/131] (472s left) api_intel_allocator (alloc-simple)
[553.532441] Starting subtest: alloc-simple
[553.561701] Subtest alloc-simple: SUCCESS (0.029s)
[553.744445] [100/131] (472s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[553.939634] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs
[553.942122] Starting dynamic subtest: pipe-A-DP-3
[553.950541] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[553.963508] Starting dynamic subtest: pipe-B-DP-3
[553.972046] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[553.985079] Starting dynamic subtest: pipe-C-DP-3
[553.993766] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[554.006611] Starting dynamic subtest: pipe-D-DP-3
[554.017826] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[554.019765] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.007s)
[554.420836] [101/131] (471s left) gem_exec_alignment (pi)
[554.506589] Starting subtest: pi
[571.726380] Subtest pi: SUCCESS (17.218s)
[572.177379] [102/131] (454s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[572.437820] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[572.439462] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[572.577431] [103/131] (453s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[572.789556] Starting subtest: x-tiled-64bpp-rotate-180
[574.753609] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.963s)
[574.948990] [104/131] (451s left) gem_exec_reloc (basic-wc)
[575.036252] Subtest basic-wc: SKIP (0.000s)
[575.119230] [105/131] (451s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[575.322246] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[575.323987] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[575.466933] [106/131] (451s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[575.671939] Subtest psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[575.733977] [107/131] (450s left) gem_userptr_blits (userfault)
[575.828190] Starting subtest: userfault
[575.831147] Subtest userfault: SUCCESS (0.005s)
[576.020755] [108/131] (450s left) kms_flip_event_leak (basic)
[576.220613] Starting subtest: basic
[576.223048] Starting dynamic subtest: pipe-A-DP-3
[576.577926] Dynamic subtest pipe-A-DP-3: SUCCESS (0.355s)
[576.598127] Starting dynamic subtest: pipe-B-DP-3
[576.870529] Dynamic subtest pipe-B-DP-3: SUCCESS (0.291s)
[576.894249] Starting dynamic subtest: pipe-C-DP-3
[577.155807] Dynamic subtest pipe-C-DP-3: SUCCESS (0.281s)
[577.180660] Starting dynamic subtest: pipe-D-DP-3
[577.463285] Dynamic subtest pipe-D-DP-3: SUCCESS (0.304s)
[577.464476] Subtest basic: SUCCESS (1.242s)
[577.708012] [109/131] (449s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[577.911163] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[577.912861] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[578.069296] [110/131] (448s left) gem_busy (extended)
[578.308693] Starting subtest: extended
[578.309791] Starting dynamic subtest: rcs0
[578.401179] Dynamic subtest rcs0: SUCCESS (0.091s)
[578.421671] Starting dynamic subtest: bcs0
[578.446832] Dynamic subtest bcs0: SUCCESS (0.042s)
[578.462681] Starting dynamic subtest: vcs0
[578.487713] Dynamic subtest vcs0: SUCCESS (0.040s)
[578.508011] Starting dynamic subtest: vcs1
[578.528621] Dynamic subtest vcs1: SUCCESS (0.040s)
[578.549071] Starting dynamic subtest: vecs0
[578.570760] Dynamic subtest vecs0: SUCCESS (0.041s)
[578.591187] Starting dynamic subtest: vecs1
[578.612710] Dynamic subtest vecs1: SUCCESS (0.041s)
[578.633241] Starting dynamic subtest: ccs0
[578.654653] Dynamic subtest ccs0: SUCCESS (0.041s)
[578.655663] Subtest extended: SUCCESS (0.347s)
[578.929983] [111/131] (448s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[579.014660] Starting subtest: multi-wait-all-for-submit-available-signaled
[579.015514] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.001s)
[579.148041] [112/131] (447s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[579.394640] Starting subtest: cursor-tearing-framebuffer-change
[579.397058] Starting dynamic subtest: pipe-A-DP-3
[579.858857] Dynamic subtest pipe-A-DP-3: SUCCESS (0.462s)
[579.878401] Starting dynamic subtest: pipe-D-DP-3
[580.286059] Dynamic subtest pipe-D-DP-3: SUCCESS (0.426s)
[580.286962] Subtest cursor-tearing-framebuffer-change: SUCCESS (0.892s)
[580.868067] [113/131] (446s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[581.062655] Starting subtest: compare-crc-sanitycheck-nv12
[581.065091] Starting dynamic subtest: pipe-A-DP-3
[581.781684] Dynamic subtest pipe-A-DP-3: SUCCESS (0.717s)
[581.799248] Starting dynamic subtest: pipe-B-DP-3
[582.432118] Dynamic subtest pipe-B-DP-3: SUCCESS (0.647s)
[582.447181] Starting dynamic subtest: pipe-C-DP-3
[583.071990] Dynamic subtest pipe-C-DP-3: SUCCESS (0.638s)
[583.086720] Starting dynamic subtest: pipe-D-DP-3
[583.684251] Dynamic subtest pipe-D-DP-3: SUCCESS (0.611s)
[583.685257] Subtest compare-crc-sanitycheck-nv12: SUCCESS (2.622s)
[583.942582] [114/131] (443s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[584.138595] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[584.139496] Starting dynamic subtest: pipe-A
[584.664963] Dynamic subtest pipe-A: SUCCESS (0.525s)
[584.700753] Starting dynamic subtest: pipe-B
[585.311672] Dynamic subtest pipe-B: SUCCESS (0.645s)
[585.340788] Starting dynamic subtest: pipe-C
[585.960805] Dynamic subtest pipe-C: SUCCESS (0.647s)
[585.985700] Starting dynamic subtest: pipe-D
[586.609604] Dynamic subtest pipe-D: SUCCESS (0.647s)
[586.610647] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (2.472s)
[586.928806] [115/131] (440s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[587.126277] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[587.128131] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[587.272308] [116/131] (440s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[587.361367] Starting subtest: saturated-hostile-nopreempt
[587.362322] Starting dynamic subtest: rcs0
[587.450333] Dynamic subtest rcs0: SKIP (0.087s)
[587.464573] Starting dynamic subtest: bcs0
[587.474279] Dynamic subtest bcs0: SKIP (0.023s)
[587.488496] Starting dynamic subtest: vcs0
[587.490669] Dynamic subtest vcs0: SKIP (0.011s)
[587.505758] Starting dynamic subtest: vcs1
[587.508318] Dynamic subtest vcs1: SKIP (0.011s)
[587.522014] Starting dynamic subtest: vecs0
[587.523853] Dynamic subtest vecs0: SKIP (0.012s)
[587.537584] Starting dynamic subtest: vecs1
[587.539708] Dynamic subtest vecs1: SKIP (0.011s)
[587.553737] Starting dynamic subtest: ccs0
[587.556141] Dynamic subtest ccs0: SKIP (0.014s)
[587.558462] Subtest saturated-hostile-nopreempt: SKIP (0.176s)
[587.714779] [117/131] (439s left) prime_self_import (reimport-vs-gem_close-race)
[587.765216] Starting subtest: reimport-vs-gem_close-race
[592.863362] Subtest reimport-vs-gem_close-race: SUCCESS (5.099s)
[592.995037] [118/131] (434s left) gem_pread (snoop)
[593.103373] Subtest snoop: SKIP (0.000s)
[593.174177] [119/131] (434s left) kms_sequence (get-busy)
[593.371579] Starting subtest: get-busy
[593.373971] Starting dynamic subtest: pipe-A-DP-3
[595.933129] Dynamic subtest pipe-A-DP-3: SUCCESS (2.560s)
[595.949724] Starting dynamic subtest: pipe-B-DP-3
[598.421363] Dynamic subtest pipe-B-DP-3: SUCCESS (2.486s)
[598.436225] Starting dynamic subtest: pipe-C-DP-3
[600.891023] Dynamic subtest pipe-C-DP-3: SUCCESS (2.468s)
[600.907038] Starting dynamic subtest: pipe-D-DP-3
[603.370332] Dynamic subtest pipe-D-DP-3: SUCCESS (2.477s)
[603.371358] Subtest get-busy: SUCCESS (9.998s)
[603.646615] [120/131] (424s left) prime_vgem (basic-fence-mmap)
[603.740777] Starting subtest: basic-fence-mmap
[603.742664] Subtest basic-fence-mmap: SKIP (0.000s)
[603.887569] [121/131] (423s left) kms_cursor_crc (cursor-onscreen-max-size)
[604.398434] Starting subtest: cursor-onscreen-max-size
[604.401185] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[604.599187] [122/131] (423s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[604.796090] Starting subtest: flip-vs-cursor-varying-size
[616.894288] Subtest flip-vs-cursor-varying-size: SUCCESS (12.097s)
[617.151958] [123/131] (410s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[617.352639] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[617.355152] Starting dynamic subtest: pipe-A-DP-3
[617.363956] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[617.378059] Starting dynamic subtest: pipe-B-DP-3
[617.386779] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[617.400626] Starting dynamic subtest: pipe-C-DP-3
[617.410424] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[617.424556] Starting dynamic subtest: pipe-D-DP-3
[617.434542] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[617.436603] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SKIP (0.007s)
[617.812437] [124/131] (410s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[618.009293] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[618.011105] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[618.176988] [125/131] (409s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[618.381205] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[618.382854] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[618.539553] [126/131] (409s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[618.618571] Starting subtest: etime-multi-wait-all-available-unsubmitted
[618.723608] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.104s)
[618.878715] [127/131] (409s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[619.081204] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[619.082934] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[619.194030] [128/131] (409s left) kms_chamelium_edid (hdmi-edid-read)
[619.476130] Subtest hdmi-edid-read: SKIP (0.000s)
[619.640799] [129/131] (408s left) gem_mmap_offset (blt-coherency)
[619.725502] Starting subtest: blt-coherency
[619.760472] Subtest blt-coherency: SUCCESS (0.035s)
[619.948745] [130/131] (408s left) perf (missing-sample-flags)
[620.331247] Starting subtest: missing-sample-flags
[620.332215] Subtest missing-sample-flags: SUCCESS (0.000s)
[620.395625] [131/131] (408s left) syncobj_wait (wait-any-snapshot)
[620.474492] Starting subtest: wait-any-snapshot
[620.557705] Subtest wait-any-snapshot: SUCCESS (0.082s)
[620.733520] Closing watchdogs
results: parsing output: 0/ for test: kms_getfb
results: parsing output: 1/ for test: kms_plane
results: parsing output: 2/ for test: kms_psr
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: gem_flink_race
results: parsing output: 5/ for test: gem_render_copy
results: parsing output: 6/ for test: perf_pmu
results: parsing output: 7/ for test: gen7_exec_parse
results: parsing output: 8/ for test: sw_sync
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: core_getclient
results: parsing output: 11/ for test: kms_cursor_legacy
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: gem_exec_fence
results: parsing output: 14/ for test: perf_pmu
results: parsing output: 15/ for test: kms_psr2_sf
results: parsing output: 16/ for test: kms_plane_scaling
results: parsing output: 17/ for test: gem_exec_schedule
results: parsing output: 18/ for test: gem_ctx_persistence
results: parsing output: 19/ for test: gem_ctx_param
results: parsing output: 20/ for test: syncobj_timeline
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: gem_exec_params
results: parsing output: 24/ for test: gem_exec_params
results: parsing output: 25/ for test: kms_content_protection
results: parsing output: 26/ for test: gem_exec_reloc
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: gem_pxp
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: i915_drm_fdinfo
results: parsing output: 32/ for test: kms_busy
results: parsing output: 33/ for test: kms_invalid_mode
results: parsing output: 34/ for test: kms_atomic_transition
results: parsing output: 35/ for test: kms_flip
results: parsing output: 36/ for test: prime_busy
results: parsing output: 37/ for test: kms_cursor_legacy
results: parsing output: 38/ for test: gem_create
results: parsing output: 39/ for test: syncobj_wait
results: parsing output: 40/ for test: gem_exec_balancer
results: parsing output: 41/ for test: i915_pm_rc6_residency
results: parsing output: 42/ for test: kms_color
results: parsing output: 43/ for test: gem_lmem_swapping
results: parsing output: 44/ for test: kms_lease
results: parsing output: 45/ for test: dumb_buffer
results: parsing output: 46/ for test: kms_prime
results: parsing output: 47/ for test: gem_exec_params
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_sequence
results: parsing output: 50/ for test: gem_mmap_gtt
results: parsing output: 51/ for test: gem_softpin
results: parsing output: 52/ for test: kms_ccs
results: parsing output: 53/ for test: kms_addfb_basic
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: syncobj_wait
results: parsing output: 56/ for test: kms_chamelium_hpd
results: parsing output: 57/ for test: gem_workarounds
results: parsing output: 58/ for test: gem_exec_whisper
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_vrr
results: parsing output: 62/ for test: kms_ccs
results: parsing output: 63/ for test: gem_mmap_gtt
results: parsing output: 64/ for test: gem_exec_schedule
results: parsing output: 65/ for test: gem_exec_params
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_exec_reloc
results: parsing output: 68/ for test: kms_draw_crc
results: parsing output: 69/ for test: gem_exec_fence
results: parsing output: 70/ for test: sw_sync
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: i915_drm_fdinfo
results: parsing output: 73/ for test: gem_eio
results: parsing output: 74/ for test: kms_psr
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: dmabuf_sync_file
results: parsing output: 77/ for test: vgem_basic
results: parsing output: 78/ for test: kms_flip_scaled_crc
results: parsing output: 79/ for test: gem_pread
results: parsing output: 80/ for test: kms_hdr
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: i915_pm_rps
results: parsing output: 83/ for test: gem_exec_params
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: syncobj_wait
results: parsing output: 86/ for test: kms_flip
results: parsing output: 87/ for test: i915_suspend
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: kms_psr
results: parsing output: 91/ for test: core_auth
results: parsing output: 92/ for test: kms_pm_rpm
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_async_flips
results: parsing output: 95/ for test: kms_cursor_crc
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: api_intel_bb
results: parsing output: 98/ for test: api_intel_allocator
results: parsing output: 99/ for test: kms_ccs
results: parsing output: 100/ for test: gem_exec_alignment
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: gem_exec_reloc
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_psr2_sf
results: parsing output: 106/ for test: gem_userptr_blits
results: parsing output: 107/ for test: kms_flip_event_leak
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_busy
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: kms_cursor_crc
results: parsing output: 112/ for test: kms_pipe_crc_basic
results: parsing output: 113/ for test: kms_plane_scaling
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: gem_ctx_persistence
results: parsing output: 116/ for test: prime_self_import
results: parsing output: 117/ for test: gem_pread
results: parsing output: 118/ for test: kms_sequence
results: parsing output: 119/ for test: prime_vgem
results: parsing output: 120/ for test: kms_cursor_crc
results: parsing output: 121/ for test: kms_cursor_legacy
results: parsing output: 122/ for test: kms_ccs
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: syncobj_timeline
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_chamelium_edid
results: parsing output: 128/ for test: gem_mmap_offset
results: parsing output: 129/ for test: perf
results: parsing output: 130/ for test: syncobj_wait
Done.