[61.950907] Initializing watchdogs
[61.950971]   /dev/watchdog0
[61.970855] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[61.981753] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[61.985597] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.987797] [001/133] (960s left) kms_cursor_edge_walk (128x128-top-bottom)
[62.167013] Starting subtest: 128x128-top-bottom
[62.167900] Starting dynamic subtest: pipe-A-DP-3
[65.586043] Dynamic subtest pipe-A-DP-3: SUCCESS (3.492s)
[65.594441] Starting dynamic subtest: pipe-D-DP-3
[68.848409] Dynamic subtest pipe-D-DP-3: SUCCESS (3.306s)
[68.849370] Subtest 128x128-top-bottom: SUCCESS (6.800s)
[69.093192] [002/133] (953s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[69.275036] Starting subtest: plane-lut1d-pre-ctm3x4
[69.490717] Starting dynamic subtest: pipe-A-plane-0
[69.703508] Dynamic subtest pipe-A-plane-0: SUCCESS (0.217s)
[69.736140] Starting dynamic subtest: pipe-A-plane-1
[69.900019] Dynamic subtest pipe-A-plane-1: SUCCESS (0.198s)
[69.907908] Starting dynamic subtest: pipe-A-plane-2
[70.066508] Dynamic subtest pipe-A-plane-2: SUCCESS (0.167s)
[70.450385] Starting dynamic subtest: pipe-B-plane-0
[70.618724] Dynamic subtest pipe-B-plane-0: SUCCESS (0.200s)
[70.646635] Starting dynamic subtest: pipe-B-plane-1
[70.815652] Dynamic subtest pipe-B-plane-1: SUCCESS (0.198s)
[70.823494] Starting dynamic subtest: pipe-B-plane-2
[70.982524] Dynamic subtest pipe-B-plane-2: SUCCESS (0.167s)
[71.360380] Starting dynamic subtest: pipe-C-plane-0
[71.530218] Dynamic subtest pipe-C-plane-0: SUCCESS (0.200s)
[71.558515] Starting dynamic subtest: pipe-C-plane-1
[71.727287] Dynamic subtest pipe-C-plane-1: SUCCESS (0.198s)
[71.734934] Starting dynamic subtest: pipe-C-plane-2
[71.894642] Dynamic subtest pipe-C-plane-2: SUCCESS (0.167s)
[72.237349] Starting dynamic subtest: pipe-D-plane-0
[72.413246] Dynamic subtest pipe-D-plane-0: SUCCESS (0.184s)
[72.440419] Starting dynamic subtest: pipe-D-plane-1
[72.628703] Dynamic subtest pipe-D-plane-1: SUCCESS (0.216s)
[72.640521] Starting dynamic subtest: pipe-D-plane-2
[72.810759] Dynamic subtest pipe-D-plane-2: SUCCESS (0.182s)
[72.900569] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (3.655s)
[73.166538] [003/133] (949s left) gem_softpin (allocator-fork)
[73.248340] Starting subtest: allocator-fork
[75.532418] Subtest allocator-fork: SUCCESS (2.295s)
[75.695445] [004/133] (947s left) gem_exec_reloc (basic-wc-cpu-active)
[75.773282] Subtest basic-wc-cpu-active: SKIP (0.000s)
[75.845238] [005/133] (946s left) i915_fb_tiling (basic-x-tiling)
[75.915157] Subtest basic-x-tiling: SKIP (0.000s)
[75.976390] [006/133] (946s left) i915_suspend (basic-s2idle-without-i915)
[76.019422] Starting subtest: basic-s2idle-without-i915
[95.512459] Subtest basic-s2idle-without-i915: SUCCESS (3.802s)
[114.659847] [007/133] (927s left) i915_pm_rpm (system-suspend-devices)
[116.777107] Starting subtest: system-suspend-devices
[124.544430] Subtest system-suspend-devices: SUCCESS (7.889s)
[144.968246] [008/133] (917s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[145.146234] Starting subtest: short-flip-after-cursor-atomic-transitions
[146.259236] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (1.111s)
[146.533467] [009/133] (915s left) gem_exec_whisper (basic-contexts)
[146.618506] Starting subtest: basic-contexts
[156.444670] Subtest basic-contexts: SUCCESS (9.822s)
[156.690510] [010/133] (905s left) gem_ctx_param (invalid-size-get)
[156.758873] Starting subtest: invalid-size-get
[156.760719] Subtest invalid-size-get: SUCCESS (0.002s)
[156.938932] [011/133] (905s left) kms_big_fb (linear-8bpp-rotate-0)
[157.134741] Starting subtest: linear-8bpp-rotate-0
[158.800593] Subtest linear-8bpp-rotate-0: SUCCESS (1.665s)
[159.020946] [012/133] (903s left) kms_addfb_basic (invalid-get-prop-any)
[159.089361] Starting subtest: invalid-get-prop-any
[159.090208] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[159.307650] [013/133] (903s left) gen9_exec_parse (bb-start-param)
[159.383643] Subtest bb-start-param: SKIP (0.000s)
[159.462408] [014/133] (902s left) kms_chamelium_color (degamma)
[159.640143] Subtest degamma: SKIP (0.000s)
[159.691158] [015/133] (902s left) gem_ctx_persistence (engines-hostile-preempt)
[159.768751] Starting subtest: engines-hostile-preempt
[159.769676] Starting dynamic subtest: rcs0
[159.855747] Dynamic subtest rcs0: SUCCESS (0.087s)
[159.865676] Starting dynamic subtest: bcs0
[159.899860] Dynamic subtest bcs0: SUCCESS (0.044s)
[159.915886] Starting dynamic subtest: vcs0
[159.945060] Dynamic subtest vcs0: SUCCESS (0.045s)
[159.975533] Starting dynamic subtest: vcs1
[160.007163] Dynamic subtest vcs1: SUCCESS (0.061s)
[160.033159] Starting dynamic subtest: vecs0
[160.067173] Dynamic subtest vecs0: SUCCESS (0.059s)
[160.091070] Starting dynamic subtest: vecs1
[160.126604] Dynamic subtest vecs1: SUCCESS (0.058s)
[160.163460] Starting dynamic subtest: ccs0
[160.192944] Dynamic subtest ccs0: SUCCESS (0.066s)
[160.194027] Subtest engines-hostile-preempt: SUCCESS (0.424s)
[160.334791] [016/133] (902s left) kms_joiner (basic-big-joiner)
[160.516457] Starting subtest: basic-big-joiner
[160.518231] Subtest basic-big-joiner: SKIP (0.000s)
[160.624002] [017/133] (901s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[160.820114] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[162.117207] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.296s)
[162.288044] [018/133] (900s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[162.475015] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[162.476772] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[162.605796] [019/133] (900s left) kms_async_flips (invalid-async-flip)
[162.787419] Starting subtest: invalid-async-flip
[163.016002] Starting dynamic subtest: pipe-A-DP-3
[163.395214] Dynamic subtest pipe-A-DP-3: SUCCESS (0.379s)
[163.600624] Starting dynamic subtest: pipe-B-DP-3
[163.759897] Dynamic subtest pipe-B-DP-3: SUCCESS (0.169s)
[163.961015] Starting dynamic subtest: pipe-C-DP-3
[164.112190] Dynamic subtest pipe-C-DP-3: SUCCESS (0.161s)
[164.308835] Starting dynamic subtest: pipe-D-DP-3
[164.459904] Dynamic subtest pipe-D-DP-3: SUCCESS (0.161s)
[164.460842] Subtest invalid-async-flip: SUCCESS (1.673s)
[164.922253] [020/133] (897s left) gem_exec_gttfill (multigpu-basic)
[165.127031] Starting subtest: multigpu-basic
[178.925750] Subtest multigpu-basic: SUCCESS (13.817s)
[179.049128] [021/133] (883s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[179.290366] Starting subtest: fbc-rgb565-draw-mmap-cpu
[181.720973] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (2.430s)
[181.919284] [022/133] (880s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[182.114042] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[182.115925] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[182.288911] [023/133] (880s left) kms_properties (invalid-properties-legacy)
[182.472131] Starting subtest: invalid-properties-legacy
[182.630638] Subtest invalid-properties-legacy: SUCCESS (0.158s)
[182.777738] [024/133] (880s left) kms_flip (nonexisting-fb-interruptible)
[182.957834] Starting subtest: nonexisting-fb-interruptible
[182.962263] Starting dynamic subtest: A-DP3
[183.312785] Dynamic subtest A-DP3: SUCCESS (0.350s)
[183.356924] Starting dynamic subtest: B-DP3
[183.587204] Dynamic subtest B-DP3: SUCCESS (0.272s)
[183.626473] Starting dynamic subtest: C-DP3
[183.844846] Dynamic subtest C-DP3: SUCCESS (0.256s)
[183.858692] Starting dynamic subtest: D-DP3
[184.092278] Dynamic subtest D-DP3: SUCCESS (0.246s)
[184.096676] Subtest nonexisting-fb-interruptible: SUCCESS (1.138s)
[184.476245] [025/133] (878s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[184.658142] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[184.659059] Starting dynamic subtest: pipe-A-DP-3
[184.667794] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[184.678138] Starting dynamic subtest: pipe-B-DP-3
[184.686891] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[184.697132] Starting dynamic subtest: pipe-C-DP-3
[184.705728] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[184.716120] Starting dynamic subtest: pipe-D-DP-3
[184.726832] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[184.728674] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SKIP (0.007s)
[185.119048] [026/133] (878s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[185.197840] Starting subtest: invalid-bsd2-flag-on-vebox
[185.198876] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[185.318576] [027/133] (877s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[185.401204] Subtest tiled-to-untiled: SKIP (0.000s)
[185.510080] [028/133] (877s left) kms_psr (fbc-psr2-cursor-plane-move)
[185.690024] Subtest fbc-psr2-cursor-plane-move: SKIP (0.000s)
[185.739984] [029/133] (877s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[185.926931] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[185.942556] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.015s)
[186.086552] [030/133] (877s left) syncobj_eventfd (timeline-wait)
[186.164273] Starting subtest: timeline-wait
[186.175005] Subtest timeline-wait: SUCCESS (0.011s)
[186.290456] [031/133] (877s left) prime_self_import (basic-llseek-size)
[186.333850] Starting subtest: basic-llseek-size
[186.363982] Subtest basic-llseek-size: SUCCESS (0.030s)
[186.519818] [032/133] (877s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[186.709739] Starting subtest: y-tiled-8bpp-rotate-90
[186.711660] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[186.830672] [033/133] (876s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[187.014295] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[187.015997] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[187.161291] [034/133] (876s left) gem_exec_reloc (basic-write-read)
[187.240427] Subtest basic-write-read: SKIP (0.000s)
[187.324206] [035/133] (876s left) syncobj_timeline (multi-wait-signaled)
[187.396692] Starting subtest: multi-wait-signaled
[187.397680] Subtest multi-wait-signaled: SUCCESS (0.001s)
[187.549605] [036/133] (876s left) kms_pm_backlight (bad-brightness)
[187.736953] Subtest bad-brightness: SKIP (0.000s)
[187.791604] [037/133] (876s left) kms_properties (colorop-properties-legacy)
[187.972202] Starting subtest: colorop-properties-legacy
[187.973125] Starting dynamic subtest: pipe-A-DP-3
[188.143080] Dynamic subtest pipe-A-DP-3: SUCCESS (0.169s)
[188.164216] Starting dynamic subtest: pipe-B-DP-3
[188.345738] Dynamic subtest pipe-B-DP-3: SUCCESS (0.201s)
[188.356607] Starting dynamic subtest: pipe-C-DP-3
[188.532483] Dynamic subtest pipe-C-DP-3: SUCCESS (0.186s)
[188.544879] Starting dynamic subtest: pipe-D-DP-3
[188.720480] Dynamic subtest pipe-D-DP-3: SUCCESS (0.187s)
[188.721361] Subtest colorop-properties-legacy: SUCCESS (0.748s)
[188.975731] [038/133] (875s left) kms_pm_rpm (legacy-planes)
[190.788472] Starting subtest: legacy-planes
[190.790709] Starting dynamic subtest: plane-65
[193.599019] Dynamic subtest plane-65: SUCCESS (2.809s)
[193.644973] Starting dynamic subtest: plane-95
[196.324761] Dynamic subtest plane-95: SUCCESS (2.723s)
[196.370988] Starting dynamic subtest: plane-125
[199.294971] Dynamic subtest plane-125: SUCCESS (2.967s)
[199.341209] Starting dynamic subtest: plane-135
[201.949410] Dynamic subtest plane-135: SUCCESS (2.652s)
[201.950818] Subtest legacy-planes: SUCCESS (11.163s)
[202.405748] [039/133] (861s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[202.592619] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[205.570822] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (2.979s)
[205.855784] [040/133] (858s left) kms_psr (fbc-psr2-sprite-plane-move)
[206.032229] Subtest fbc-psr2-sprite-plane-move: SKIP (0.000s)
[206.101337] [041/133] (858s left) kms_pipe_stress (stress-xrgb8888-untiled)
[206.286174] Starting subtest: stress-xrgb8888-untiled
[214.179407] Subtest stress-xrgb8888-untiled: SUCCESS (7.894s)
[214.460847] [042/133] (849s left) prime_vgem (wait)
[214.628128] Starting subtest: wait
[214.629052] Starting dynamic subtest: rcs0
[214.692282] Dynamic subtest rcs0: SUCCESS (0.064s)
[214.704088] Starting dynamic subtest: bcs0
[214.744274] Dynamic subtest bcs0: SUCCESS (0.051s)
[214.760006] Starting dynamic subtest: vcs0
[214.784721] Dynamic subtest vcs0: SUCCESS (0.039s)
[214.804812] Starting dynamic subtest: vcs1
[214.826316] Dynamic subtest vcs1: SUCCESS (0.040s)
[214.846352] Starting dynamic subtest: vecs0
[214.867790] Dynamic subtest vecs0: SUCCESS (0.040s)
[214.885159] Starting dynamic subtest: vecs1
[214.909597] Dynamic subtest vecs1: SUCCESS (0.041s)
[214.927674] Starting dynamic subtest: ccs0
[214.951620] Dynamic subtest ccs0: SUCCESS (0.041s)
[214.952671] Subtest wait: SUCCESS (0.324s)
[215.093713] [FACT prime_vgem (wait)] new: kernel.kmod_is_loaded.vgem: true
[215.096217] [043/133] (849s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[215.291645] Starting subtest: cursor-vs-flip-atomic
[246.274380] Subtest cursor-vs-flip-atomic: SUCCESS (30.990s)
[246.583021] [044/133] (817s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[246.664755] Starting subtest: single-wait-for-submit-available-submitted
[246.665712] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s)
[246.852956] [045/133] (817s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[247.041132] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[247.102382] [046/133] (817s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[247.293760] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[247.295528] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[247.435535] [047/133] (817s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[247.630411] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[247.632207] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[247.796409] [048/133] (816s left) gem_mmap (pf-nonblock)
[247.877650] Subtest pf-nonblock: SKIP (0.000s)
[247.952671] [049/133] (816s left) gem_fence_thrash (bo-write-verify-x)
[247.999629] Starting subtest: bo-write-verify-x
[248.032692] Subtest bo-write-verify-x: SKIP (0.032s)
[248.102235] [050/133] (816s left) gem_mmap (bad-offset)
[248.181715] Subtest bad-offset: SKIP (0.000s)
[248.253403] [051/133] (816s left) i915_drm_fdinfo (busy)
[248.324690] Starting subtest: busy
[248.325645] Starting dynamic subtest: rcs0
[248.343780] Dynamic subtest rcs0: SKIP (0.018s)
[248.354994] Starting dynamic subtest: bcs0
[248.356777] Dynamic subtest bcs0: SKIP (0.000s)
[248.368125] Starting dynamic subtest: vcs0
[248.370410] Dynamic subtest vcs0: SKIP (0.000s)
[248.381753] Starting dynamic subtest: vcs1
[248.384264] Dynamic subtest vcs1: SKIP (0.000s)
[248.395301] Starting dynamic subtest: vecs0
[248.397685] Dynamic subtest vecs0: SKIP (0.000s)
[248.409296] Starting dynamic subtest: vecs1
[248.411636] Dynamic subtest vecs1: SKIP (0.000s)
[248.422291] Starting dynamic subtest: ccs0
[248.424614] Dynamic subtest ccs0: SKIP (0.000s)
[248.427123] Subtest busy: SKIP (0.025s)
[248.474109] [052/133] (816s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[248.751305] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[248.903089] [053/133] (816s left) kms_lease (multimaster-lease)
[249.090544] Starting subtest: multimaster-lease
[249.111339] Subtest multimaster-lease: SUCCESS (0.021s)
[249.245151] [054/133] (815s left) kms_pm_backlight (basic-brightness)
[249.431582] Subtest basic-brightness: SKIP (0.000s)
[249.489366] [055/133] (815s left) gem_exec_fence (nb-await)
[249.700019] Starting subtest: nb-await
[249.701224] Starting dynamic subtest: rcs0
[249.816174] Dynamic subtest rcs0: SUCCESS (0.109s)
[249.827216] Starting dynamic subtest: bcs0
[249.872088] Dynamic subtest bcs0: SUCCESS (0.061s)
[249.900440] Starting dynamic subtest: vcs0
[249.949681] Dynamic subtest vcs0: SUCCESS (0.075s)
[249.965812] Starting dynamic subtest: vcs1
[250.016437] Dynamic subtest vcs1: SUCCESS (0.064s)
[250.033340] Starting dynamic subtest: vecs0
[250.085364] Dynamic subtest vecs0: SUCCESS (0.068s)
[250.114474] Starting dynamic subtest: vecs1
[250.162571] Dynamic subtest vecs1: SUCCESS (0.075s)
[250.204853] Starting dynamic subtest: ccs0
[250.256891] Dynamic subtest ccs0: SUCCESS (0.092s)
[250.258107] Subtest nb-await: SUCCESS (0.558s)
[251.016200] [056/133] (814s left) gem_ctx_shared (q-independent)
[251.109948] Starting subtest: Q-independent
[251.110903] Starting dynamic subtest: rcs0
[251.362758] Dynamic subtest rcs0: SUCCESS (0.245s)
[251.373965] Starting dynamic subtest: bcs0
[251.521322] Dynamic subtest bcs0: SUCCESS (0.159s)
[251.532696] Starting dynamic subtest: vcs0
[251.684433] Dynamic subtest vcs0: SUCCESS (0.169s)
[251.695847] Starting dynamic subtest: vcs1
[251.856689] Dynamic subtest vcs1: SUCCESS (0.171s)
[251.867934] Starting dynamic subtest: vecs0
[252.025553] Dynamic subtest vecs0: SUCCESS (0.168s)
[252.036957] Starting dynamic subtest: vecs1
[252.197789] Dynamic subtest vecs1: SUCCESS (0.171s)
[252.209465] Starting dynamic subtest: ccs0
[252.364159] Dynamic subtest ccs0: SUCCESS (0.166s)
[252.365007] Subtest Q-independent: SUCCESS (1.255s)
[252.728478] [057/133] (812s left) kms_scaling_modes (scaling-mode-center)
[252.914473] Starting subtest: scaling-mode-center
[252.919616] Subtest scaling-mode-center: SKIP (0.001s)
[253.098648] [058/133] (812s left) kms_busy (extended-modeset-hang-newfb)
[253.292403] Starting subtest: extended-modeset-hang-newfb
[253.294665] Starting dynamic subtest: pipe-A
[269.018922] Dynamic subtest pipe-A: SUCCESS (15.729s)
[269.044603] Starting dynamic subtest: pipe-D
[284.771022] Dynamic subtest pipe-D: SUCCESS (15.749s)
[284.772330] Subtest extended-modeset-hang-newfb: SUCCESS (31.489s)
[285.042356] [059/133] (780s left) gem_exec_reloc (basic-wc-noreloc)
[285.129303] Subtest basic-wc-noreloc: SKIP (0.000s)
[285.213334] [060/133] (780s left) kms_cursor_legacy (single-move)
[285.401469] Starting subtest: single-move
[285.402450] Starting dynamic subtest: pipe-A
[290.780912] Dynamic subtest pipe-A: SUCCESS (5.380s)
[290.792601] Starting dynamic subtest: pipe-B
[296.159931] Dynamic subtest pipe-B: SUCCESS (5.380s)
[296.171106] Starting dynamic subtest: pipe-C
[301.537713] Dynamic subtest pipe-C: SUCCESS (5.379s)
[301.548962] Starting dynamic subtest: pipe-D
[306.918467] Dynamic subtest pipe-D: SUCCESS (5.379s)
[306.929918] Starting dynamic subtest: all-pipes
[312.301020] Dynamic subtest all-pipes: SUCCESS (5.379s)
[312.301940] Subtest single-move: SUCCESS (26.901s)
[312.392477] [061/133] (753s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[312.584489] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[312.586380] Subtest psr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[312.767734] [062/133] (752s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render)
[312.961657] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render
[315.347209] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (2.385s)
[315.515681] [063/133] (750s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[315.703736] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[315.705674] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.002s)
[315.797791] [064/133] (749s left) kms_chamelium_audio (dp-audio)
[316.073809] Subtest dp-audio: SKIP (0.000s)
[316.230222] [065/133] (749s left) kms_addfb_basic (master-rmfb)
[316.312988] Starting subtest: master-rmfb
[316.329820] Subtest master-rmfb: SUCCESS (0.017s)
[316.575181] [066/133] (749s left) gem_exec_reloc (basic-wc-cpu)
[316.659948] Subtest basic-wc-cpu: SKIP (0.000s)
[316.760179] [067/133] (749s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[316.949603] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[316.951447] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[317.097959] [068/133] (748s left) gem_mmap_offset (bad-object)
[317.185040] Starting subtest: bad-object
[317.186010] Subtest bad-object: SUCCESS (0.000s)
[317.375286] [069/133] (748s left) kms_fence_pin_leak
[317.648915] [070/133] (748s left) perf (gen12-unprivileged-single-ctx-counters)
[318.038371] Starting subtest: gen12-unprivileged-single-ctx-counters
[318.039331] Starting dynamic subtest: rcs0
[318.136910] Dynamic subtest rcs0: SUCCESS (0.098s)
[318.137888] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.099s)
[318.202269] [071/133] (748s left) gem_exec_parallel (basic)
[318.316141] Starting subtest: basic
[318.317131] Starting dynamic subtest: rcs0
[319.833156] Dynamic subtest rcs0: SUCCESS (1.516s)
[319.849236] Starting dynamic subtest: bcs0
[321.370163] Dynamic subtest bcs0: SUCCESS (1.535s)
[321.383242] Starting dynamic subtest: vcs0
[322.860082] Dynamic subtest vcs0: SUCCESS (1.488s)
[322.876813] Starting dynamic subtest: vcs1
[324.346997] Dynamic subtest vcs1: SUCCESS (1.485s)
[324.362737] Starting dynamic subtest: vecs0
[325.814102] Dynamic subtest vecs0: SUCCESS (1.465s)
[325.829790] Starting dynamic subtest: vecs1
[327.277970] Dynamic subtest vecs1: SUCCESS (1.462s)
[327.289992] Starting dynamic subtest: ccs0
[328.758954] Dynamic subtest ccs0: SUCCESS (1.479s)
[328.759997] Subtest basic: SUCCESS (10.440s)
[329.042959] [072/133] (737s left) drm_read (empty-block)
[329.307984] Starting subtest: empty-block
[330.308534] Subtest empty-block: SUCCESS (1.000s)
[330.504591] [073/133] (735s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[330.694528] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[330.696364] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[330.830970] [074/133] (735s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[331.021769] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[331.023538] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[331.171342] [075/133] (735s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[331.360926] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[331.361723] Starting dynamic subtest: pipe-A
[333.357155] Dynamic subtest pipe-A: SUCCESS (1.996s)
[333.386649] Starting dynamic subtest: pipe-B
[335.372960] Dynamic subtest pipe-B: SUCCESS (2.013s)
[335.390826] Starting dynamic subtest: pipe-C
[335.669582] Dynamic subtest pipe-C: SUCCESS (0.295s)
[335.696880] Starting dynamic subtest: pipe-D
[335.982374] Dynamic subtest pipe-D: SUCCESS (0.311s)
[335.983554] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (4.623s)
[336.317386] [076/133] (730s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[336.510515] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[336.512318] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[336.734438] [077/133] (729s left) gem_ctx_persistence (legacy-engines-queued)
[336.821392] Starting subtest: legacy-engines-queued
[336.822400] Starting dynamic subtest: render
[336.916016] Dynamic subtest render: SUCCESS (0.094s)
[336.930879] Starting dynamic subtest: bsd1
[336.941778] Dynamic subtest bsd1: SUCCESS (0.024s)
[336.956441] Starting dynamic subtest: bsd2
[337.006962] Dynamic subtest bsd2: SUCCESS (0.064s)
[337.020958] Starting dynamic subtest: blt
[337.032729] Dynamic subtest blt: SUCCESS (0.024s)
[337.046273] Starting dynamic subtest: vebox
[337.077748] Dynamic subtest vebox: SUCCESS (0.044s)
[337.078696] Subtest legacy-engines-queued: SUCCESS (0.257s)
[337.269348] [078/133] (729s left) syncobj_timeline (etime-single-wait-all-submitted)
[337.349935] Starting subtest: etime-single-wait-all-submitted
[337.455215] Subtest etime-single-wait-all-submitted: SUCCESS (0.105s)
[337.615914] [079/133] (729s left) perf_pmu (event-wait)
[337.687991] Starting subtest: event-wait
[337.688941] Starting dynamic subtest: rcs0
[337.690763] Dynamic subtest rcs0: SKIP (0.000s)
[337.692553] Subtest event-wait: SKIP (0.001s)
[337.867046] [080/133] (729s left) kms_addfb_basic (no-handle)
[337.948414] Starting subtest: no-handle
[337.949366] Subtest no-handle: SUCCESS (0.000s)
[338.177906] [081/133] (728s left) gem_lmem_swapping (basic)
[340.829112] Starting subtest: basic
[340.830004] Starting dynamic subtest: lmem0
[361.311978] Dynamic subtest lmem0: SUCCESS (20.480s)
[361.312976] Subtest basic: SUCCESS (20.481s)
[362.539651] [FACT gem_lmem_swapping (basic)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[362.540630] [FACT gem_lmem_swapping (basic)] deleted: kernel.kmod_is_loaded.i915: true
[362.542633] [082/133] (704s left) kms_vblank (wait-forked)
[364.318458] Starting subtest: wait-forked
[364.320883] Starting dynamic subtest: pipe-A-DP-3
[366.717968] Dynamic subtest pipe-A-DP-3: SUCCESS (2.395s)
[366.742372] Starting dynamic subtest: pipe-D-DP-3
[369.064479] Dynamic subtest pipe-D-DP-3: SUCCESS (2.336s)
[369.065655] Subtest wait-forked: SUCCESS (4.745s)
[369.346347] [FACT kms_vblank (wait-forked)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[369.349019] [FACT kms_vblank (wait-forked)] new: kernel.kmod_is_loaded.i915: true
[369.351870] [083/133] (697s left) gem_exec_schedule (promotion)
[369.456446] Starting subtest: promotion
[369.457463] Starting dynamic subtest: rcs0
[369.773472] Dynamic subtest rcs0: SUCCESS (0.316s)
[369.784063] Starting dynamic subtest: bcs0
[369.992732] Dynamic subtest bcs0: SUCCESS (0.218s)
[370.003969] Starting dynamic subtest: vcs0
[370.224562] Dynamic subtest vcs0: SUCCESS (0.231s)
[370.235056] Starting dynamic subtest: vcs1
[370.451287] Dynamic subtest vcs1: SUCCESS (0.225s)
[370.462308] Starting dynamic subtest: vecs0
[370.704950] Dynamic subtest vecs0: SUCCESS (0.252s)
[370.718093] Starting dynamic subtest: vecs1
[370.921510] Dynamic subtest vecs1: SUCCESS (0.215s)
[370.932361] Starting dynamic subtest: ccs0
[371.147322] Dynamic subtest ccs0: SUCCESS (0.225s)
[371.148423] Subtest promotion: SUCCESS (1.691s)
[371.574187] [084/133] (695s left) kms_cursor_crc (cursor-offscreen-64x64)
[371.903611] Starting subtest: cursor-offscreen-64x64
[371.907986] Starting dynamic subtest: pipe-A-DP-3
[374.482007] Dynamic subtest pipe-A-DP-3: SUCCESS (2.571s)
[374.530439] Starting dynamic subtest: pipe-D-DP-3
[377.012815] Dynamic subtest pipe-D-DP-3: SUCCESS (2.492s)
[377.013762] Subtest cursor-offscreen-64x64: SUCCESS (5.110s)
[377.451438] [085/133] (689s left) syncobj_wait (single-wait-signaled)
[377.534888] Starting subtest: single-wait-signaled
[377.535934] Subtest single-wait-signaled: SUCCESS (0.000s)
[377.678464] [086/133] (689s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[377.874895] Starting subtest: x-tiled-8bpp-rotate-0
[379.483406] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.607s)
[379.714436] [087/133] (687s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[379.901439] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[379.903801] Starting dynamic subtest: pipe-A-DP-3
[379.907394] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[379.918334] Starting dynamic subtest: pipe-B-DP-3
[379.921819] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[379.932504] Starting dynamic subtest: pipe-C-DP-3
[379.936073] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[379.946603] Starting dynamic subtest: pipe-D-DP-3
[379.950095] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[379.951799] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.008s)
[380.352023] [088/133] (687s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[380.544607] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[380.546625] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[380.685310] [089/133] (686s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[380.880496] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[380.882374] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[381.102586] [090/133] (686s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[381.293984] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[392.267222] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (10.974s)
[392.521095] [091/133] (675s left) gem_close_race (multigpu-basic-threads)
[392.649903] Starting subtest: multigpu-basic-threads
[392.652128] Subtest multigpu-basic-threads: SKIP (0.000s)
[392.931737] [092/133] (675s left) syncobj_wait (single-wait-submitted)
[393.013042] Starting subtest: single-wait-submitted
[393.119771] Subtest single-wait-submitted: SUCCESS (0.106s)
[393.269378] [093/133] (674s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[393.689844] Starting subtest: cursor-rapid-movement-256x256
[393.694000] Starting dynamic subtest: pipe-A-DP-3
[394.151048] Dynamic subtest pipe-A-DP-3: SUCCESS (0.455s)
[394.201914] Starting dynamic subtest: pipe-D-DP-3
[394.600701] Dynamic subtest pipe-D-DP-3: SUCCESS (0.408s)
[394.601781] Subtest cursor-rapid-movement-256x256: SUCCESS (0.912s)
[394.949448] [094/133] (673s left) gem_render_copy (yf-tiled-to-vebox-linear)
[395.040425] Starting subtest: yf-tiled-to-vebox-linear
[395.042880] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[395.303633] [095/133] (672s left) dumb_buffer (create-valid-dumb)
[395.382731] Starting subtest: create-valid-dumb
[395.383686] Subtest create-valid-dumb: SUCCESS (0.000s)
[395.552503] [096/133] (672s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[395.742671] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[395.744482] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[395.887503] [097/133] (672s left) sysfs_defaults (readonly)
[395.976918] Starting subtest: readonly
[395.977899] Starting dynamic subtest: vecs0
[395.978826] Dynamic subtest vecs0: SUCCESS (0.000s)
[395.989921] Starting dynamic subtest: ccs0
[395.991009] Dynamic subtest ccs0: SUCCESS (0.000s)
[396.001790] Starting dynamic subtest: vcs0
[396.003115] Dynamic subtest vcs0: SUCCESS (0.000s)
[396.013697] Starting dynamic subtest: bcs0
[396.015007] Dynamic subtest bcs0: SUCCESS (0.000s)
[396.025738] Starting dynamic subtest: vecs1
[396.027031] Dynamic subtest vecs1: SUCCESS (0.000s)
[396.038061] Starting dynamic subtest: rcs0
[396.039273] Dynamic subtest rcs0: SUCCESS (0.000s)
[396.050148] Starting dynamic subtest: vcs1
[396.051324] Dynamic subtest vcs1: SUCCESS (0.000s)
[396.052560] Subtest readonly: SUCCESS (0.012s)
[396.107304] [098/133] (672s left) kms_selftest (drm_damage_helper)
[396.162196] Starting subtest: drm_damage_helper
[396.191767] Starting dynamic subtest: drm_test_damage_iter_no_damage
[396.254138] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.062s)
[396.285906] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[396.327106] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.070s)
[396.364803] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[396.400566] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.070s)
[396.425416] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[396.477864] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.070s)
[396.519971] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[396.563050] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.084s)
[396.593545] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[396.629243] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.063s)
[396.656843] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[396.701486] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.068s)
[396.740210] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[396.770411] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.065s)
[396.789877] Starting dynamic subtest: drm_test_damage_iter_single_damage
[396.837392] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.064s)
[396.882340] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[396.907402] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.066s)
[396.923740] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[396.977077] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.067s)
[397.018003] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[397.054971] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.074s)
[397.084051] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[397.121103] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.064s)
[397.138265] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[397.194401] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.069s)
[397.232833] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[397.267876] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.071s)
[397.293136] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[397.338214] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.067s)
[397.352666] Starting dynamic subtest: drm_test_damage_iter_damage
[397.404825] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.063s)
[397.450884] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[397.482833] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.075s)
[397.503943] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[397.560752] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.074s)
[397.604022] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[397.633439] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.068s)
[397.650033] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[397.704738] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.069s)
[397.711794] Subtest drm_damage_helper: SUCCESS (1.544s)
[397.924184] [099/133] (670s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[398.112002] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[398.119860] Starting dynamic subtest: pipe-A-DP-3
[398.128872] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[398.139735] Starting dynamic subtest: pipe-B-DP-3
[398.148013] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[398.158794] Starting dynamic subtest: pipe-C-DP-3
[398.167424] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[398.178217] Starting dynamic subtest: pipe-D-DP-3
[398.188469] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[398.190648] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.008s)
[398.575595] [100/133] (670s left) kms_flip (plain-flip-ts-check-interruptible)
[398.770905] Starting subtest: plain-flip-ts-check-interruptible
[398.774586] Starting dynamic subtest: A-DP3
[406.889100] Dynamic subtest A-DP3: SUCCESS (8.115s)
[406.903111] Starting dynamic subtest: B-DP3
[414.940269] Dynamic subtest B-DP3: SUCCESS (8.049s)
[414.956261] Starting dynamic subtest: C-DP3
[422.986770] Dynamic subtest C-DP3: SUCCESS (8.042s)
[423.029537] Starting dynamic subtest: D-DP3
[431.067023] Dynamic subtest D-DP3: SUCCESS (8.075s)
[431.077044] Subtest plain-flip-ts-check-interruptible: SUCCESS (32.310s)
[431.406949] [101/133] (637s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[431.596467] Starting subtest: primary-yf-tiled-reflect-x-0
[431.697050] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.099s)
[431.868328] [102/133] (636s left) gem_wait (busy)
[431.960000] Starting subtest: busy
[431.960882] Starting dynamic subtest: all-engines
[432.566813] Dynamic subtest all-engines: SUCCESS (0.606s)
[432.581171] Starting dynamic subtest: rcs0
[433.106636] Dynamic subtest rcs0: SUCCESS (0.538s)
[433.118902] Starting dynamic subtest: bcs0
[433.646891] Dynamic subtest bcs0: SUCCESS (0.539s)
[433.659294] Starting dynamic subtest: vcs0
[434.186863] Dynamic subtest vcs0: SUCCESS (0.539s)
[434.199170] Starting dynamic subtest: vcs1
[434.727866] Dynamic subtest vcs1: SUCCESS (0.540s)
[434.740175] Starting dynamic subtest: vecs0
[435.268600] Dynamic subtest vecs0: SUCCESS (0.540s)
[435.281001] Starting dynamic subtest: vecs1
[435.807782] Dynamic subtest vecs1: SUCCESS (0.538s)
[435.820131] Starting dynamic subtest: ccs0
[436.346545] Dynamic subtest ccs0: SUCCESS (0.538s)
[436.347499] Subtest busy: SUCCESS (4.388s)
[436.596469] [103/133] (632s left) gem_exec_flush (basic-uc-prw-default)
[436.688176] Subtest basic-uc-prw-default: SKIP (0.000s)
[436.758179] [104/133] (632s left) syncobj_basic (bad-flags-fd-to-handle)
[436.842580] Starting subtest: bad-flags-fd-to-handle
[436.843630] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[437.001592] [105/133] (631s left) gem_exec_schedule (manyslice)
[437.094542] Starting subtest: manyslice
[437.095467] Starting dynamic subtest: rcs0
[443.081047] Dynamic subtest rcs0: SUCCESS (5.985s)
[443.092866] Starting dynamic subtest: bcs0
[449.058046] Dynamic subtest bcs0: SUCCESS (5.977s)
[449.072077] Starting dynamic subtest: vcs0
[455.837895] Dynamic subtest vcs0: SUCCESS (6.778s)
[455.849794] Starting dynamic subtest: vcs1
[462.098228] Dynamic subtest vcs1: SUCCESS (6.260s)
[462.112605] Starting dynamic subtest: vecs0
[467.843467] Dynamic subtest vecs0: SUCCESS (5.745s)
[467.857636] Starting dynamic subtest: vecs1
[473.588470] Dynamic subtest vecs1: SUCCESS (5.743s)
[473.602489] Starting dynamic subtest: ccs0
[479.593280] Dynamic subtest ccs0: SUCCESS (6.005s)
[479.594819] Subtest manyslice: SUCCESS (42.507s)
[480.006439] [106/133] (589s left) api_intel_bb (lot-of-buffers)
[480.088017] Starting subtest: lot-of-buffers
[483.408467] Subtest lot-of-buffers: SUCCESS (3.321s)
[483.630305] [107/133] (585s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[483.709940] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[483.710900] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[483.859098] [108/133] (585s left) vgem_basic (create)
[483.921795] Starting subtest: create
[483.922717] Subtest create: SUCCESS (0.000s)
[484.003754] [109/133] (585s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[484.199083] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[484.200789] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[484.354958] [110/133] (584s left) kms_flip (2x-plain-flip-ts-check)
[484.542118] Starting subtest: 2x-plain-flip-ts-check
[484.557551] Subtest 2x-plain-flip-ts-check: SKIP (0.015s)
[484.658679] [111/133] (584s left) gem_exec_fence (expired-history)
[485.187290] Starting subtest: expired-history
[491.545477] Subtest expired-history: SUCCESS (6.359s)
[493.270337] [112/133] (576s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[493.468887] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[494.753606] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.284s)
[494.974336] [113/133] (574s left) api_intel_allocator (two-level-inception)
[495.056879] Starting subtest: two-level-inception
[500.474913] Subtest two-level-inception: SUCCESS (5.418s)
[500.683575] [114/133] (568s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[500.874164] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[500.875938] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[501.013510] [115/133] (568s left) kms_plane_multiple (2x-tiling-y)
[501.201983] Starting subtest: 2x-tiling-y
[501.203717] Subtest 2x-tiling-y: SKIP (0.000s)
[501.311427] [116/133] (568s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs)
[501.497300] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs
[501.499681] Starting dynamic subtest: pipe-A-DP-3
[501.521927] Dynamic subtest pipe-A-DP-3: SKIP (0.002s)
[501.533079] Starting dynamic subtest: pipe-B-DP-3
[501.563106] Dynamic subtest pipe-B-DP-3: SKIP (0.002s)
[501.574336] Starting dynamic subtest: pipe-C-DP-3
[501.600480] Dynamic subtest pipe-C-DP-3: SKIP (0.002s)
[501.613079] Starting dynamic subtest: pipe-D-DP-3
[501.640013] Dynamic subtest pipe-D-DP-3: SKIP (0.002s)
[501.642183] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.015s)
[501.983534] [117/133] (567s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[502.173879] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[502.175670] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.000s)
[502.265486] [118/133] (567s left) syncobj_timeline (invalid-signal-illegal-point)
[502.346909] Starting subtest: invalid-signal-illegal-point
[502.347990] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[502.514921] [119/133] (567s left) gem_pxp (protected-raw-src-copy-not-readible)
[505.121927] Starting subtest: protected-raw-src-copy-not-readible
[505.123853] Subtest protected-raw-src-copy-not-readible: SKIP (0.000s)
[505.265943] [120/133] (564s left) kms_psr (fbc-pr-cursor-plane-onoff)
[505.453825] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[505.509228] [121/133] (564s left) kms_content_protection (atomic-dpms)
[505.757810] Starting subtest: atomic-dpms
[505.795021] Starting dynamic subtest: pipe-A-DP-3
[628.766786] Dynamic subtest pipe-A-DP-3: FAIL (122.822s)
[628.768163] Subtest atomic-dpms: FAIL (122.965s)
[628.968968] [122/133] (441s left) kms_plane (pixel-format-linear-modifier)
[629.158913] Starting subtest: pixel-format-linear-modifier
[629.189300] Starting dynamic subtest: pipe-A-plane-0
[634.954105] Dynamic subtest pipe-A-plane-0: SUCCESS (5.766s)
[634.971325] Starting dynamic subtest: pipe-A-plane-3
[638.303140] Dynamic subtest pipe-A-plane-3: SUCCESS (3.348s)
[638.317596] Starting dynamic subtest: pipe-A-plane-5
[638.520048] Dynamic subtest pipe-A-plane-5: SUCCESS (0.216s)
[638.790998] Starting dynamic subtest: pipe-B-plane-0
[644.817907] Dynamic subtest pipe-B-plane-0: SUCCESS (6.049s)
[644.866431] Starting dynamic subtest: pipe-B-plane-3
[648.150325] Dynamic subtest pipe-B-plane-3: SUCCESS (3.331s)
[648.165435] Starting dynamic subtest: pipe-B-plane-5
[648.417258] Dynamic subtest pipe-B-plane-5: SUCCESS (0.266s)
[648.507567] Subtest pixel-format-linear-modifier: SUCCESS (19.355s)
[648.814282] [123/133] (421s left) kms_psr (psr2-primary-mmap-gtt)
[649.003141] Subtest psr2-primary-mmap-gtt: SKIP (0.000s)
[649.071404] [124/133] (421s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[649.260961] Starting subtest: plane-all-modeset-transition-fencing
[649.261910] Starting dynamic subtest: pipe-A-DP-3
[676.309290] Dynamic subtest pipe-A-DP-3: SUCCESS (27.053s)
[676.422640] Starting dynamic subtest: pipe-B-DP-3
[699.999307] Dynamic subtest pipe-B-DP-3: SUCCESS (23.619s)
[700.053042] Subtest plane-all-modeset-transition-fencing: SUCCESS (50.804s)
[700.345829] [125/133] (370s left) perf (invalid-oa-format-id)
[700.726883] Starting subtest: invalid-oa-format-id
[700.745693] Subtest invalid-oa-format-id: SUCCESS (0.019s)
[700.798639] [126/133] (369s left) gem_workarounds (suspend-resume-fd)
[700.899937] Starting subtest: suspend-resume-fd
[720.714223] Subtest suspend-resume-fd: SUCCESS (3.941s)
[739.875206] [127/133] (349s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[740.070604] Starting subtest: cursorB-vs-flipB-atomic-transitions
[740.072384] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s)
[740.191767] [128/133] (349s left) gem_ccs (ctrl-surf-copy-new-ctx)
[740.279549] Starting subtest: ctrl-surf-copy-new-ctx
[740.281848] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0
[740.339519] Dynamic subtest linear-compressed-compfmt0-smem-lmem0: SUCCESS (0.059s)
[740.354256] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0
[740.537334] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.196s)
[740.551667] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0
[740.566540] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0: SUCCESS (0.028s)
[740.581051] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0
[740.765181] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.197s)
[740.779488] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0
[740.793718] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0: SUCCESS (0.027s)
[740.808491] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0
[740.998486] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.203s)
[741.012768] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0
[741.028545] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0: SUCCESS (0.029s)
[741.042965] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0
[741.232538] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.202s)
[741.233504] Subtest ctrl-surf-copy-new-ctx: SUCCESS (0.952s)
[741.427968] [129/133] (348s left) perf (non-sampling-read-error)
[741.639549] Starting subtest: non-sampling-read-error
[741.656133] Subtest non-sampling-read-error: SUCCESS (0.016s)
[741.724526] [130/133] (348s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[741.916320] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[741.918118] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[742.053228] [131/133] (347s left) gem_exec_balancer (hog)
[742.142878] Starting subtest: hog
[742.144744] Subtest hog: SKIP (0.000s)
[742.546178] [132/133] (347s left) kms_psr (pr-sprite-mmap-cpu)
[742.733218] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[742.791742] [133/133] (347s left) kms_feature_discovery (dp-mst)
[742.981654] Starting subtest: dp-mst
[742.983496] Subtest dp-mst: SKIP (0.000s)
[744.085650] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_edge_walk
results: parsing output: 1/ for test: kms_color_pipeline
results: parsing output: 2/ for test: gem_softpin
results: parsing output: 3/ for test: gem_exec_reloc
results: parsing output: 4/ for test: i915_fb_tiling
results: parsing output: 5/ for test: i915_suspend
results: parsing output: 6/ for test: i915_pm_rpm
results: parsing output: 7/ for test: kms_cursor_legacy
results: parsing output: 8/ for test: gem_exec_whisper
results: parsing output: 9/ for test: gem_ctx_param
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: kms_addfb_basic
results: parsing output: 12/ for test: gen9_exec_parse
results: parsing output: 13/ for test: kms_chamelium_color
results: parsing output: 14/ for test: gem_ctx_persistence
results: parsing output: 15/ for test: kms_joiner
results: parsing output: 16/ for test: kms_big_fb
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_async_flips
results: parsing output: 19/ for test: gem_exec_gttfill
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: kms_properties
results: parsing output: 23/ for test: kms_flip
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: gem_exec_params
results: parsing output: 26/ for test: gem_set_tiling_vs_blt
results: parsing output: 27/ for test: kms_psr
results: parsing output: 28/ for test: kms_flip
results: parsing output: 29/ for test: syncobj_eventfd
results: parsing output: 30/ for test: prime_self_import
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: gem_exec_reloc
results: parsing output: 34/ for test: syncobj_timeline
results: parsing output: 35/ for test: kms_pm_backlight
results: parsing output: 36/ for test: kms_properties
results: parsing output: 37/ for test: kms_pm_rpm
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_psr
results: parsing output: 40/ for test: kms_pipe_stress
results: parsing output: 41/ for test: prime_vgem
results: parsing output: 42/ for test: kms_cursor_legacy
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: kms_psr2_sf
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: gem_mmap
results: parsing output: 48/ for test: gem_fence_thrash
results: parsing output: 49/ for test: gem_mmap
results: parsing output: 50/ for test: i915_drm_fdinfo
results: parsing output: 51/ for test: kms_chamelium_hpd
results: parsing output: 52/ for test: kms_lease
results: parsing output: 53/ for test: kms_pm_backlight
results: parsing output: 54/ for test: gem_exec_fence
results: parsing output: 55/ for test: gem_ctx_shared
results: parsing output: 56/ for test: kms_scaling_modes
results: parsing output: 57/ for test: kms_busy
results: parsing output: 58/ for test: gem_exec_reloc
results: parsing output: 59/ for test: kms_cursor_legacy
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_cursor_legacy
results: parsing output: 63/ for test: kms_chamelium_audio
results: parsing output: 64/ for test: kms_addfb_basic
results: parsing output: 65/ for test: gem_exec_reloc
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_mmap_offset
results: parsing output: 68/ for test: kms_fence_pin_leak
results: parsing output: 69/ for test: perf
results: parsing output: 70/ for test: gem_exec_parallel
results: parsing output: 71/ for test: drm_read
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_plane_scaling
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_ctx_persistence
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: perf_pmu
results: parsing output: 79/ for test: kms_addfb_basic
results: parsing output: 80/ for test: gem_lmem_swapping
results: parsing output: 81/ for test: kms_vblank
results: parsing output: 82/ for test: gem_exec_schedule
results: parsing output: 83/ for test: kms_cursor_crc
results: parsing output: 84/ for test: syncobj_wait
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_cursor_legacy
results: parsing output: 90/ for test: gem_close_race
results: parsing output: 91/ for test: syncobj_wait
results: parsing output: 92/ for test: kms_cursor_crc
results: parsing output: 93/ for test: gem_render_copy
results: parsing output: 94/ for test: dumb_buffer
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: sysfs_defaults
results: parsing output: 97/ for test: kms_selftest
results: parsing output: 98/ for test: kms_ccs
results: parsing output: 99/ for test: kms_flip
results: parsing output: 100/ for test: kms_rotation_crc
results: parsing output: 101/ for test: gem_wait
results: parsing output: 102/ for test: gem_exec_flush
results: parsing output: 103/ for test: syncobj_basic
results: parsing output: 104/ for test: gem_exec_schedule
results: parsing output: 105/ for test: api_intel_bb
results: parsing output: 106/ for test: syncobj_wait
results: parsing output: 107/ for test: vgem_basic
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_flip
results: parsing output: 110/ for test: gem_exec_fence
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: api_intel_allocator
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_plane_multiple
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: kms_flip_scaled_crc
results: parsing output: 117/ for test: syncobj_timeline
results: parsing output: 118/ for test: gem_pxp
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: kms_content_protection
results: parsing output: 121/ for test: kms_plane
results: parsing output: 122/ for test: kms_psr
results: parsing output: 123/ for test: kms_atomic_transition
results: parsing output: 124/ for test: perf
results: parsing output: 125/ for test: gem_workarounds
results: parsing output: 126/ for test: kms_cursor_legacy
results: parsing output: 127/ for test: gem_ccs
results: parsing output: 128/ for test: perf
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: gem_exec_balancer
results: parsing output: 131/ for test: kms_psr
results: parsing output: 132/ for test: kms_feature_discovery
Done.