[69.811538] Initializing watchdogs
[69.811619]   /dev/watchdog0
[69.842968] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[69.857920] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[69.862885] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[69.865962] [001/154] (960s left) kms_pm_dc (dc5-dpms-negative)
[72.368227] Starting subtest: dc5-dpms-negative
[76.597950] Subtest dc5-dpms-negative: SUCCESS (4.230s)
[76.712867] [002/154] (953s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-move)
[78.207835] Starting subtest: fbchdr-2p-primscrn-spr-indfb-move
[78.209634] Subtest fbchdr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[78.389529] [003/154] (952s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[79.935279] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[80.066516] [004/154] (950s left) gem_close_race (basic-process)
[80.148643] Starting subtest: basic-process
[80.195509] Subtest basic-process: SUCCESS (0.047s)
[80.506026] [005/154] (950s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[81.991236] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[81.992217] Starting dynamic subtest: pipe-A-HDMI-A-4
[82.002520] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[82.011125] Starting dynamic subtest: pipe-B-HDMI-A-4
[82.023613] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[82.032185] Starting dynamic subtest: pipe-C-HDMI-A-4
[82.040832] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[82.048927] Starting dynamic subtest: pipe-D-HDMI-A-4
[82.057815] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[82.059400] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[82.294225] [006/154] (948s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[83.788862] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[83.790930] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[83.979374] [007/154] (946s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-mmap-cpu)
[85.475361] Starting subtest: fbcpsrhdr-rgb101010-draw-mmap-cpu
[85.477123] Subtest fbcpsrhdr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[85.632872] [008/154] (945s left) gem_pipe_control_store_loop (fresh-buffer)
[85.691921] Starting subtest: fresh-buffer
[87.860913] Subtest fresh-buffer: SUCCESS (2.166s)
[88.002614] [009/154] (943s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-mmap-wc)
[89.497164] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-mmap-wc
[89.499127] Subtest hdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[89.630460] [010/154] (941s left) kms_color_pipeline (plane-lut1d)
[91.137367] Starting subtest: plane-lut1d
[91.337605] Starting dynamic subtest: pipe-A-plane-0
[91.587371] Dynamic subtest pipe-A-plane-0: SUCCESS (0.250s)
[91.620658] Starting dynamic subtest: pipe-A-plane-1
[91.787397] Dynamic subtest pipe-A-plane-1: SUCCESS (0.199s)
[91.817574] Starting dynamic subtest: pipe-A-plane-2
[92.004095] Dynamic subtest pipe-A-plane-2: SUCCESS (0.215s)
[92.298033] Starting dynamic subtest: pipe-B-plane-0
[92.452635] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[92.483124] Starting dynamic subtest: pipe-B-plane-1
[92.654117] Dynamic subtest pipe-B-plane-1: SUCCESS (0.200s)
[92.663395] Starting dynamic subtest: pipe-B-plane-2
[92.817216] Dynamic subtest pipe-B-plane-2: SUCCESS (0.163s)
[93.121952] Starting dynamic subtest: pipe-C-plane-0
[93.302248] Dynamic subtest pipe-C-plane-0: SUCCESS (0.200s)
[93.335775] Starting dynamic subtest: pipe-C-plane-1
[93.518980] Dynamic subtest pipe-C-plane-1: SUCCESS (0.215s)
[93.551638] Starting dynamic subtest: pipe-C-plane-2
[93.734409] Dynamic subtest pipe-C-plane-2: SUCCESS (0.215s)
[94.022804] Starting dynamic subtest: pipe-D-plane-0
[94.194923] Dynamic subtest pipe-D-plane-0: SUCCESS (0.183s)
[94.226713] Starting dynamic subtest: pipe-D-plane-1
[94.411487] Dynamic subtest pipe-D-plane-1: SUCCESS (0.215s)
[94.438851] Starting dynamic subtest: pipe-D-plane-2
[94.628248] Dynamic subtest pipe-D-plane-2: SUCCESS (0.215s)
[94.682132] Subtest plane-lut1d: SUCCESS (3.546s)
[94.908406] [011/154] (936s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[96.406941] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[96.408579] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[96.558080] [012/154] (934s left) gem_mmap_wc (copy)
[96.617411] Subtest copy: SKIP (0.000s)
[96.687863] [013/154] (934s left) prime_vgem (basic-fence-blt)
[96.839823] Starting subtest: basic-fence-blt
[96.956286] Subtest basic-fence-blt: SUCCESS (0.116s)
[97.144662] [FACT prime_vgem (basic-fence-blt)] new: kernel.kmod_is_loaded.vgem: true
[97.146854] [014/154] (934s left) gem_exec_flush (basic-batch-kernel-default-wb)
[97.198803] Subtest basic-batch-kernel-default-wb: SKIP (0.000s)
[97.298273] [015/154] (934s left) gem_exec_balancer (full-late-pulse)
[97.354751] Starting subtest: full-late-pulse
[99.806331] Subtest full-late-pulse: SUCCESS (2.452s)
[100.269946] [016/154] (931s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[101.764725] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[101.767038] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[101.945114] [017/154] (929s left) gem_workarounds (reset-fd)
[102.025036] Starting subtest: reset-fd
[102.193312] Subtest reset-fd: SUCCESS (0.170s)
[102.335231] [018/154] (929s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[102.847357] Starting subtest: syncobj-stationary-timeline-chain-engines
[102.984471] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.137s)
[103.255214] [019/154] (928s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[104.749974] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[107.216752] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (2.467s)
[107.538094] [020/154] (924s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[109.033301] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[109.034947] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[109.211303] [021/154] (922s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[110.723410] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[110.793382] [022/154] (921s left) fbdev (unaligned-read)
[110.849404] Starting subtest: unaligned-read
[110.864967] Subtest unaligned-read: SUCCESS (0.016s)
[111.009861] [023/154] (921s left) kms_cursor_legacy (torture-bo)
[112.498404] Starting subtest: torture-bo
[112.499350] Starting dynamic subtest: pipe-A
[118.050279] Dynamic subtest pipe-A: SUCCESS (5.549s)
[118.062040] Starting dynamic subtest: pipe-B
[123.713450] Dynamic subtest pipe-B: SUCCESS (5.663s)
[123.724528] Starting dynamic subtest: pipe-C
[129.232147] Dynamic subtest pipe-C: SUCCESS (5.519s)
[129.244877] Starting dynamic subtest: pipe-D
[134.728563] Dynamic subtest pipe-D: SUCCESS (5.496s)
[134.740123] Starting dynamic subtest: all-pipes
[140.186546] Dynamic subtest all-pipes: SUCCESS (5.458s)
[140.188581] Subtest torture-bo: SUCCESS (27.687s)
[140.314835] [024/154] (892s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[140.396256] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[140.491306] [025/154] (891s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[140.543372] Starting subtest: y-tiled-ccs-to-yf-tiled
[140.544279] Starting dynamic subtest: smem
[140.637316] Dynamic subtest smem: SUCCESS (0.094s)
[140.648489] Starting dynamic subtest: lmem0
[141.570048] Dynamic subtest lmem0: SUCCESS (0.929s)
[141.571118] Subtest y-tiled-ccs-to-yf-tiled: SUCCESS (1.024s)
[141.815578] [026/154] (890s left) kms_pipe_crc_basic (read-crc)
[143.303329] Starting subtest: read-crc
[143.304364] Starting dynamic subtest: pipe-A-HDMI-A-4
[144.002030] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.697s)
[144.013300] Starting dynamic subtest: pipe-B-HDMI-A-4
[144.546509] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.542s)
[144.557827] Starting dynamic subtest: pipe-C-HDMI-A-4
[145.059919] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.512s)
[145.071252] Starting dynamic subtest: pipe-D-HDMI-A-4
[145.579399] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.519s)
[145.580278] Subtest read-crc: SUCCESS (2.276s)
[145.782680] [027/154] (886s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[147.292608] Starting subtest: y-tiled-16bpp-rotate-90
[149.108460] Subtest y-tiled-16bpp-rotate-90: SUCCESS (1.812s)
[149.286026] [028/154] (883s left) kms_atomic (atomic-invalid-params)
[150.776295] Starting subtest: atomic-invalid-params
[150.777268] Starting dynamic subtest: pipe-A-HDMI-A-4
[151.177336] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.400s)
[151.178374] Subtest atomic-invalid-params: SUCCESS (0.401s)
[151.373810] [029/154] (881s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[152.863424] Starting subtest: cursorB-vs-flipA-varying-size
[152.865451] Subtest cursorB-vs-flipA-varying-size: SKIP (0.002s)
[153.009607] [030/154] (879s left) kms_atomic_interruptible (atomic-setmode)
[154.507640] Starting subtest: atomic-setmode
[154.509530] Starting dynamic subtest: pipe-A-HDMI-A-4
[160.742164] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (6.232s)
[160.743044] Subtest atomic-setmode: SUCCESS (6.234s)
[160.945047] [031/154] (871s left) i915_hangman (gt-error-state-capture)
[161.006066] Starting subtest: gt-error-state-capture
[161.007031] Starting dynamic subtest: rcs0
[171.030496] Dynamic subtest rcs0: SUCCESS (10.024s)
[171.043201] Starting dynamic subtest: bcs0
[181.052320] Dynamic subtest bcs0: SUCCESS (10.019s)
[181.097031] Starting dynamic subtest: vcs0
[191.035272] Dynamic subtest vcs0: SUCCESS (9.982s)
[191.046477] Starting dynamic subtest: vcs1
[201.015347] Dynamic subtest vcs1: SUCCESS (9.979s)
[201.031064] Starting dynamic subtest: vecs0
[210.991214] Dynamic subtest vecs0: SUCCESS (9.975s)
[210.992104] Subtest gt-error-state-capture: SUCCESS (49.983s)
[211.145502] [032/154] (821s left) kms_flip (busy-flip)
[212.634167] Starting subtest: busy-flip
[212.641530] Starting dynamic subtest: A-HDMI-A4
[213.422223] Dynamic subtest A-HDMI-A4: SUCCESS (0.780s)
[213.455039] Starting dynamic subtest: B-HDMI-A4
[214.157313] Dynamic subtest B-HDMI-A4: SUCCESS (0.732s)
[214.169605] Starting dynamic subtest: C-HDMI-A4
[214.858494] Dynamic subtest C-HDMI-A4: SUCCESS (0.700s)
[214.870442] Starting dynamic subtest: D-HDMI-A4
[215.577764] Dynamic subtest D-HDMI-A4: SUCCESS (0.718s)
[215.578677] Subtest busy-flip: SUCCESS (2.944s)
[215.843139] [033/154] (817s left) i915_drm_fdinfo (virtual-busy-hang-all)
[215.893105] Starting subtest: virtual-busy-hang-all
[215.894840] Subtest virtual-busy-hang-all: SKIP (0.000s)
[216.008605] [034/154] (817s left) syncobj_timeline (wait-delayed-signal)
[216.053703] Starting subtest: wait-delayed-signal
[216.158627] Subtest wait-delayed-signal: SUCCESS (0.103s)
[216.296214] [035/154] (816s left) drm_read (invalid-buffer)
[217.851813] Starting subtest: invalid-buffer
[217.852782] Subtest invalid-buffer: SUCCESS (0.000s)
[218.103328] [036/154] (815s left) gem_exec_fence (basic-await)
[218.278305] Starting subtest: basic-await
[218.279250] Starting dynamic subtest: rcs0
[218.383865] Dynamic subtest rcs0: SUCCESS (0.105s)
[218.396664] Starting dynamic subtest: bcs0
[218.470051] Dynamic subtest bcs0: SUCCESS (0.086s)
[218.482802] Starting dynamic subtest: vcs0
[218.557135] Dynamic subtest vcs0: SUCCESS (0.085s)
[218.593698] Starting dynamic subtest: vcs1
[218.670792] Dynamic subtest vcs1: SUCCESS (0.112s)
[218.687028] Starting dynamic subtest: vecs0
[218.764167] Dynamic subtest vecs0: SUCCESS (0.093s)
[218.765195] Subtest basic-await: SUCCESS (0.486s)
[219.490407] [037/154] (813s left) kms_cursor_edge_walk (64x64-top-bottom)
[220.978291] Starting subtest: 64x64-top-bottom
[220.979194] Starting dynamic subtest: pipe-A-HDMI-A-4
[224.316149] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (3.337s)
[224.329281] Starting dynamic subtest: pipe-D-HDMI-A-4
[227.565235] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (3.247s)
[227.566140] Subtest 64x64-top-bottom: SUCCESS (6.588s)
[227.771108] [038/154] (805s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[229.303138] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[229.432351] [039/154] (804s left) gem_exec_schedule (preempt-user)
[229.494885] Starting subtest: preempt-user
[229.495923] Starting dynamic subtest: rcs0
[229.559184] Dynamic subtest rcs0: SUCCESS (0.064s)
[229.570907] Starting dynamic subtest: bcs0
[229.604535] Dynamic subtest bcs0: SUCCESS (0.045s)
[229.616209] Starting dynamic subtest: vcs0
[229.649716] Dynamic subtest vcs0: SUCCESS (0.044s)
[229.661119] Starting dynamic subtest: vcs1
[229.696287] Dynamic subtest vcs1: SUCCESS (0.046s)
[229.708335] Starting dynamic subtest: vecs0
[229.741566] Dynamic subtest vecs0: SUCCESS (0.045s)
[229.742447] Subtest preempt-user: SUCCESS (0.247s)
[230.207404] [040/154] (803s left) gem_exec_whisper (basic-forked)
[230.265343] Starting subtest: basic-forked
[232.963205] Subtest basic-forked: SUCCESS (2.697s)
[233.261110] [041/154] (800s left) gem_exec_schedule (manyslice)
[233.318684] Starting subtest: manyslice
[233.319536] Starting dynamic subtest: rcs0
[238.858959] Dynamic subtest rcs0: SUCCESS (5.537s)
[238.870921] Starting dynamic subtest: bcs0
[244.250839] Dynamic subtest bcs0: SUCCESS (5.391s)
[244.262458] Starting dynamic subtest: vcs0
[249.757098] Dynamic subtest vcs0: SUCCESS (5.505s)
[249.769038] Starting dynamic subtest: vcs1
[254.762180] Dynamic subtest vcs1: SUCCESS (5.004s)
[254.773890] Starting dynamic subtest: vecs0
[260.257679] Dynamic subtest vecs0: SUCCESS (5.494s)
[260.258929] Subtest manyslice: SUCCESS (26.935s)
[260.727770] [042/154] (773s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[262.222877] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[262.224783] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[262.399996] [043/154] (771s left) kms_frontbuffer_tracking (hdr-2p-primscrn-shrfb-plflip-blt)
[263.895381] Starting subtest: hdr-2p-primscrn-shrfb-plflip-blt
[263.896982] Subtest hdr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[264.047586] [044/154] (769s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[265.564247] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[265.566060] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[265.759559] [045/154] (768s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[265.813176] Subtest tiled-to-tiled: SKIP (0.000s)
[265.897361] [046/154] (768s left) perf (missing-sample-flags)
[266.022777] Starting subtest: missing-sample-flags
[266.023746] Subtest missing-sample-flags: SUCCESS (0.000s)
[266.100960] [047/154] (768s left) gem_userptr_blits (vma-merge)
[266.170809] Starting subtest: vma-merge
[266.268862] Subtest vma-merge: SUCCESS (0.098s)
[266.431566] [048/154] (767s left) kms_psr (psr-cursor-render)
[267.921309] Subtest psr-cursor-render: SKIP (0.000s)
[267.996764] [049/154] (766s left) kms_addfb_basic (clobberred-modifier)
[268.042946] Starting subtest: clobberred-modifier
[268.044704] Subtest clobberred-modifier: SKIP (0.000s)
[269.656603] [050/154] (764s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[271.153775] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[271.172031] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.017s)
[271.296650] [051/154] (763s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[272.801511] Starting subtest: psr-rgb101010-draw-render
[272.803637] Subtest psr-rgb101010-draw-render: SKIP (0.000s)
[272.973978] [052/154] (761s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping)
[274.465522] Starting subtest: pixel-format-x-tiled-modifier-source-clamping
[274.502404] Starting dynamic subtest: pipe-A-plane-0
[275.236483] Dynamic subtest pipe-A-plane-0: SUCCESS (0.733s)
[275.271201] Starting dynamic subtest: pipe-A-plane-3
[275.736056] Dynamic subtest pipe-A-plane-3: SUCCESS (0.498s)
[275.775161] Starting dynamic subtest: pipe-A-plane-5
[276.236158] Dynamic subtest pipe-A-plane-5: SUCCESS (0.498s)
[276.432513] Starting dynamic subtest: pipe-B-plane-0
[276.972126] Dynamic subtest pipe-B-plane-0: SUCCESS (0.550s)
[276.999140] Starting dynamic subtest: pipe-B-plane-3
[277.488739] Dynamic subtest pipe-B-plane-3: SUCCESS (0.515s)
[277.523679] Starting dynamic subtest: pipe-B-plane-5
[278.021890] Dynamic subtest pipe-B-plane-5: SUCCESS (0.532s)
[278.128224] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (3.661s)
[278.341700] [053/154] (756s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-shrfb-msflip-blt)
[279.838302] Starting subtest: fbcpsrhdr-2p-primscrn-shrfb-msflip-blt
[279.840116] Subtest fbcpsrhdr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[279.994588] [054/154] (754s left) gem_softpin (evict-prime)
[280.053666] Starting subtest: evict-prime
[280.054659] Starting dynamic subtest: rcs0
[281.268286] Dynamic subtest rcs0: SUCCESS (1.214s)
[281.280113] Starting dynamic subtest: bcs0
[282.442203] Dynamic subtest bcs0: SUCCESS (1.173s)
[282.454297] Starting dynamic subtest: vcs0
[283.638249] Dynamic subtest vcs0: SUCCESS (1.195s)
[283.650920] Starting dynamic subtest: vcs1
[284.819289] Dynamic subtest vcs1: SUCCESS (1.180s)
[284.832192] Starting dynamic subtest: vecs0
[286.017451] Dynamic subtest vecs0: SUCCESS (1.198s)
[286.029544] Starting dynamic subtest: all
[287.248438] Dynamic subtest all: SUCCESS (1.227s)
[287.249320] Subtest evict-prime: SUCCESS (7.192s)
[287.389587] [055/154] (747s left) gem_exec_params (no-blt)
[287.440573] Starting subtest: no-blt
[287.442756] Subtest no-blt: SUCCESS (0.002s)
[287.651666] [056/154] (747s left) perf_pmu (busy-no-semaphores)
[287.704135] Starting subtest: busy-no-semaphores
[287.705051] Starting dynamic subtest: rcs0
[288.251865] Dynamic subtest rcs0: SUCCESS (0.544s)
[288.264613] Starting dynamic subtest: bcs0
[288.808817] Dynamic subtest bcs0: SUCCESS (0.554s)
[288.820705] Starting dynamic subtest: vcs0
[289.364061] Dynamic subtest vcs0: SUCCESS (0.551s)
[289.380216] Starting dynamic subtest: vcs1
[289.917517] Dynamic subtest vcs1: SUCCESS (0.550s)
[289.933964] Starting dynamic subtest: vecs0
[290.470434] Dynamic subtest vecs0: SUCCESS (0.549s)
[290.471331] Subtest busy-no-semaphores: SUCCESS (2.766s)
[290.635741] [057/154] (744s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[292.133969] Starting subtest: fbc-rgb101010-draw-pwrite
[293.046180] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (0.914s)
[293.248768] [058/154] (741s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[294.743993] Starting subtest: psr-rgb565-draw-render
[294.745964] Subtest psr-rgb565-draw-render: SKIP (0.000s)
[294.931909] [059/154] (740s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[296.427244] Starting subtest: fbc-indfb-scaledprimary
[297.846306] Subtest fbc-indfb-scaledprimary: SUCCESS (1.419s)
[298.054484] [060/154] (737s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-blt)
[299.549431] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-blt
[299.551584] Subtest hdr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[299.724973] [061/154] (735s left) kms_prop_blob (blob-prop-core)
[299.772275] Starting subtest: blob-prop-core
[299.773178] Subtest blob-prop-core: SUCCESS (0.000s)
[299.891669] [062/154] (735s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-indfb-plflip-blt)
[301.387032] Starting subtest: psrhdr-2p-scndscrn-indfb-plflip-blt
[301.389154] Subtest psrhdr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[301.592229] [063/154] (734s left) kms_flip (plain-flip-interruptible)
[303.095580] Starting subtest: plain-flip-interruptible
[303.103741] Starting dynamic subtest: A-HDMI-A4
[303.846438] Dynamic subtest A-HDMI-A4: SUCCESS (0.743s)
[303.861745] Starting dynamic subtest: B-HDMI-A4
[304.527763] Dynamic subtest B-HDMI-A4: SUCCESS (0.680s)
[304.541902] Starting dynamic subtest: C-HDMI-A4
[305.212544] Dynamic subtest C-HDMI-A4: SUCCESS (0.683s)
[305.226679] Starting dynamic subtest: D-HDMI-A4
[305.900348] Dynamic subtest D-HDMI-A4: SUCCESS (0.685s)
[305.902874] Subtest plain-flip-interruptible: SUCCESS (2.806s)
[306.179399] [064/154] (729s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[307.667286] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[307.668166] Starting dynamic subtest: pipe-A
[307.771113] Dynamic subtest pipe-A: SUCCESS (0.103s)
[307.783613] Starting dynamic subtest: pipe-B
[307.929497] Dynamic subtest pipe-B: SUCCESS (0.157s)
[307.941307] Starting dynamic subtest: pipe-C
[308.086511] Dynamic subtest pipe-C: SUCCESS (0.156s)
[308.098262] Starting dynamic subtest: pipe-D
[308.244236] Dynamic subtest pipe-D: SUCCESS (0.157s)
[308.245163] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (0.577s)
[308.451053] [065/154] (727s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[309.946872] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[309.948633] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[310.142904] [066/154] (725s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[311.655170] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[311.657169] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[311.832173] [067/154] (724s left) gem_exec_whisper (basic-queues-priority-all)
[311.891438] Starting subtest: basic-queues-priority-all
[326.232707] Subtest basic-queues-priority-all: SUCCESS (14.336s)
[326.562371] [068/154] (709s left) kms_psr (pr-cursor-blt)
[328.052351] Subtest pr-cursor-blt: SKIP (0.000s)
[328.136630] [069/154] (708s left) kms_plane_lowres (tiling-y)
[329.681159] Starting subtest: tiling-y
[329.682094] Starting dynamic subtest: pipe-A-HDMI-A-4
[339.562642] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (9.881s)
[339.646698] Starting dynamic subtest: pipe-B-HDMI-A-4
[349.289893] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (9.654s)
[349.390822] Starting dynamic subtest: pipe-C-HDMI-A-4
[358.991745] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (9.612s)
[359.061278] Starting dynamic subtest: pipe-D-HDMI-A-4
[368.832142] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (9.781s)
[368.889189] Subtest tiling-y: SUCCESS (39.208s)
[369.076487] [070/154] (667s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[369.125503] Starting subtest: etime-multi-wait-all-submitted-signaled
[369.234587] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.105s)
[369.444831] [071/154] (667s left) kms_content_protection (atomic-dpms)
[370.993155] Starting subtest: atomic-dpms
[370.997586] Subtest atomic-dpms: SKIP (0.002s)
[371.187741] [072/154] (665s left) sw_sync (sync_merge_invalid)
[371.234157] Starting subtest: sync_merge_invalid
[371.236133] Subtest sync_merge_invalid: SUCCESS (0.004s)
[371.318856] [073/154] (665s left) gem_ctx_param (set-priority-invalid-size)
[371.364936] Starting subtest: set-priority-invalid-size
[371.365870] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[371.475092] [074/154] (665s left) gem_userptr_blits (unsync-unmap-cycles)
[371.530104] Subtest unsync-unmap-cycles: SKIP (0.000s)
[371.742764] [075/154] (665s left) kms_draw_crc (draw-method-mmap-gtt)
[373.233415] Starting subtest: draw-method-mmap-gtt
[373.234998] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[373.384386] [076/154] (663s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[374.881847] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[374.883523] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[375.041018] [077/154] (662s left) gen9_exec_parse (batch-invalid-length)
[375.097327] Subtest batch-invalid-length: SKIP (0.000s)
[375.185953] [078/154] (661s left) kms_scaling_modes (scaling-mode-full-aspect)
[376.674690] Starting subtest: scaling-mode-full-aspect
[376.680253] Subtest scaling-mode-full-aspect: SKIP (0.001s)
[376.802685] [079/154] (660s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[378.302148] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[378.303195] Starting dynamic subtest: pipe-A-HDMI-A-4
[399.565920] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (10.438s)
[399.581860] Starting dynamic subtest: pipe-B-HDMI-A-4
[421.506881] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (10.100s)
[421.522879] Starting dynamic subtest: pipe-C-HDMI-A-4
[443.491926] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (10.124s)
[443.508013] Starting dynamic subtest: pipe-D-HDMI-A-4
[465.453071] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (9.999s)
[465.453976] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SUCCESS (40.670s)
[471.693221] [080/154] (571s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[473.193111] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[473.194529] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[473.329650] [081/154] (570s left) kms_lease (lease-invalid-connector)
[475.261251] Starting subtest: lease-invalid-connector
[475.262346] Starting dynamic subtest: pipe-A-HDMI-A-4
[475.263390] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.000s)
[475.279156] Starting dynamic subtest: pipe-B-HDMI-A-4
[475.280141] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.000s)
[475.295244] Starting dynamic subtest: pipe-C-HDMI-A-4
[475.296553] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.000s)
[475.312866] Starting dynamic subtest: pipe-D-HDMI-A-4
[475.313948] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.000s)
[475.315140] Subtest lease-invalid-connector: SUCCESS (0.010s)
[475.382919] [082/154] (568s left) perf (mi-rpc)
[475.503713] Starting subtest: mi-rpc
[475.505426] Subtest mi-rpc: SKIP (0.000s)
[475.578270] [083/154] (567s left) kms_selftest (drm_plane_helper)
[475.627823] Starting subtest: drm_plane_helper
[475.700916] Starting dynamic subtest: drm_test_check_plane_state
[475.740650] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.075s)
[475.779238] Starting dynamic subtest: drm_test_check_invalid_plane_state
[475.817426] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.073s)
[475.818529] Subtest drm_plane_helper: SUCCESS (0.190s)
[476.052929] [084/154] (567s left) kms_vblank (wait-forked-busy-hang)
[477.544627] Starting subtest: wait-forked-busy-hang
[477.545609] Starting dynamic subtest: pipe-A-HDMI-A-4
[503.931023] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (26.385s)
[503.949299] Starting dynamic subtest: pipe-D-HDMI-A-4
[528.938261] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (25.004s)
[528.940668] Subtest wait-forked-busy-hang: SUCCESS (51.398s)
[529.143494] [085/154] (514s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[530.640349] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[530.642164] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[530.865527] [086/154] (512s left) prime_mmap_coherency (read)
[530.964301] Starting subtest: read
[536.356888] Subtest read: SUCCESS (5.390s)
[536.538781] [087/154] (507s left) gem_lmem_swapping (verify-random-ccs)
[541.053412] Starting subtest: verify-random-ccs
[541.054984] Starting dynamic subtest: lmem0
[541.058202] Dynamic subtest lmem0: SKIP (0.000s)
[541.061048] Subtest verify-random-ccs: SKIP (0.008s)
[545.005571] [FACT gem_lmem_swapping (verify-random-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[545.006707] [FACT gem_lmem_swapping (verify-random-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[545.009136] [088/154] (498s left) gem_ctx_persistence (heartbeat-close)
[548.416645] Starting subtest: heartbeat-close
[548.418673] Subtest heartbeat-close: SKIP (0.001s)
[548.504003] [FACT gem_ctx_persistence (heartbeat-close)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[548.507293] [FACT gem_ctx_persistence (heartbeat-close)] new: kernel.kmod_is_loaded.i915: true
[548.511072] [089/154] (495s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[550.010688] Starting subtest: 2x-plain-flip-ts-check-interruptible
[550.027577] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.017s)
[550.154978] [090/154] (493s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[551.654687] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[551.738767] [091/154] (492s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[554.540269] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[555.157857] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.619s)
[555.418836] [092/154] (488s left) gem_exec_reloc (basic-write-cpu)
[555.472916] Subtest basic-write-cpu: SKIP (0.000s)
[555.573206] [093/154] (488s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-indfb-fliptrack-mmap-gtt)
[557.068192] Starting subtest: fbcpsrhdr-2p-indfb-fliptrack-mmap-gtt
[557.069901] Subtest fbcpsrhdr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[557.219485] [094/154] (487s left) syncobj_timeline (multi-wait-signaled)
[557.271804] Starting subtest: multi-wait-signaled
[557.272649] Subtest multi-wait-signaled: SUCCESS (0.001s)
[557.422137] [095/154] (487s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[557.476638] Starting subtest: mixed-tiled-to-y-tiled-ccs
[557.477551] Starting dynamic subtest: smem
[557.589772] Dynamic subtest smem: SUCCESS (0.109s)
[557.603172] Starting dynamic subtest: lmem0
[558.538912] Dynamic subtest lmem0: SUCCESS (0.947s)
[558.540093] Subtest mixed-tiled-to-y-tiled-ccs: SUCCESS (1.060s)
[558.797347] [096/154] (485s left) kms_cursor_crc (cursor-offscreen-32x32)
[560.379912] Starting subtest: cursor-offscreen-32x32
[560.431910] Subtest cursor-offscreen-32x32: SKIP (0.052s)
[560.880885] [097/154] (483s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[562.388764] Starting subtest: yf-tiled-addfb-size-offset-overflow
[562.390618] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[562.567233] [098/154] (482s left) api_intel_bb (object-reloc-keep-cache)
[562.615739] Starting subtest: object-reloc-keep-cache
[562.619675] Subtest object-reloc-keep-cache: SKIP (0.003s)
[562.858199] [099/154] (482s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[564.368223] Starting subtest: x-tiled-64bpp-rotate-270
[564.450945] Subtest x-tiled-64bpp-rotate-270: SKIP (0.080s)
[564.626016] [100/154] (480s left) gem_mmap (pf-nonblock)
[564.671732] Subtest pf-nonblock: SKIP (0.000s)
[564.756004] [101/154] (480s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-mmap-wc)
[566.251488] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-mmap-wc
[566.253412] Subtest psrhdr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[566.412884] [102/154] (478s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-y)
[567.911225] Starting subtest: fbcpsrhdr-tiling-y
[567.913141] Subtest fbcpsrhdr-tiling-y: SKIP (0.000s)
[568.131325] [103/154] (477s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-blt)
[569.642534] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-blt
[569.644502] Subtest fbchdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[569.825463] [104/154] (475s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[571.322831] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[574.576562] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (3.254s)
[574.783854] [105/154] (470s left) kms_frontbuffer_tracking (hdr-1p-rte)
[576.280605] Starting subtest: hdr-1p-rte
[576.282242] Subtest hdr-1p-rte: SKIP (0.000s)
[576.439838] [106/154] (469s left) perf_pmu (busy-double-start)
[576.496875] Starting subtest: busy-double-start
[576.497767] Starting dynamic subtest: rcs0
[580.112562] Dynamic subtest rcs0: SUCCESS (3.615s)
[580.131237] Starting dynamic subtest: bcs0
[583.700499] Dynamic subtest bcs0: SUCCESS (3.585s)
[583.717730] Starting dynamic subtest: vcs0
[587.267593] Dynamic subtest vcs0: SUCCESS (3.565s)
[587.282863] Starting dynamic subtest: vcs1
[590.864788] Dynamic subtest vcs1: SUCCESS (3.594s)
[590.882989] Starting dynamic subtest: vecs0
[594.451776] Dynamic subtest vecs0: SUCCESS (3.581s)
[594.457453] Subtest busy-double-start: SUCCESS (17.957s)
[594.637993] [107/154] (451s left) kms_plane_scaling (invalid-num-scalers)
[596.127935] Starting subtest: invalid-num-scalers
[596.133627] Starting dynamic subtest: pipe-A-HDMI-A-4-invalid-num-scalers
[596.156808] Dynamic subtest pipe-A-HDMI-A-4-invalid-num-scalers: SUCCESS (0.023s)
[596.175670] Starting dynamic subtest: pipe-B-HDMI-A-4-invalid-num-scalers
[596.200871] Dynamic subtest pipe-B-HDMI-A-4-invalid-num-scalers: SUCCESS (0.039s)
[596.219489] Starting dynamic subtest: pipe-C-HDMI-A-4-invalid-num-scalers
[596.245168] Dynamic subtest pipe-C-HDMI-A-4-invalid-num-scalers: SUCCESS (0.038s)
[596.263394] Starting dynamic subtest: pipe-D-HDMI-A-4-invalid-num-scalers
[596.289463] Dynamic subtest pipe-D-HDMI-A-4-invalid-num-scalers: SUCCESS (0.038s)
[596.290217] Subtest invalid-num-scalers: SUCCESS (0.163s)
[596.428487] [108/154] (449s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[597.919135] Starting subtest: short-flip-before-cursor-atomic-transitions
[598.947748] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (1.029s)
[599.166089] [109/154] (446s left) kms_addfb_basic (bad-pitch-63)
[599.213868] Starting subtest: bad-pitch-63
[599.214710] Subtest bad-pitch-63: SUCCESS (0.000s)
[600.811640] [110/154] (445s left) syncobj_wait (signal)
[600.862227] Starting subtest: signal
[600.863126] Subtest signal: SUCCESS (0.000s)
[600.982006] [111/154] (445s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[602.472766] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (0.000s)
[602.549983] [112/154] (443s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[604.060220] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[604.635397] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.575s)
[604.960233] [113/154] (441s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[606.456479] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-mmap-gtt
[606.458296] Subtest fbchdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[606.611480] [114/154] (439s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[608.102754] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[608.105155] Starting dynamic subtest: pipe-A-HDMI-A-4
[610.543060] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.433s)
[610.565833] Starting dynamic subtest: pipe-B-HDMI-A-4
[611.235773] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.681s)
[611.278340] Starting dynamic subtest: pipe-C-HDMI-A-4
[611.943405] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.695s)
[611.987635] Starting dynamic subtest: pipe-D-HDMI-A-4
[612.666601] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.711s)
[612.669023] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SUCCESS (4.562s)
[612.938071] [115/154] (433s left) gem_render_copy_redux (interruptible)
[612.991560] Starting subtest: interruptible
[613.878522] Subtest interruptible: SUCCESS (0.887s)
[614.096666] [116/154] (432s left) template (a)
[614.143485] Starting subtest: A
[614.144449] Subtest A: SUCCESS (0.000s)
[614.252600] [117/154] (432s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[616.034809] Starting subtest: cursor-rapid-movement-512x170
[616.038504] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[616.273592] [118/154] (430s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[617.764911] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[617.845743] [119/154] (428s left) kms_psr (pr-sprite-plane-onoff)
[619.338757] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[619.413873] [120/154] (427s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-move)
[620.911022] Starting subtest: psrhdr-1p-primscrn-spr-indfb-move
[620.913064] Subtest psrhdr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[621.103248] [121/154] (425s left) syncobj_timeline (etime-single-wait-submitted)
[621.153082] Starting subtest: etime-single-wait-submitted
[621.261006] Subtest etime-single-wait-submitted: SUCCESS (0.106s)
[621.459322] [122/154] (425s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[622.949297] Starting subtest: addfb25-yf-tiled-legacy
[622.950349] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[623.119323] [123/154] (424s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-render)
[624.616515] Starting subtest: psrhdr-rgb565-draw-render
[624.618306] Subtest psrhdr-rgb565-draw-render: SKIP (0.000s)
[624.851627] [124/154] (422s left) kms_atomic_transition (plane-all-transition-fencing)
[626.343246] Starting subtest: plane-all-transition-fencing
[626.344298] Starting dynamic subtest: pipe-A-HDMI-A-4
[630.198354] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (3.854s)
[630.283723] Starting dynamic subtest: pipe-B-HDMI-A-4
[634.299501] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (4.027s)
[634.354562] Subtest plane-all-transition-fencing: SUCCESS (8.012s)
[634.552287] [125/154] (412s left) device_reset (unbind-cold-reset-rebind)
[634.634631] Starting subtest: unbind-cold-reset-rebind
[634.636629] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[634.763848] [126/154] (412s left) i915_pm_rpm (system-suspend)
[638.483869] Starting subtest: system-suspend
[661.513942] Subtest system-suspend: SUCCESS (12.028s)
[666.473740] [127/154] (385s left) gem_ctx_persistence (engines-persistence)
[666.530160] Starting subtest: engines-persistence
[666.531043] Starting dynamic subtest: rcs0
[667.318617] Dynamic subtest rcs0: SUCCESS (0.789s)
[667.333698] Starting dynamic subtest: bcs0
[668.095623] Dynamic subtest bcs0: SUCCESS (0.775s)
[668.110884] Starting dynamic subtest: vcs0
[668.835707] Dynamic subtest vcs0: SUCCESS (0.738s)
[668.851082] Starting dynamic subtest: vcs1
[669.632391] Dynamic subtest vcs1: SUCCESS (0.794s)
[669.711054] Starting dynamic subtest: vecs0
[670.454452] Dynamic subtest vecs0: SUCCESS (0.814s)
[670.460247] Subtest engines-persistence: SUCCESS (3.929s)
[670.664097] [128/154] (381s left) i915_selftest (mock)
[671.671679] Starting subtest: mock
[671.672644] Starting dynamic subtest: sanitycheck
[672.459826] Dynamic subtest sanitycheck: SUCCESS (0.786s)
[672.498895] Starting dynamic subtest: shmem
[673.278587] Dynamic subtest shmem: SUCCESS (0.810s)
[673.318325] Starting dynamic subtest: fence
[681.463692] Dynamic subtest fence: SUCCESS (8.178s)
[681.476081] Starting dynamic subtest: scatterlist
[683.272687] Dynamic subtest scatterlist: SUCCESS (1.807s)
[683.286090] Starting dynamic subtest: syncmap
[686.042860] Dynamic subtest syncmap: SUCCESS (2.768s)
[686.056950] Starting dynamic subtest: uncore
[686.837781] Dynamic subtest uncore: SUCCESS (0.791s)
[686.878270] Starting dynamic subtest: ring
[687.654006] Dynamic subtest ring: SUCCESS (0.808s)
[687.696910] Starting dynamic subtest: engine
[688.496186] Dynamic subtest engine: SUCCESS (0.834s)
[688.537761] Starting dynamic subtest: timelines
[693.864690] Dynamic subtest timelines: SUCCESS (5.361s)
[693.876548] Starting dynamic subtest: requests
[696.700622] Dynamic subtest requests: SUCCESS (2.834s)
[696.712516] Starting dynamic subtest: objects
[697.637820] Dynamic subtest objects: SUCCESS (0.936s)
[697.649943] Starting dynamic subtest: phys
[698.588659] Dynamic subtest phys: SUCCESS (0.949s)
[698.601275] Starting dynamic subtest: dmabuf
[699.494846] Dynamic subtest dmabuf: SUCCESS (0.904s)
[699.506945] Starting dynamic subtest: vma
[709.852757] Dynamic subtest vma: SUCCESS (10.355s)
[709.865346] Starting dynamic subtest: evict
[711.884643] Dynamic subtest evict: SUCCESS (2.030s)
[711.899639] Starting dynamic subtest: gtt
[715.661710] Dynamic subtest gtt: SUCCESS (3.775s)
[715.674581] Starting dynamic subtest: hugepages
[716.792775] Dynamic subtest hugepages: SUCCESS (1.129s)
[716.805537] Starting dynamic subtest: memory_region
[720.941484] Dynamic subtest memory_region: SUCCESS (4.147s)
[720.942366] Subtest mock: SUCCESS (49.269s)
[720.988334] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[720.989471] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[720.991862] [129/154] (330s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc)
[725.794929] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc
[725.796822] Subtest psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[726.064896] [FACT kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[726.068391] [FACT kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc)] new: kernel.kmod_is_loaded.i915: true
[726.075551] [130/154] (325s left) kms_big_fb (linear-64bpp-rotate-0)
[727.586073] Starting subtest: linear-64bpp-rotate-0
[730.312164] Subtest linear-64bpp-rotate-0: SUCCESS (2.726s)
[730.481952] [131/154] (321s left) kms_flip (flip-vs-wf_vblank-interruptible)
[732.634170] Starting subtest: flip-vs-wf_vblank-interruptible
[732.642959] Starting dynamic subtest: A-HDMI-A4
[733.676686] Dynamic subtest A-HDMI-A4: SUCCESS (1.034s)
[733.692752] Starting dynamic subtest: B-HDMI-A4
[734.641984] Dynamic subtest B-HDMI-A4: SUCCESS (0.963s)
[734.657728] Starting dynamic subtest: C-HDMI-A4
[735.610406] Dynamic subtest C-HDMI-A4: SUCCESS (0.966s)
[735.626055] Starting dynamic subtest: D-HDMI-A4
[736.579280] Dynamic subtest D-HDMI-A4: SUCCESS (0.967s)
[736.580151] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (3.946s)
[736.829660] [132/154] (315s left) gem_create (create-massive)
[736.875252] Starting subtest: create-massive
[736.876054] Subtest create-massive: SUCCESS (0.000s)
[737.119349] [133/154] (315s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-pwrite)
[738.615902] Starting subtest: hdr-rgb101010-draw-pwrite
[738.617732] Subtest hdr-rgb101010-draw-pwrite: SKIP (0.000s)
[738.807285] [134/154] (313s left) gem_exec_params (rs-invalid)
[738.865740] Starting subtest: rs-invalid
[738.870089] Subtest rs-invalid: SUCCESS (0.003s)
[739.054335] [135/154] (313s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[739.102727] Starting subtest: single-wait-for-submit-unsubmitted
[739.215409] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.108s)
[739.426844] [136/154] (313s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-indfb-pgflip-blt)
[740.923171] Starting subtest: fbcpsrhdr-1p-primscrn-indfb-pgflip-blt
[740.924975] Subtest fbcpsrhdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[741.101502] [137/154] (311s left) gem_mmap_gtt (fault-concurrent)
[741.147666] Subtest fault-concurrent: SKIP (0.000s)
[741.240457] [138/154] (311s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[742.737128] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[742.738945] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[742.920970] [139/154] (309s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[744.413812] Starting subtest: short-flip-after-cursor-atomic-transitions
[745.425822] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (1.013s)
[745.638549] [140/154] (307s left) gem_mmap_gtt (medium-copy)
[745.686740] Subtest medium-copy: SKIP (0.000s)
[745.771232] [141/154] (307s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[745.818985] Starting subtest: multi-wait-all-for-submit-available-submitted
[745.819947] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.001s)
[745.954966] [142/154] (307s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[747.451370] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[747.452999] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[747.650653] [143/154] (305s left) kms_joiner (basic-ultra-joiner)
[749.141915] Starting subtest: basic-ultra-joiner
[749.143728] Subtest basic-ultra-joiner: SKIP (0.000s)
[749.271986] [144/154] (303s left) kms_chamelium_color (ctm-red-to-blue)
[750.770247] Subtest ctm-red-to-blue: SKIP (0.000s)
[750.855250] [145/154] (302s left) kms_frontbuffer_tracking (fbchdr-modesetfrombusy)
[752.360922] Starting subtest: fbchdr-modesetfrombusy
[752.362686] Subtest fbchdr-modesetfrombusy: SKIP (0.000s)
[752.553506] [146/154] (300s left) api_intel_allocator (reloc-allocator)
[752.603111] Starting subtest: reloc-allocator
[752.604139] Starting dynamic subtest: basic
[752.621768] Dynamic subtest basic: SUCCESS (0.018s)
[752.638188] Starting dynamic subtest: parallel-one
[752.639269] Dynamic subtest parallel-one: SUCCESS (0.005s)
[752.653409] Starting dynamic subtest: print
[752.654490] Dynamic subtest print: SUCCESS (0.000s)
[752.669135] Starting dynamic subtest: reuse
[752.670411] Dynamic subtest reuse: SUCCESS (0.000s)
[752.683727] Starting dynamic subtest: fork-reopen-allocator
[752.685073] Dynamic subtest fork-reopen-allocator: SUCCESS (0.016s)
[752.686411] Subtest reloc-allocator: SUCCESS (0.048s)
[752.831420] [147/154] (300s left) gem_mmap_wc (write)
[752.880546] Subtest write: SKIP (0.000s)
[752.959758] [148/154] (300s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[754.457896] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc
[754.459578] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[754.682198] [149/154] (299s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[756.173739] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[756.174773] Starting dynamic subtest: pipe-A-valid-mode
[757.003933] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.829s)
[757.004782] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (0.831s)
[757.220698] [150/154] (296s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[758.712615] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs
[758.713542] Starting dynamic subtest: pipe-A-HDMI-A-4
[758.722307] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[758.736309] Starting dynamic subtest: pipe-B-HDMI-A-4
[758.745119] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[758.758784] Starting dynamic subtest: pipe-C-HDMI-A-4
[758.768270] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[758.781903] Starting dynamic subtest: pipe-D-HDMI-A-4
[758.791753] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[758.793733] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.010s)
[759.013727] [151/154] (294s left) gem_mmap_gtt (zero-extend)
[759.062940] Subtest zero-extend: SKIP (0.000s)
[759.148795] [152/154] (294s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[760.644784] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[760.646682] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[760.843672] [153/154] (293s left) perf_pmu (rc6)
[760.896153] Starting subtest: rc6
[760.897118] Starting dynamic subtest: gt0
[767.240285] Dynamic subtest gt0: SUCCESS (6.341s)
[767.254670] Starting dynamic subtest: runtime-pm-gt0
[774.803916] Dynamic subtest runtime-pm-gt0: SUCCESS (7.559s)
[774.817695] Starting dynamic subtest: runtime-pm-long-gt0
[787.307531] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.504s)
[787.321501] Starting dynamic subtest: other-idle-gt0
[787.323273] Dynamic subtest other-idle-gt0: SKIP (0.000s)
[787.324147] Subtest rc6: SUCCESS (26.413s)
[788.093903] [154/154] (266s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[789.589945] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-mmap-cpu
[789.591908] Subtest fbchdr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[789.697292] Closing watchdogs
results: parsing output: 0/ for test: kms_pm_dc
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_chamelium_hpd
results: parsing output: 3/ for test: gem_close_race
results: parsing output: 4/ for test: kms_ccs
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: gem_pipe_control_store_loop
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_color_pipeline
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_mmap_wc
results: parsing output: 12/ for test: prime_vgem
results: parsing output: 13/ for test: gem_exec_flush
results: parsing output: 14/ for test: gem_exec_balancer
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: gem_workarounds
results: parsing output: 17/ for test: gem_exec_fence
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: fbdev
results: parsing output: 22/ for test: kms_cursor_legacy
results: parsing output: 23/ for test: gem_exec_reloc
results: parsing output: 24/ for test: gem_render_copy
results: parsing output: 25/ for test: kms_pipe_crc_basic
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: kms_atomic
results: parsing output: 28/ for test: kms_cursor_legacy
results: parsing output: 29/ for test: kms_atomic_interruptible
results: parsing output: 30/ for test: i915_hangman
results: parsing output: 31/ for test: kms_flip
results: parsing output: 32/ for test: i915_drm_fdinfo
results: parsing output: 33/ for test: syncobj_timeline
results: parsing output: 34/ for test: drm_read
results: parsing output: 35/ for test: gem_exec_fence
results: parsing output: 36/ for test: kms_cursor_edge_walk
results: parsing output: 37/ for test: kms_chamelium_edid
results: parsing output: 38/ for test: gem_exec_schedule
results: parsing output: 39/ for test: gem_exec_whisper
results: parsing output: 40/ for test: gem_exec_schedule
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: gem_set_tiling_vs_blt
results: parsing output: 45/ for test: perf
results: parsing output: 46/ for test: gem_userptr_blits
results: parsing output: 47/ for test: kms_psr
results: parsing output: 48/ for test: kms_addfb_basic
results: parsing output: 49/ for test: kms_flip
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_plane
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: gem_softpin
results: parsing output: 54/ for test: gem_exec_params
results: parsing output: 55/ for test: perf_pmu
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_prop_blob
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_flip
results: parsing output: 63/ for test: kms_plane_scaling
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_exec_whisper
results: parsing output: 67/ for test: kms_psr
results: parsing output: 68/ for test: kms_plane_lowres
results: parsing output: 69/ for test: syncobj_timeline
results: parsing output: 70/ for test: kms_content_protection
results: parsing output: 71/ for test: sw_sync
results: parsing output: 72/ for test: gem_ctx_param
results: parsing output: 73/ for test: gem_userptr_blits
results: parsing output: 74/ for test: kms_draw_crc
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gen9_exec_parse
results: parsing output: 77/ for test: kms_scaling_modes
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_lease
results: parsing output: 81/ for test: perf
results: parsing output: 82/ for test: kms_selftest
results: parsing output: 83/ for test: kms_vblank
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: prime_mmap_coherency
results: parsing output: 86/ for test: gem_lmem_swapping
results: parsing output: 87/ for test: gem_ctx_persistence
results: parsing output: 88/ for test: kms_flip
results: parsing output: 89/ for test: kms_psr2_sf
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: gem_exec_reloc
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: gem_render_copy
results: parsing output: 95/ for test: kms_cursor_crc
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: api_intel_bb
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: gem_mmap
results: parsing output: 100/ for test: kms_frontbuffer_tracking
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_frontbuffer_tracking
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: perf_pmu
results: parsing output: 106/ for test: kms_plane_scaling
results: parsing output: 107/ for test: kms_cursor_legacy
results: parsing output: 108/ for test: kms_addfb_basic
results: parsing output: 109/ for test: syncobj_wait
results: parsing output: 110/ for test: kms_psr2_sf
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_ccs
results: parsing output: 114/ for test: gem_render_copy_redux
results: parsing output: 115/ for test: template
results: parsing output: 116/ for test: kms_cursor_crc
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: kms_addfb_basic
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_atomic_transition
results: parsing output: 124/ for test: device_reset
results: parsing output: 125/ for test: i915_pm_rpm
results: parsing output: 126/ for test: gem_ctx_persistence
results: parsing output: 127/ for test: i915_selftest
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: kms_flip
results: parsing output: 131/ for test: gem_create
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: gem_exec_params
results: parsing output: 134/ for test: syncobj_wait
results: parsing output: 135/ for test: kms_frontbuffer_tracking
results: parsing output: 136/ for test: gem_mmap_gtt
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: kms_cursor_legacy
results: parsing output: 139/ for test: gem_mmap_gtt
results: parsing output: 140/ for test: syncobj_timeline
results: parsing output: 141/ for test: kms_frontbuffer_tracking
results: parsing output: 142/ for test: kms_joiner
results: parsing output: 143/ for test: kms_chamelium_color
results: parsing output: 144/ for test: kms_frontbuffer_tracking
results: parsing output: 145/ for test: api_intel_allocator
results: parsing output: 146/ for test: gem_mmap_wc
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: kms_flip_scaled_crc
results: parsing output: 149/ for test: kms_ccs
results: parsing output: 150/ for test: gem_mmap_gtt
results: parsing output: 151/ for test: kms_frontbuffer_tracking
results: parsing output: 152/ for test: perf_pmu
results: parsing output: 153/ for test: kms_frontbuffer_tracking
Done.