[67.222813] Initializing watchdogs
[67.222897]   /dev/watchdog0
[67.254026] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[67.269232] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[67.274140] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[67.277097] [001/131] (960s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[68.769295] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[68.770860] Subtest psr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[68.985510] [002/131] (958s left) gem_ctx_bad_destroy (invalid-default-ctx)
[69.030744] Starting subtest: invalid-default-ctx
[69.031542] Subtest invalid-default-ctx: SUCCESS (0.000s)
[69.171310] [003/131] (958s left) gem_exec_schedule (preempt-self)
[69.236694] Starting subtest: preempt-self
[69.237567] Starting dynamic subtest: rcs0
[69.281446] Dynamic subtest rcs0: SUCCESS (0.045s)
[69.289560] Starting dynamic subtest: bcs0
[69.306587] Dynamic subtest bcs0: SUCCESS (0.025s)
[69.314847] Starting dynamic subtest: vcs0
[69.333543] Dynamic subtest vcs0: SUCCESS (0.027s)
[69.341541] Starting dynamic subtest: vcs1
[69.359546] Dynamic subtest vcs1: SUCCESS (0.026s)
[69.367660] Starting dynamic subtest: vecs0
[69.384471] Dynamic subtest vecs0: SUCCESS (0.025s)
[69.385300] Subtest preempt-self: SUCCESS (0.148s)
[69.855676] [004/131] (958s left) perf (gen8-unprivileged-single-ctx-counters)
[70.007725] Starting subtest: gen8-unprivileged-single-ctx-counters
[70.009404] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[70.080212] [005/131] (958s left) kms_color (deep-color)
[71.566483] Starting subtest: deep-color
[71.576183] Subtest deep-color: SKIP (0.005s)
[71.698825] [006/131] (956s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[71.769684] Starting subtest: invalid-bsd2-flag-on-vebox
[71.770802] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[72.069190] [007/131] (956s left) gem_ctx_persistence (hostile)
[72.135974] Starting subtest: hostile
[82.265185] Subtest hostile: SUCCESS (10.129s)
[82.397804] [008/131] (945s left) kms_chamelium_edid (dp-mode-timings)
[83.924376] Subtest dp-mode-timings: SKIP (0.000s)
[84.029152] [009/131] (944s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[84.081440] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[84.082409] Starting dynamic subtest: smem
[84.186372] Dynamic subtest smem: SUCCESS (0.105s)
[84.194515] Starting dynamic subtest: lmem0
[85.302365] Dynamic subtest lmem0: SUCCESS (1.113s)
[85.303365] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SUCCESS (1.218s)
[85.568481] [010/131] (942s left) kms_cursor_crc (cursor-onscreen-512x170)
[87.347234] Starting subtest: cursor-onscreen-512x170
[87.349890] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[87.555520] [011/131] (941s left) kms_vblank (query-idle)
[89.038272] Starting subtest: query-idle
[89.039330] Starting dynamic subtest: pipe-A-HDMI-A-4
[91.410312] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.371s)
[91.421360] Starting dynamic subtest: pipe-D-HDMI-A-4
[93.588408] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.175s)
[93.589285] Subtest query-idle: SUCCESS (4.551s)
[93.746398] [012/131] (934s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[95.233311] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[95.308115] [013/131] (933s left) kms_plane (plane-position-hole-dpms)
[96.796728] Starting subtest: plane-position-hole-dpms
[97.226562] Starting dynamic subtest: pipe-A-plane-1
[97.707101] Dynamic subtest pipe-A-plane-1: SUCCESS (0.480s)
[97.715431] Starting dynamic subtest: pipe-A-plane-2
[98.191364] Dynamic subtest pipe-A-plane-2: SUCCESS (0.484s)
[98.200039] Starting dynamic subtest: pipe-A-plane-3
[98.694732] Dynamic subtest pipe-A-plane-3: SUCCESS (0.503s)
[98.703192] Starting dynamic subtest: pipe-A-plane-4
[99.180402] Dynamic subtest pipe-A-plane-4: SUCCESS (0.486s)
[99.188947] Starting dynamic subtest: pipe-A-plane-5
[99.682446] Dynamic subtest pipe-A-plane-5: SUCCESS (0.502s)
[99.690953] Starting dynamic subtest: pipe-A-plane-6
[100.180883] Dynamic subtest pipe-A-plane-6: SUCCESS (0.499s)
[100.189414] Starting dynamic subtest: pipe-A-plane-7
[100.202385] Dynamic subtest pipe-A-plane-7: SUCCESS (0.021s)
[100.490349] Starting dynamic subtest: pipe-B-plane-1
[100.917190] Dynamic subtest pipe-B-plane-1: SUCCESS (0.436s)
[100.925940] Starting dynamic subtest: pipe-B-plane-2
[101.403259] Dynamic subtest pipe-B-plane-2: SUCCESS (0.486s)
[101.411547] Starting dynamic subtest: pipe-B-plane-3
[101.869443] Dynamic subtest pipe-B-plane-3: SUCCESS (0.467s)
[101.877928] Starting dynamic subtest: pipe-B-plane-4
[102.321014] Dynamic subtest pipe-B-plane-4: SUCCESS (0.450s)
[102.329551] Starting dynamic subtest: pipe-B-plane-5
[102.786223] Dynamic subtest pipe-B-plane-5: SUCCESS (0.466s)
[102.794881] Starting dynamic subtest: pipe-B-plane-6
[103.246805] Dynamic subtest pipe-B-plane-6: SUCCESS (0.459s)
[103.257978] Starting dynamic subtest: pipe-B-plane-7
[103.276734] Dynamic subtest pipe-B-plane-7: SUCCESS (0.029s)
[103.278846] Subtest plane-position-hole-dpms: SUCCESS (6.480s)
[103.451342] [014/131] (925s left) gem_pread (snoop)
[103.498967] Subtest snoop: SKIP (0.000s)
[103.577057] [015/131] (925s left) gem_ctx_bad_destroy (double-destroy)
[103.620658] Starting subtest: double-destroy
[103.621556] Subtest double-destroy: SUCCESS (0.000s)
[103.715703] [016/131] (925s left) kms_flip (dpms-vs-vblank-race)
[105.199025] Starting subtest: dpms-vs-vblank-race
[105.206242] Starting dynamic subtest: A-HDMI-A4
[108.269048] Dynamic subtest A-HDMI-A4: SUCCESS (3.063s)
[108.277566] Starting dynamic subtest: B-HDMI-A4
[111.214467] Dynamic subtest B-HDMI-A4: SUCCESS (2.944s)
[111.223083] Starting dynamic subtest: C-HDMI-A4
[114.176830] Dynamic subtest C-HDMI-A4: SUCCESS (2.960s)
[114.185298] Starting dynamic subtest: D-HDMI-A4
[117.126319] Dynamic subtest D-HDMI-A4: SUCCESS (2.947s)
[117.127292] Subtest dpms-vs-vblank-race: SUCCESS (11.927s)
[117.311449] [017/131] (911s left) kms_getfb (getfb2-accept-nv12)
[118.809438] Starting subtest: getfb2-accept-nv12
[118.812325] Subtest getfb2-accept-nv12: SUCCESS (0.002s)
[118.990030] [018/131] (910s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[120.478858] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[120.480691] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[120.583587] [019/131] (908s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[120.636457] Starting subtest: etime-single-wait-for-submit-submitted
[120.748341] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.108s)
[120.890416] [020/131] (908s left) kms_plane_scaling (planes-upscale-factor-0-25)
[122.374799] Starting subtest: planes-upscale-factor-0-25
[122.375781] Starting dynamic subtest: pipe-A
[122.483565] Dynamic subtest pipe-A: SUCCESS (0.109s)
[122.493813] Starting dynamic subtest: pipe-B
[122.624541] Dynamic subtest pipe-B: SUCCESS (0.140s)
[122.634384] Starting dynamic subtest: pipe-C
[122.765594] Dynamic subtest pipe-C: SUCCESS (0.140s)
[122.775519] Starting dynamic subtest: pipe-D
[122.906490] Dynamic subtest pipe-D: SUCCESS (0.140s)
[122.907333] Subtest planes-upscale-factor-0-25: SUCCESS (0.534s)
[123.071262] [021/131] (906s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[124.559848] Starting subtest: fbcpsr-rgb101010-draw-render
[124.561753] Subtest fbcpsr-rgb101010-draw-render: SKIP (0.000s)
[124.728918] [022/131] (904s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[126.220230] Starting subtest: 2x-long-flip-vs-cursor-atomic
[126.223273] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.003s)
[126.324614] [023/131] (903s left) gem_exec_balancer (bonded-sync)
[126.387535] Starting subtest: bonded-sync
[126.389373] Subtest bonded-sync: SKIP (0.000s)
[126.854323] [024/131] (902s left) kms_feature_discovery (chamelium)
[128.339556] Starting subtest: chamelium
[128.341284] Subtest chamelium: SKIP (0.000s)
[128.440634] [025/131] (901s left) kms_pm_backlight (fade)
[129.929989] Subtest fade: SKIP (0.000s)
[130.000456] [026/131] (899s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[131.485541] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[131.486487] Starting dynamic subtest: pipe-A-HDMI-A-4
[131.494915] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[131.503462] Starting dynamic subtest: pipe-B-HDMI-A-4
[131.511949] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[131.520401] Starting dynamic subtest: pipe-C-HDMI-A-4
[131.529029] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[131.537327] Starting dynamic subtest: pipe-D-HDMI-A-4
[131.546386] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[131.548040] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.011s)
[131.717898] [027/131] (897s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[133.207493] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[133.209156] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[133.373533] [028/131] (896s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[134.866738] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.000s)
[134.931666] [029/131] (894s left) gem_mmap (bad-size)
[134.976911] Subtest bad-size: SKIP (0.000s)
[135.049531] [030/131] (894s left) perf_pmu (semaphore-wait)
[135.099853] Starting subtest: semaphore-wait
[135.100810] Starting dynamic subtest: rcs0
[135.631725] Dynamic subtest rcs0: SUCCESS (0.527s)
[135.642641] Starting dynamic subtest: bcs0
[136.146797] Dynamic subtest bcs0: SUCCESS (0.509s)
[136.157641] Starting dynamic subtest: vcs0
[136.661632] Dynamic subtest vcs0: SUCCESS (0.509s)
[136.672663] Starting dynamic subtest: vcs1
[137.177151] Dynamic subtest vcs1: SUCCESS (0.510s)
[137.188051] Starting dynamic subtest: vecs0
[137.692089] Dynamic subtest vecs0: SUCCESS (0.510s)
[137.695438] Subtest semaphore-wait: SUCCESS (2.592s)
[137.879623] [031/131] (892s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[137.926688] Starting subtest: single-wait-for-submit-available-submitted
[137.927485] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s)
[138.048599] [032/131] (892s left) perf_pmu (busy-accuracy-2)
[138.098474] Starting subtest: busy-accuracy-2
[138.099304] Starting dynamic subtest: rcs0
[141.156393] Dynamic subtest rcs0: SUCCESS (3.056s)
[141.165831] Starting dynamic subtest: bcs0
[144.217240] Dynamic subtest bcs0: SUCCESS (3.059s)
[144.226579] Starting dynamic subtest: vcs0
[147.274384] Dynamic subtest vcs0: SUCCESS (3.055s)
[147.283901] Starting dynamic subtest: vcs1
[150.332402] Dynamic subtest vcs1: SUCCESS (3.056s)
[150.341864] Starting dynamic subtest: vecs0
[153.390679] Dynamic subtest vecs0: SUCCESS (3.056s)
[153.391522] Subtest busy-accuracy-2: SUCCESS (15.292s)
[153.541670] [033/131] (876s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[155.026572] Starting subtest: flip-vs-cursor-toggle
[170.098092] Subtest flip-vs-cursor-toggle: SUCCESS (15.070s)
[170.266373] [034/131] (859s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[171.750406] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[171.752802] Starting dynamic subtest: pipe-A-valid-mode
[172.543281] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.790s)
[172.544280] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SUCCESS (0.793s)
[172.716271] [035/131] (857s left) gem_bad_reloc (negative-reloc-lut)
[172.768116] Subtest negative-reloc-lut: SKIP (0.000s)
[172.859996] [036/131] (857s left) gem_exec_reloc (basic-gtt-active)
[172.910556] Subtest basic-gtt-active: SKIP (0.000s)
[173.021771] [037/131] (857s left) syncobj_wait (multi-wait-all-signaled)
[173.067287] Starting subtest: multi-wait-all-signaled
[173.070472] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[173.187454] [038/131] (857s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[174.670428] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[174.672948] Starting dynamic subtest: pipe-A-HDMI-A-4
[174.681227] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.001s)
[174.690466] Starting dynamic subtest: pipe-B-HDMI-A-4
[174.698637] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.001s)
[174.707815] Starting dynamic subtest: pipe-C-HDMI-A-4
[174.715988] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.001s)
[174.725032] Starting dynamic subtest: pipe-D-HDMI-A-4
[174.734127] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.001s)
[174.735896] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.014s)
[174.910018] [039/131] (855s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling)
[176.394486] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling
[176.395312] Starting dynamic subtest: pipe-A-valid-mode
[178.766725] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.370s)
[178.767813] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SUCCESS (2.373s)
[178.940586] [040/131] (851s left) perf (non-system-wide-paranoid)
[179.056309] Starting subtest: non-system-wide-paranoid
[179.099993] Subtest non-system-wide-paranoid: SUCCESS (0.045s)
[179.172151] [041/131] (851s left) gem_exec_params (larger-than-life-batch)
[179.222245] Starting subtest: larger-than-life-batch
[189.607188] Subtest larger-than-life-batch: SUCCESS (10.381s)
[190.116521] [042/131] (840s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[191.648610] Starting subtest: basic-max-pipe-crc-check
[191.650479] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[191.718968] [043/131] (839s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[193.205738] Starting subtest: basic-flip-after-cursor-varying-size
[194.251153] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.045s)
[194.423909] [044/131] (836s left) gem_pxp (verify-pxp-stale-ctx-execution)
[196.998393] Starting subtest: verify-pxp-stale-ctx-execution
[197.000517] Subtest verify-pxp-stale-ctx-execution: SKIP (0.000s)
[197.114369] [045/131] (833s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[198.625208] Starting subtest: y-tiled-16bpp-rotate-0
[200.512571] Subtest y-tiled-16bpp-rotate-0: SUCCESS (1.885s)
[200.712548] [046/131] (830s left) gem_ctx_engines (none)
[200.768373] Starting subtest: none
[200.770799] Subtest none: SUCCESS (0.002s)
[201.079923] [047/131] (829s left) gen9_exec_parse (bb-large)
[201.132286] Subtest bb-large: SKIP (0.000s)
[201.215920] [048/131] (829s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[202.706173] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[202.707951] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[202.879473] [049/131] (828s left) vgem_basic (second-client)
[203.025495] Starting subtest: second-client
[203.058874] Subtest second-client: SUCCESS (0.033s)
[203.165365] [FACT vgem_basic (second-client)] new: kernel.kmod_is_loaded.vgem: true
[203.168380] [050/131] (828s left) kms_psr (fbc-pr-basic)
[204.651278] Subtest fbc-pr-basic: SKIP (0.000s)
[204.735890] [051/131] (826s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[206.226182] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[206.227916] Subtest fbcpsr-1p-pri-indfb-multidraw: SKIP (0.000s)
[206.395270] [052/131] (825s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[207.887856] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[210.792769] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (2.905s)
[211.066192] [053/131] (820s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[212.554516] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[212.636515] [054/131] (819s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[214.125403] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[214.127029] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[214.292378] [055/131] (817s left) kms_psr (fbc-pr-sprite-blt)
[215.778989] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[215.853861] [056/131] (815s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[217.357818] Starting subtest: yf-tiled-16bpp-rotate-180
[217.359490] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[217.530909] [057/131] (814s left) kms_content_protection (srm)
[219.077952] Starting subtest: srm
[219.083935] Subtest srm: SKIP (0.003s)
[219.298834] [058/131] (812s left) core_hotunplug (unbind-rebind)
[219.459555] Starting subtest: unbind-rebind
[224.081282] Subtest unbind-rebind: SUCCESS (4.622s)
[224.149114] [059/131] (807s left) i915_pm_rpm (gem-pread)
[228.063620] Starting subtest: gem-pread
[229.292467] Subtest gem-pread: SUCCESS (1.228s)
[230.231609] [060/131] (802s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[231.963327] Starting subtest: cursor-rapid-movement-256x85
[231.977984] Starting dynamic subtest: pipe-A-HDMI-A-4
[232.444915] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.467s)
[232.479307] Starting dynamic subtest: pipe-D-HDMI-A-4
[232.791700] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.321s)
[232.792479] Subtest cursor-rapid-movement-256x85: SUCCESS (0.829s)
[233.111279] [061/131] (799s left) i915_hangman (error-state-basic)
[233.174116] Starting subtest: error-state-basic
[233.280528] Subtest error-state-basic: SUCCESS (0.105s)
[233.390796] [062/131] (799s left) gem_exec_whisper (basic-contexts-all)
[233.448800] Starting subtest: basic-contexts-all
[240.639696] Subtest basic-contexts-all: SUCCESS (7.187s)
[240.911113] [063/131] (791s left) syncobj_wait (reset-multiple-signaled)
[240.958214] Starting subtest: reset-multiple-signaled
[240.959028] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[241.085508] [064/131] (791s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[242.569610] Starting subtest: primary-y-tiled-reflect-x-180
[253.205895] Subtest primary-y-tiled-reflect-x-180: SUCCESS (10.637s)
[253.473916] [065/131] (779s left) syncobj_timeline (invalid-query-zero-handles)
[253.520967] Starting subtest: invalid-query-zero-handles
[253.522499] Subtest invalid-query-zero-handles: SUCCESS (0.000s)
[253.648626] [066/131] (779s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[255.133783] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[255.136476] Starting dynamic subtest: pipe-A-HDMI-A-4
[255.157594] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.003s)
[255.169380] Starting dynamic subtest: pipe-B-HDMI-A-4
[255.191261] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.003s)
[255.202790] Starting dynamic subtest: pipe-C-HDMI-A-4
[255.224841] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.003s)
[255.236395] Starting dynamic subtest: pipe-D-HDMI-A-4
[255.257528] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.003s)
[255.259147] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.022s)
[255.387429] [067/131] (777s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[255.433568] Starting subtest: multi-wait-for-submit-available-submitted
[255.434454] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.001s)
[255.556648] [068/131] (777s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[257.041509] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[257.042357] Starting dynamic subtest: pipe-A-valid-mode
[259.494835] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.452s)
[259.495725] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SUCCESS (2.455s)
[259.670669] [069/131] (773s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[261.155821] Starting subtest: 2x-long-cursor-vs-flip-atomic
[261.158532] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.003s)
[261.277850] [070/131] (771s left) gem_spin_batch (resubmit-new-all)
[261.339924] Starting subtest: resubmit-new-all
[261.341113] Starting dynamic subtest: rcs0
[261.364832] Dynamic subtest rcs0: SUCCESS (0.024s)
[261.378606] Starting dynamic subtest: bcs0
[261.379683] Dynamic subtest bcs0: SUCCESS (0.008s)
[261.391399] Starting dynamic subtest: vcs0
[261.392519] Dynamic subtest vcs0: SUCCESS (0.007s)
[261.404499] Starting dynamic subtest: vcs1
[261.405867] Dynamic subtest vcs1: SUCCESS (0.008s)
[261.417660] Starting dynamic subtest: vecs0
[261.419092] Dynamic subtest vecs0: SUCCESS (0.007s)
[261.420454] Subtest resubmit-new-all: SUCCESS (0.062s)
[261.751690] [071/131] (771s left) gem_exec_fence (syncobj-timeline-chain-engines)
[262.369489] Starting subtest: syncobj-timeline-chain-engines
[262.513580] Subtest syncobj-timeline-chain-engines: SUCCESS (0.144s)
[262.822810] [072/131] (770s left) kms_rotation_crc (sprite-rotation-90)
[264.306344] Starting subtest: sprite-rotation-90
[274.483525] Subtest sprite-rotation-90: SUCCESS (10.177s)
[274.732542] [073/131] (758s left) kms_chamelium_color (ctm-limited-range)
[276.218942] Subtest ctm-limited-range: SKIP (0.000s)
[276.296455] [074/131] (757s left) kms_psr (psr2-cursor-mmap-cpu)
[277.782654] Subtest psr2-cursor-mmap-cpu: SKIP (0.000s)
[277.862604] [075/131] (755s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[277.908642] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[278.018550] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.106s)
[278.185717] [076/131] (755s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[280.755776] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[280.758017] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SKIP (0.000s)
[280.875547] [077/131] (752s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[282.378892] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[282.381168] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[282.570418] [078/131] (751s left) gem_partial_pwrite_pread (write-uncached)
[282.620562] Subtest write-uncached: SKIP (0.000s)
[282.731822] [079/131] (751s left) kms_async_flips (crc-atomic)
[284.216410] Starting subtest: crc-atomic
[284.474234] Starting dynamic subtest: pipe-A-HDMI-A-4
[286.919112] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.441s)
[287.096331] Starting dynamic subtest: pipe-B-HDMI-A-4
[289.251269] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (2.163s)
[289.404959] Starting dynamic subtest: pipe-C-HDMI-A-4
[291.573223] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (2.176s)
[291.752771] Starting dynamic subtest: pipe-D-HDMI-A-4
[293.921131] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.176s)
[293.922027] Subtest crc-atomic: SUCCESS (9.703s)
[294.248345] [080/131] (739s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[295.738538] Starting subtest: fbc-shrfb-scaledprimary
[299.349632] Subtest fbc-shrfb-scaledprimary: SUCCESS (3.611s)
[299.574559] [081/131] (734s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[301.058805] Starting subtest: cursor-vs-flip-legacy
[332.769874] Subtest cursor-vs-flip-legacy: SUCCESS (31.711s)
[332.970409] [082/131] (701s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[334.473539] Starting subtest: x-tiled-16bpp-rotate-180
[336.376243] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.898s)
[336.599271] [083/131] (697s left) gem_userptr_blits (sync-unmap-after-close)
[336.660847] Starting subtest: sync-unmap-after-close
[336.681439] Subtest sync-unmap-after-close: SUCCESS (0.021s)
[336.891713] [084/131] (697s left) kms_addfb_basic (bad-pitch-0)
[336.937980] Starting subtest: bad-pitch-0
[336.938892] Subtest bad-pitch-0: SUCCESS (0.000s)
[338.538010] [085/131] (695s left) gem_exec_schedule (preemptive-hang)
[338.741710] Starting subtest: preemptive-hang
[338.743897] Starting dynamic subtest: rcs0
[348.091556] Dynamic subtest rcs0: SUCCESS (9.354s)
[348.103529] Starting dynamic subtest: bcs0
[357.048244] Dynamic subtest bcs0: SUCCESS (8.956s)
[357.061529] Starting dynamic subtest: vcs0
[366.079424] Dynamic subtest vcs0: SUCCESS (9.029s)
[366.091498] Starting dynamic subtest: vcs1
[375.102123] Dynamic subtest vcs1: SUCCESS (9.021s)
[375.115756] Starting dynamic subtest: vecs0
[384.056386] Dynamic subtest vecs0: SUCCESS (8.953s)
[384.057225] Subtest preemptive-hang: SUCCESS (45.324s)
[384.364164] [086/131] (650s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[385.866461] Starting subtest: cursorB-vs-flipB-toggle
[385.870816] Subtest cursorB-vs-flipB-toggle: SKIP (0.002s)
[385.979410] [087/131] (648s left) gem_huc_copy (huc-copy)
[386.055964] Starting subtest: huc-copy
[386.062381] Subtest huc-copy: SUCCESS (0.006s)
[386.247041] [088/131] (648s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[387.735489] Starting subtest: fbc-rgb101010-draw-mmap-wc
[387.737387] Subtest fbc-rgb101010-draw-mmap-wc: SKIP (0.000s)
[387.924443] [089/131] (646s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[389.450444] Starting subtest: cursor-tearing-framebuffer-change
[389.453304] Starting dynamic subtest: pipe-A-HDMI-A-4
[389.961271] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.508s)
[389.975114] Starting dynamic subtest: pipe-D-HDMI-A-4
[390.303644] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.340s)
[390.304649] Subtest cursor-tearing-framebuffer-change: SUCCESS (0.853s)
[390.969998] [090/131] (643s left) kms_fence_pin_leak
[392.545426] [091/131] (642s left) kms_getfb (getfb-repeated-different-handles)
[394.029561] Starting subtest: getfb-repeated-different-handles
[394.030457] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[394.216859] [092/131] (640s left) kms_lease (atomic-implicit-crtc)
[395.703300] Starting subtest: atomic-implicit-crtc
[395.704351] Starting dynamic subtest: pipe-A-HDMI-A-4
[395.714559] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.002s)
[395.727171] Starting dynamic subtest: pipe-B-HDMI-A-4
[395.731817] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.008s)
[395.744041] Starting dynamic subtest: pipe-C-HDMI-A-4
[395.748785] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.008s)
[395.760522] Starting dynamic subtest: pipe-D-HDMI-A-4
[395.765387] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.008s)
[395.766508] Subtest atomic-implicit-crtc: SUCCESS (0.037s)
[395.915605] [093/131] (639s left) kms_dp_linktrain_fallback (dsc-fallback)
[397.400452] Starting subtest: dsc-fallback
[397.402959] Subtest dsc-fallback: SKIP (0.000s)
[397.526542] [094/131] (637s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[397.581184] Starting subtest: wait-all-for-submit-delayed-submit
[397.688980] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.105s)
[397.930931] [095/131] (637s left) kms_plane (pixel-format-yf-tiled-modifier)
[399.472811] Starting subtest: pixel-format-yf-tiled-modifier
[399.474629] Subtest pixel-format-yf-tiled-modifier: SKIP (0.000s)
[399.667672] [096/131] (635s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[401.158802] Starting subtest: 2x-plain-flip-ts-check-interruptible
[401.177210] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.018s)
[401.333142] [097/131] (634s left) gem_softpin (softpin)
[401.388526] Starting subtest: softpin
[433.781218] Subtest softpin: SUCCESS (32.388s)
[433.958402] [098/131] (601s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[434.009220] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[434.094255] [099/131] (601s left) kms_selftest (drm_format)
[434.144727] Starting subtest: drm_format
[434.217417] Starting dynamic subtest: drm_test_format_block_width_invalid
[434.280420] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.067s)
[434.307100] Starting dynamic subtest: drm_test_format_block_width_one_plane
[434.348918] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.064s)
[434.380120] Starting dynamic subtest: drm_test_format_block_width_two_plane
[434.417136] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.065s)
[434.448889] Starting dynamic subtest: drm_test_format_block_width_three_plane
[434.496851] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.074s)
[434.540402] Starting dynamic subtest: drm_test_format_block_width_tiled
[434.569840] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.067s)
[434.586909] Starting dynamic subtest: drm_test_format_block_height_invalid
[434.638880] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.065s)
[434.684401] Starting dynamic subtest: drm_test_format_block_height_one_plane
[434.713824] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.069s)
[434.729623] Starting dynamic subtest: drm_test_format_block_height_two_plane
[434.781945] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.065s)
[434.818996] Starting dynamic subtest: drm_test_format_block_height_three_plane
[434.855016] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.069s)
[434.886450] Starting dynamic subtest: drm_test_format_block_height_tiled
[434.927151] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.068s)
[434.966873] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[435.003053] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.072s)
[435.032220] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[435.075772] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.068s)
[435.110986] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[435.144191] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.065s)
[435.167517] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[435.220591] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.072s)
[435.264960] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[435.287870] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.061s)
[435.303765] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[435.361235] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.071s)
[435.408469] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[435.429350] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.064s)
[435.450883] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[435.497891] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.065s)
[435.499027] Subtest drm_format: SUCCESS (1.353s)
[435.723149] [100/131] (600s left) kms_big_fb (yf-tiled-addfb)
[437.227885] Starting subtest: yf-tiled-addfb
[437.230068] Subtest yf-tiled-addfb: SKIP (0.000s)
[437.412220] [101/131] (598s left) gem_eio (in-flight-immediate)
[437.603529] Starting subtest: in-flight-immediate
[441.915454] Subtest in-flight-immediate: SUCCESS (4.313s)
[443.473257] [102/131] (592s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[444.972102] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[444.974030] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[445.172852] [103/131] (590s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[446.660805] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[446.662384] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[446.857039] [104/131] (589s left) kms_psr (psr-sprite-plane-onoff)
[448.343742] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[448.429982] [105/131] (587s left) kms_chamelium_hpd (vga-hpd-fast)
[449.957222] Subtest vga-hpd-fast: SKIP (0.000s)
[450.071801] [106/131] (586s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[451.556552] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[451.557497] Starting dynamic subtest: pipe-A-HDMI-A-4
[451.566093] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.001s)
[451.578497] Starting dynamic subtest: pipe-B-HDMI-A-4
[451.587459] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.001s)
[451.599589] Starting dynamic subtest: pipe-C-HDMI-A-4
[451.608983] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.001s)
[451.621113] Starting dynamic subtest: pipe-D-HDMI-A-4
[451.632852] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.001s)
[451.634383] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.014s)
[451.802757] [107/131] (584s left) kms_big_fb (linear-32bpp-rotate-90)
[453.306283] Starting subtest: linear-32bpp-rotate-90
[453.405610] Subtest linear-32bpp-rotate-90: SKIP (0.097s)
[453.573043] [108/131] (583s left) perf (buffer-fill)
[453.700249] Starting subtest: buffer-fill
[453.701314] Starting dynamic subtest: 0-rcs0
[455.935366] Dynamic subtest 0-rcs0: SUCCESS (2.232s)
[455.936434] Subtest buffer-fill: SUCCESS (2.234s)
[456.019617] [109/131] (580s left) api_intel_bb (object-noreloc-keep-cache-simple)
[456.065446] Starting subtest: object-noreloc-keep-cache-simple
[456.086599] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.022s)
[456.262120] [110/131] (580s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[457.745538] Starting subtest: short-flip-before-cursor-atomic-transitions
[458.759188] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (1.014s)
[458.938686] [111/131] (577s left) kms_addfb_basic (invalid-get-prop)
[458.984768] Starting subtest: invalid-get-prop
[458.985807] Subtest invalid-get-prop: SUCCESS (0.000s)
[460.581792] [112/131] (576s left) i915_selftest (mock)
[461.539841] Starting subtest: mock
[461.540771] Starting dynamic subtest: sanitycheck
[462.296512] Dynamic subtest sanitycheck: SUCCESS (0.752s)
[462.332204] Starting dynamic subtest: shmem
[463.062539] Dynamic subtest shmem: SUCCESS (0.758s)
[463.097405] Starting dynamic subtest: fence
[471.001300] Dynamic subtest fence: SUCCESS (7.932s)
[471.013532] Starting dynamic subtest: scatterlist
[472.731579] Dynamic subtest scatterlist: SUCCESS (1.727s)
[472.740971] Starting dynamic subtest: syncmap
[475.408436] Dynamic subtest syncmap: SUCCESS (2.672s)
[475.417556] Starting dynamic subtest: uncore
[476.119915] Dynamic subtest uncore: SUCCESS (0.710s)
[476.156223] Starting dynamic subtest: ring
[476.872110] Dynamic subtest ring: SUCCESS (0.743s)
[476.910213] Starting dynamic subtest: engine
[477.630914] Dynamic subtest engine: SUCCESS (0.751s)
[477.666854] Starting dynamic subtest: timelines
[482.952655] Dynamic subtest timelines: SUCCESS (5.315s)
[482.962240] Starting dynamic subtest: requests
[486.561688] Dynamic subtest requests: SUCCESS (3.607s)
[486.571424] Starting dynamic subtest: objects
[487.416782] Dynamic subtest objects: SUCCESS (0.853s)
[487.426387] Starting dynamic subtest: phys
[488.283954] Dynamic subtest phys: SUCCESS (0.866s)
[488.293728] Starting dynamic subtest: dmabuf
[489.119690] Dynamic subtest dmabuf: SUCCESS (0.834s)
[489.129721] Starting dynamic subtest: vma
[499.479715] Dynamic subtest vma: SUCCESS (10.358s)
[499.490825] Starting dynamic subtest: evict
[501.456779] Dynamic subtest evict: SUCCESS (1.975s)
[501.466601] Starting dynamic subtest: gtt
[505.196719] Dynamic subtest gtt: SUCCESS (3.738s)
[505.206701] Starting dynamic subtest: hugepages
[506.264800] Dynamic subtest hugepages: SUCCESS (1.066s)
[506.274310] Starting dynamic subtest: memory_region
[510.348613] Dynamic subtest memory_region: SUCCESS (4.083s)
[510.349458] Subtest mock: SUCCESS (48.806s)
[510.397202] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[510.398604] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[510.400733] [113/131] (526s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[515.105655] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[515.107668] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[515.365979] [FACT kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[515.369312] [FACT kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)] new: kernel.kmod_is_loaded.i915: true
[515.376074] [114/131] (521s left) gem_mmap_gtt (flink-race)
[515.423671] Subtest flink-race: SKIP (0.000s)
[515.498418] [115/131] (521s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[516.986807] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[516.988356] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[517.153610] [116/131] (520s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[518.646923] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[518.648775] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[518.842433] [117/131] (518s left) perf_pmu (enable-race)
[518.897729] Starting subtest: enable-race
[518.898586] Starting dynamic subtest: rcs0
[531.652972] Dynamic subtest rcs0: SUCCESS (12.754s)
[531.665156] Starting dynamic subtest: bcs0
[544.403055] Dynamic subtest bcs0: SUCCESS (12.748s)
[544.414958] Starting dynamic subtest: vcs0
[557.154969] Dynamic subtest vcs0: SUCCESS (12.751s)
[557.167320] Starting dynamic subtest: vcs1
[569.906968] Dynamic subtest vcs1: SUCCESS (12.750s)
[569.919182] Starting dynamic subtest: vecs0
[582.659008] Dynamic subtest vecs0: SUCCESS (12.750s)
[582.659954] Subtest enable-race: SUCCESS (63.762s)
[582.799608] [118/131] (454s left) gem_readwrite (read-write)
[582.844421] Subtest read-write: SKIP (0.000s)
[582.931053] [119/131] (454s left) perf_pmu (all-busy-check-all)
[582.981233] Starting subtest: all-busy-check-all
[583.553746] Subtest all-busy-check-all: SUCCESS (0.573s)
[583.712935] [120/131] (453s left) kms_busy (extended-modeset-hang-oldfb)
[585.204626] Starting subtest: extended-modeset-hang-oldfb
[585.205554] Starting dynamic subtest: pipe-A
[593.117246] Dynamic subtest pipe-A: SUCCESS (7.911s)
[593.131774] Starting dynamic subtest: pipe-D
[600.991067] Dynamic subtest pipe-D: SUCCESS (7.869s)
[600.993332] Subtest extended-modeset-hang-oldfb: SUCCESS (15.789s)
[601.187776] [121/131] (436s left) gem_softpin (overlap)
[601.241490] Starting subtest: overlap
[604.984421] Subtest overlap: SUCCESS (3.740s)
[605.147983] [122/131] (432s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[606.632331] Starting subtest: basic-modeset-with-all-modifiers-formats
[606.837032] Starting dynamic subtest: pipe-A-HDMI-A-4-y-rc-ccs-XRGB8888
[607.147843] Dynamic subtest pipe-A-HDMI-A-4-y-rc-ccs-XRGB8888: SUCCESS (0.311s)
[607.160293] Starting dynamic subtest: pipe-A-HDMI-A-4-y-rc-ccs-XRGB2101010
[607.181171] Dynamic subtest pipe-A-HDMI-A-4-y-rc-ccs-XRGB2101010: SUCCESS (0.032s)
[607.193827] Starting dynamic subtest: pipe-A-HDMI-A-4-y-rc-ccs-XRGB16161616F
[607.214594] Dynamic subtest pipe-A-HDMI-A-4-y-rc-ccs-XRGB16161616F: SUCCESS (0.032s)
[607.230653] Starting dynamic subtest: pipe-A-HDMI-A-4-y-RGB565
[607.414524] Dynamic subtest pipe-A-HDMI-A-4-y-RGB565: SUCCESS (0.198s)
[607.427188] Starting dynamic subtest: pipe-A-HDMI-A-4-y-XRGB8888
[607.447913] Dynamic subtest pipe-A-HDMI-A-4-y-XRGB8888: SUCCESS (0.032s)
[607.466029] Starting dynamic subtest: pipe-A-HDMI-A-4-y-XRGB2101010
[607.481239] Dynamic subtest pipe-A-HDMI-A-4-y-XRGB2101010: SUCCESS (0.031s)
[607.499804] Starting dynamic subtest: pipe-A-HDMI-A-4-y-XRGB16161616F
[607.514590] Dynamic subtest pipe-A-HDMI-A-4-y-XRGB16161616F: SUCCESS (0.031s)
[607.533150] Starting dynamic subtest: pipe-A-HDMI-A-4-y-YUYV
[607.547938] Dynamic subtest pipe-A-HDMI-A-4-y-YUYV: SUCCESS (0.031s)
[607.566607] Starting dynamic subtest: pipe-A-HDMI-A-4-y-Y210
[607.581238] Dynamic subtest pipe-A-HDMI-A-4-y-Y210: SUCCESS (0.031s)
[607.599759] Starting dynamic subtest: pipe-A-HDMI-A-4-y-XYUV8888
[607.614613] Dynamic subtest pipe-A-HDMI-A-4-y-XYUV8888: SUCCESS (0.031s)
[607.633156] Starting dynamic subtest: pipe-A-HDMI-A-4-y-XV30
[607.647898] Dynamic subtest pipe-A-HDMI-A-4-y-XV30: SUCCESS (0.031s)
[607.664250] Starting dynamic subtest: pipe-A-HDMI-A-4-y-XV36
[607.681180] Dynamic subtest pipe-A-HDMI-A-4-y-XV36: SUCCESS (0.031s)
[607.695486] Starting dynamic subtest: pipe-A-HDMI-A-4-x-RGB565
[607.880615] Dynamic subtest pipe-A-HDMI-A-4-x-RGB565: SUCCESS (0.198s)
[607.893527] Starting dynamic subtest: pipe-A-HDMI-A-4-x-XRGB8888
[607.913999] Dynamic subtest pipe-A-HDMI-A-4-x-XRGB8888: SUCCESS (0.032s)
[607.930609] Starting dynamic subtest: pipe-A-HDMI-A-4-x-XRGB2101010
[607.947351] Dynamic subtest pipe-A-HDMI-A-4-x-XRGB2101010: SUCCESS (0.031s)
[607.966458] Starting dynamic subtest: pipe-A-HDMI-A-4-x-XRGB16161616F
[607.980700] Dynamic subtest pipe-A-HDMI-A-4-x-XRGB16161616F: SUCCESS (0.031s)
[607.999262] Starting dynamic subtest: pipe-A-HDMI-A-4-x-YUYV
[608.014057] Dynamic subtest pipe-A-HDMI-A-4-x-YUYV: SUCCESS (0.031s)
[608.032526] Starting dynamic subtest: pipe-A-HDMI-A-4-x-Y210
[608.047381] Dynamic subtest pipe-A-HDMI-A-4-x-Y210: SUCCESS (0.031s)
[608.066024] Starting dynamic subtest: pipe-A-HDMI-A-4-x-XYUV8888
[608.080733] Dynamic subtest pipe-A-HDMI-A-4-x-XYUV8888: SUCCESS (0.031s)
[608.099309] Starting dynamic subtest: pipe-A-HDMI-A-4-x-XV30
[608.114059] Dynamic subtest pipe-A-HDMI-A-4-x-XV30: SUCCESS (0.031s)
[608.132592] Starting dynamic subtest: pipe-A-HDMI-A-4-x-XV36
[608.147398] Dynamic subtest pipe-A-HDMI-A-4-x-XV36: SUCCESS (0.031s)
[608.162474] Starting dynamic subtest: pipe-A-HDMI-A-4-linear-RGB565
[608.331814] Dynamic subtest pipe-A-HDMI-A-4-linear-RGB565: SUCCESS (0.182s)
[608.344796] Starting dynamic subtest: pipe-A-HDMI-A-4-linear-XRGB8888
[608.365169] Dynamic subtest pipe-A-HDMI-A-4-linear-XRGB8888: SUCCESS (0.032s)
[608.382016] Starting dynamic subtest: pipe-A-HDMI-A-4-linear-XRGB2101010
[608.398595] Dynamic subtest pipe-A-HDMI-A-4-linear-XRGB2101010: SUCCESS (0.031s)
[608.417249] Starting dynamic subtest: pipe-A-HDMI-A-4-linear-XRGB16161616F
[608.432058] Dynamic subtest pipe-A-HDMI-A-4-linear-XRGB16161616F: SUCCESS (0.031s)
[608.451063] Starting dynamic subtest: pipe-A-HDMI-A-4-linear-YUYV
[608.465415] Dynamic subtest pipe-A-HDMI-A-4-linear-YUYV: SUCCESS (0.031s)
[608.486687] Starting dynamic subtest: pipe-A-HDMI-A-4-linear-Y210
[608.498586] Dynamic subtest pipe-A-HDMI-A-4-linear-Y210: SUCCESS (0.031s)
[608.517418] Starting dynamic subtest: pipe-A-HDMI-A-4-linear-XYUV8888
[608.531893] Dynamic subtest pipe-A-HDMI-A-4-linear-XYUV8888: SUCCESS (0.031s)
[608.550631] Starting dynamic subtest: pipe-A-HDMI-A-4-linear-XV30
[608.565231] Dynamic subtest pipe-A-HDMI-A-4-linear-XV30: SUCCESS (0.031s)
[608.583848] Starting dynamic subtest: pipe-A-HDMI-A-4-linear-XV36
[608.598568] Dynamic subtest pipe-A-HDMI-A-4-linear-XV36: SUCCESS (0.031s)
[608.851279] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.220s)
[609.071691] [123/131] (428s left) gem_exec_basic (basic)
[609.123918] Starting subtest: basic
[609.124826] Starting dynamic subtest: rcs0-smem
[609.127256] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[609.140225] Starting dynamic subtest: bcs0-smem
[609.141100] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[609.152418] Starting dynamic subtest: vcs0-smem
[609.153581] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[609.164590] Starting dynamic subtest: vcs1-smem
[609.165699] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[609.176423] Starting dynamic subtest: vecs0-smem
[609.177568] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[609.188102] Starting dynamic subtest: rcs0-lmem0
[609.189182] Dynamic subtest rcs0-lmem0: SUCCESS (0.001s)
[609.199856] Starting dynamic subtest: bcs0-lmem0
[609.200975] Dynamic subtest bcs0-lmem0: SUCCESS (0.000s)
[609.211668] Starting dynamic subtest: vcs0-lmem0
[609.212765] Dynamic subtest vcs0-lmem0: SUCCESS (0.000s)
[609.223479] Starting dynamic subtest: vcs1-lmem0
[609.224579] Dynamic subtest vcs1-lmem0: SUCCESS (0.000s)
[609.235236] Starting dynamic subtest: vecs0-lmem0
[609.236390] Dynamic subtest vecs0-lmem0: SUCCESS (0.000s)
[609.237521] Subtest basic: SUCCESS (0.022s)
[609.399278] [124/131] (428s left) api_intel_bb (blit-reloc-purge-cache)
[609.443827] Starting subtest: blit-reloc-purge-cache
[609.445514] Subtest blit-reloc-purge-cache: SKIP (0.001s)
[609.647255] [125/131] (428s left) kms_psr (pr-cursor-mmap-gtt)
[611.137972] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[611.215447] [126/131] (426s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[612.704837] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[612.706511] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[612.875580] [127/131] (425s left) i915_drm_fdinfo (memory-info-shared)
[612.927446] Starting subtest: memory-info-shared
[612.928508] Starting dynamic subtest: lmem0
[613.003826] Dynamic subtest lmem0: SUCCESS (0.075s)
[613.021936] Starting dynamic subtest: smem0
[613.062211] Dynamic subtest smem0: SUCCESS (0.056s)
[613.063286] Subtest memory-info-shared: SUCCESS (0.136s)
[613.175779] [128/131] (425s left) gem_ctx_isolation (dirty-create)
[613.232529] Starting subtest: dirty-create
[613.233530] Starting dynamic subtest: rcs0
[613.984292] Dynamic subtest rcs0: SUCCESS (0.751s)
[613.997834] Starting dynamic subtest: bcs0
[614.800463] Dynamic subtest bcs0: SUCCESS (0.815s)
[614.813449] Starting dynamic subtest: vcs0
[615.607330] Dynamic subtest vcs0: SUCCESS (0.805s)
[615.620515] Starting dynamic subtest: vcs1
[616.416619] Dynamic subtest vcs1: SUCCESS (0.808s)
[616.429638] Starting dynamic subtest: vecs0
[617.208103] Dynamic subtest vecs0: SUCCESS (0.790s)
[617.209127] Subtest dirty-create: SUCCESS (3.976s)
[617.505403] [129/131] (420s left) gem_watchdog (default-virtual)
[617.560506] Starting subtest: default-virtual
[622.869054] Subtest default-virtual: SUCCESS (5.305s)
[623.003403] [130/131] (415s left) kms_joiner (invalid-modeset-big-joiner)
[624.490865] Starting subtest: invalid-modeset-big-joiner
[624.492592] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[624.621405] [131/131] (413s left) syncobj_timeline (wait-for-submit-complex)
[624.680608] Starting subtest: wait-for-submit-complex
[624.743255] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[624.923530] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_ctx_bad_destroy
results: parsing output: 2/ for test: gem_exec_schedule
results: parsing output: 3/ for test: perf
results: parsing output: 4/ for test: kms_color
results: parsing output: 5/ for test: gem_exec_params
results: parsing output: 6/ for test: gem_ctx_persistence
results: parsing output: 7/ for test: kms_chamelium_edid
results: parsing output: 8/ for test: gem_render_copy
results: parsing output: 9/ for test: kms_cursor_crc
results: parsing output: 10/ for test: kms_vblank
results: parsing output: 11/ for test: kms_psr2_sf
results: parsing output: 12/ for test: kms_plane
results: parsing output: 13/ for test: gem_pread
results: parsing output: 14/ for test: gem_ctx_bad_destroy
results: parsing output: 15/ for test: kms_flip
results: parsing output: 16/ for test: kms_getfb
results: parsing output: 17/ for test: kms_plane
results: parsing output: 18/ for test: syncobj_timeline
results: parsing output: 19/ for test: kms_plane_scaling
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_cursor_legacy
results: parsing output: 22/ for test: gem_exec_balancer
results: parsing output: 23/ for test: kms_feature_discovery
results: parsing output: 24/ for test: kms_pm_backlight
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_psr
results: parsing output: 28/ for test: gem_mmap
results: parsing output: 29/ for test: perf_pmu
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: perf_pmu
results: parsing output: 32/ for test: kms_cursor_legacy
results: parsing output: 33/ for test: kms_flip_scaled_crc
results: parsing output: 34/ for test: gem_bad_reloc
results: parsing output: 35/ for test: gem_exec_reloc
results: parsing output: 36/ for test: syncobj_wait
results: parsing output: 37/ for test: kms_ccs
results: parsing output: 38/ for test: kms_flip_scaled_crc
results: parsing output: 39/ for test: perf
results: parsing output: 40/ for test: gem_exec_params
results: parsing output: 41/ for test: kms_multipipe_modeset
results: parsing output: 42/ for test: kms_cursor_legacy
results: parsing output: 43/ for test: gem_pxp
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: gem_ctx_engines
results: parsing output: 46/ for test: gen9_exec_parse
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: vgem_basic
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_psr2_sf
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: kms_content_protection
results: parsing output: 57/ for test: core_hotunplug
results: parsing output: 58/ for test: i915_pm_rpm
results: parsing output: 59/ for test: kms_cursor_crc
results: parsing output: 60/ for test: i915_hangman
results: parsing output: 61/ for test: gem_exec_whisper
results: parsing output: 62/ for test: syncobj_wait
results: parsing output: 63/ for test: kms_rotation_crc
results: parsing output: 64/ for test: syncobj_timeline
results: parsing output: 65/ for test: kms_ccs
results: parsing output: 66/ for test: syncobj_timeline
results: parsing output: 67/ for test: kms_flip_scaled_crc
results: parsing output: 68/ for test: kms_cursor_legacy
results: parsing output: 69/ for test: gem_spin_batch
results: parsing output: 70/ for test: gem_exec_fence
results: parsing output: 71/ for test: kms_rotation_crc
results: parsing output: 72/ for test: kms_chamelium_color
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: syncobj_timeline
results: parsing output: 75/ for test: gem_pxp
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: gem_partial_pwrite_pread
results: parsing output: 78/ for test: kms_async_flips
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_cursor_legacy
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: gem_userptr_blits
results: parsing output: 83/ for test: kms_addfb_basic
results: parsing output: 84/ for test: gem_exec_schedule
results: parsing output: 85/ for test: kms_cursor_legacy
results: parsing output: 86/ for test: gem_huc_copy
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_cursor_crc
results: parsing output: 89/ for test: kms_fence_pin_leak
results: parsing output: 90/ for test: kms_getfb
results: parsing output: 91/ for test: kms_lease
results: parsing output: 92/ for test: kms_dp_linktrain_fallback
results: parsing output: 93/ for test: syncobj_wait
results: parsing output: 94/ for test: kms_plane
results: parsing output: 95/ for test: kms_flip
results: parsing output: 96/ for test: gem_softpin
results: parsing output: 97/ for test: gem_fenced_exec_thrash
results: parsing output: 98/ for test: kms_selftest
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: gem_eio
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_psr
results: parsing output: 104/ for test: kms_chamelium_hpd
results: parsing output: 105/ for test: kms_ccs
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: perf
results: parsing output: 108/ for test: api_intel_bb
results: parsing output: 109/ for test: kms_cursor_legacy
results: parsing output: 110/ for test: kms_addfb_basic
results: parsing output: 111/ for test: i915_selftest
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_mmap_gtt
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: perf_pmu
results: parsing output: 117/ for test: gem_readwrite
results: parsing output: 118/ for test: perf_pmu
results: parsing output: 119/ for test: kms_busy
results: parsing output: 120/ for test: gem_softpin
results: parsing output: 121/ for test: kms_async_flips
results: parsing output: 122/ for test: gem_exec_basic
results: parsing output: 123/ for test: api_intel_bb
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: i915_drm_fdinfo
results: parsing output: 127/ for test: gem_ctx_isolation
results: parsing output: 128/ for test: gem_watchdog
results: parsing output: 129/ for test: kms_joiner
results: parsing output: 130/ for test: syncobj_timeline
Done.