[69.550183] Initializing watchdogs
[69.550266]   /dev/watchdog0
[69.581819] [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.596842] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[69.601746] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[69.605192] [001/155] (960s left) kms_pm_dc (dc5-dpms-negative)
[72.120515] Starting subtest: dc5-dpms-negative
[76.349848] Subtest dc5-dpms-negative: SUCCESS (4.226s)
[76.467162] [002/155] (953s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-move)
[77.969679] Starting subtest: fbchdr-2p-primscrn-spr-indfb-move
[77.972925] Subtest fbchdr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[78.145732] [003/155] (952s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[79.681708] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[79.809132] [004/155] (950s left) gem_close_race (basic-process)
[79.894590] Starting subtest: basic-process
[79.946298] Subtest basic-process: SUCCESS (0.053s)
[80.318858] [005/155] (950s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[81.809635] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[81.811077] Starting dynamic subtest: pipe-A-HDMI-A-4
[81.827485] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[81.836849] Starting dynamic subtest: pipe-B-HDMI-A-4
[81.856118] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[81.865141] Starting dynamic subtest: pipe-C-HDMI-A-4
[81.881697] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[81.890778] Starting dynamic subtest: pipe-D-HDMI-A-4
[81.908713] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[81.911889] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[82.072643] [006/155] (948s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[83.572928] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[83.576501] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[83.706123] [007/155] (946s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-mmap-cpu)
[85.223757] Starting subtest: fbcpsrhdr-rgb101010-draw-mmap-cpu
[85.226917] Subtest fbcpsrhdr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[85.395610] [008/155] (945s left) gem_pipe_control_store_loop (fresh-buffer)
[85.454698] Starting subtest: fresh-buffer
[87.625264] Subtest fresh-buffer: SUCCESS (2.167s)
[87.782652] [009/155] (943s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-mmap-wc)
[89.283871] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-mmap-wc
[89.287109] Subtest hdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[89.433524] [010/155] (941s left) kms_color_pipeline (plane-lut1d)
[90.934482] Starting subtest: plane-lut1d
[91.142317] Starting dynamic subtest: pipe-A-plane-0
[91.392701] Dynamic subtest pipe-A-plane-0: SUCCESS (0.250s)
[91.428880] Starting dynamic subtest: pipe-A-plane-1
[91.593163] Dynamic subtest pipe-A-plane-1: SUCCESS (0.199s)
[91.622146] Starting dynamic subtest: pipe-A-plane-2
[91.809129] Dynamic subtest pipe-A-plane-2: SUCCESS (0.215s)
[92.121829] Starting dynamic subtest: pipe-B-plane-0
[92.287690] Dynamic subtest pipe-B-plane-0: SUCCESS (0.200s)
[92.301892] Starting dynamic subtest: pipe-B-plane-1
[92.455594] Dynamic subtest pipe-B-plane-1: SUCCESS (0.165s)
[92.486649] Starting dynamic subtest: pipe-B-plane-2
[92.654863] Dynamic subtest pipe-B-plane-2: SUCCESS (0.198s)
[92.949942] Starting dynamic subtest: pipe-C-plane-0
[93.121820] Dynamic subtest pipe-C-plane-0: SUCCESS (0.200s)
[93.135864] Starting dynamic subtest: pipe-C-plane-1
[93.321228] Dynamic subtest pipe-C-plane-1: SUCCESS (0.199s)
[93.354401] Starting dynamic subtest: pipe-C-plane-2
[93.536925] Dynamic subtest pipe-C-plane-2: SUCCESS (0.215s)
[93.824206] Starting dynamic subtest: pipe-D-plane-0
[93.995522] Dynamic subtest pipe-D-plane-0: SUCCESS (0.183s)
[94.009401] Starting dynamic subtest: pipe-D-plane-1
[94.195427] Dynamic subtest pipe-D-plane-1: SUCCESS (0.199s)
[94.209290] Starting dynamic subtest: pipe-D-plane-2
[94.378866] Dynamic subtest pipe-D-plane-2: SUCCESS (0.182s)
[94.433377] Subtest plane-lut1d: SUCCESS (3.499s)
[94.666741] [011/155] (936s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[96.171378] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[96.174816] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[96.366660] [012/155] (934s left) gem_mmap_wc (copy)
[96.490291] Subtest copy: SKIP (0.000s)
[96.595206] [013/155] (934s left) prime_vgem (basic-fence-blt)
[96.747082] Starting subtest: basic-fence-blt
[96.849604] Subtest basic-fence-blt: SUCCESS (0.105s)
[97.004050] [FACT prime_vgem (basic-fence-blt)] new: kernel.kmod_is_loaded.vgem: true
[97.007419] [014/155] (934s left) gem_exec_flush (basic-batch-kernel-default-wb)
[97.061028] Subtest basic-batch-kernel-default-wb: SKIP (0.000s)
[97.154409] [015/155] (934s left) gem_exec_balancer (full-late-pulse)
[97.214851] Starting subtest: full-late-pulse
[99.628846] Subtest full-late-pulse: SUCCESS (2.415s)
[100.094441] [016/155] (931s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[101.604701] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[101.608221] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[101.774399] [017/155] (929s left) gem_workarounds (reset-fd)
[101.875111] Starting subtest: reset-fd
[102.047136] Subtest reset-fd: SUCCESS (0.172s)
[102.214488] [018/155] (929s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[102.785627] Starting subtest: syncobj-stationary-timeline-chain-engines
[102.932972] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.150s)
[103.271932] [019/155] (928s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[104.771798] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[107.226381] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (2.457s)
[107.471917] [020/155] (924s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[108.973302] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[108.975927] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[109.124894] [021/155] (922s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[110.622940] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[110.703806] [022/155] (921s left) fbdev (unaligned-read)
[110.759351] Starting subtest: unaligned-read
[110.774927] Subtest unaligned-read: SUCCESS (0.015s)
[110.874356] [023/155] (921s left) kms_cursor_legacy (torture-bo)
[112.362791] Starting subtest: torture-bo
[112.364400] Starting dynamic subtest: pipe-A
[117.897336] Dynamic subtest pipe-A: SUCCESS (5.535s)
[117.910237] Starting dynamic subtest: pipe-B
[123.408349] Dynamic subtest pipe-B: SUCCESS (5.507s)
[123.423273] Starting dynamic subtest: pipe-C
[128.860767] Dynamic subtest pipe-C: SUCCESS (5.452s)
[128.874280] Starting dynamic subtest: pipe-D
[134.319114] Dynamic subtest pipe-D: SUCCESS (5.458s)
[134.331714] Starting dynamic subtest: all-pipes
[139.794493] Dynamic subtest all-pipes: SUCCESS (5.476s)
[139.795815] Subtest torture-bo: SUCCESS (27.430s)
[139.948777] [024/155] (892s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[140.017668] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[140.137547] [025/155] (892s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[140.190745] Starting subtest: y-tiled-ccs-to-yf-tiled
[140.194493] Starting dynamic subtest: smem
[140.286563] Dynamic subtest smem: SUCCESS (0.096s)
[140.298386] Starting dynamic subtest: lmem0
[141.216029] Dynamic subtest lmem0: SUCCESS (0.925s)
[141.217813] Subtest y-tiled-ccs-to-yf-tiled: SUCCESS (1.022s)
[141.518411] [026/155] (890s left) kms_pipe_crc_basic (read-crc)
[143.008926] Starting subtest: read-crc
[143.010342] Starting dynamic subtest: pipe-A-HDMI-A-4
[143.683540] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.675s)
[143.702259] Starting dynamic subtest: pipe-B-HDMI-A-4
[144.165516] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.478s)
[144.179180] Starting dynamic subtest: pipe-C-HDMI-A-4
[144.660528] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.494s)
[144.674189] Starting dynamic subtest: pipe-D-HDMI-A-4
[145.208925] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.547s)
[145.210496] Subtest read-crc: SUCCESS (2.201s)
[145.404556] [027/155] (887s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[146.915717] Starting subtest: y-tiled-16bpp-rotate-90
[148.721036] Subtest y-tiled-16bpp-rotate-90: SUCCESS (1.802s)
[148.897449] [028/155] (883s left) kms_atomic (atomic-invalid-params)
[150.387219] Starting subtest: atomic-invalid-params
[150.388754] Starting dynamic subtest: pipe-A-HDMI-A-4
[150.772510] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.383s)
[150.774138] Subtest atomic-invalid-params: SUCCESS (0.385s)
[150.982409] [029/155] (881s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[152.474707] Starting subtest: cursorB-vs-flipA-varying-size
[152.477894] Subtest cursorB-vs-flipA-varying-size: SKIP (0.002s)
[152.634047] [030/155] (880s left) kms_atomic_interruptible (atomic-setmode)
[154.133319] Starting subtest: atomic-setmode
[154.134806] Starting dynamic subtest: pipe-A-HDMI-A-4
[160.336893] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (6.202s)
[160.338655] Subtest atomic-setmode: SUCCESS (6.204s)
[160.513553] [031/155] (872s left) i915_hangman (gt-error-state-capture)
[160.576353] Starting subtest: gt-error-state-capture
[160.577873] Starting dynamic subtest: rcs0
[170.042706] Dynamic subtest rcs0: SUCCESS (9.467s)
[170.054982] Starting dynamic subtest: bcs0
[180.013134] Dynamic subtest bcs0: SUCCESS (9.970s)
[180.030062] Starting dynamic subtest: vcs0
[189.999106] Dynamic subtest vcs0: SUCCESS (9.986s)
[190.015403] Starting dynamic subtest: vcs1
[199.983806] Dynamic subtest vcs1: SUCCESS (9.985s)
[200.000447] Starting dynamic subtest: vecs0
[209.970953] Dynamic subtest vecs0: SUCCESS (9.987s)
[209.972615] Subtest gt-error-state-capture: SUCCESS (49.397s)
[210.169568] [032/155] (822s left) kms_flip (busy-flip)
[211.660165] Starting subtest: busy-flip
[211.666765] Starting dynamic subtest: A-HDMI-A4
[212.447478] Dynamic subtest A-HDMI-A4: SUCCESS (0.781s)
[212.462044] Starting dynamic subtest: B-HDMI-A4
[213.142205] Dynamic subtest B-HDMI-A4: SUCCESS (0.693s)
[213.155258] Starting dynamic subtest: C-HDMI-A4
[213.836468] Dynamic subtest C-HDMI-A4: SUCCESS (0.694s)
[213.849313] Starting dynamic subtest: D-HDMI-A4
[214.537008] Dynamic subtest D-HDMI-A4: SUCCESS (0.699s)
[214.538622] Subtest busy-flip: SUCCESS (2.879s)
[214.789293] [033/155] (818s left) i915_drm_fdinfo (virtual-busy-hang-all)
[214.841757] Starting subtest: virtual-busy-hang-all
[214.845376] Subtest virtual-busy-hang-all: SKIP (0.000s)
[214.974249] [034/155] (818s left) syncobj_timeline (wait-delayed-signal)
[215.028486] Starting subtest: wait-delayed-signal
[215.128107] Subtest wait-delayed-signal: SUCCESS (0.103s)
[215.292738] [035/155] (817s left) drm_read (invalid-buffer)
[216.861865] Starting subtest: invalid-buffer
[216.863651] Subtest invalid-buffer: SUCCESS (0.000s)
[217.106764] [036/155] (816s left) gem_exec_fence (basic-await)
[217.283353] Starting subtest: basic-await
[217.284807] Starting dynamic subtest: rcs0
[217.389733] Dynamic subtest rcs0: SUCCESS (0.106s)
[217.402772] Starting dynamic subtest: bcs0
[217.475118] Dynamic subtest bcs0: SUCCESS (0.085s)
[217.491397] Starting dynamic subtest: vcs0
[217.566662] Dynamic subtest vcs0: SUCCESS (0.091s)
[217.581212] Starting dynamic subtest: vcs1
[217.653677] Dynamic subtest vcs1: SUCCESS (0.086s)
[217.668341] Starting dynamic subtest: vecs0
[217.741189] Dynamic subtest vecs0: SUCCESS (0.087s)
[217.742886] Subtest basic-await: SUCCESS (0.458s)
[218.453499] [037/155] (814s left) kms_cursor_edge_walk (64x64-top-bottom)
[219.943487] Starting subtest: 64x64-top-bottom
[219.944992] Starting dynamic subtest: pipe-A-HDMI-A-4
[223.262821] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (3.318s)
[223.275390] Starting dynamic subtest: pipe-D-HDMI-A-4
[226.495937] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (3.230s)
[226.497418] Subtest 64x64-top-bottom: SUCCESS (6.552s)
[226.693185] [038/155] (806s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[228.233339] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[228.362944] [039/155] (805s left) gem_exec_schedule (preempt-user)
[228.428256] Starting subtest: preempt-user
[228.430116] Starting dynamic subtest: rcs0
[228.496252] Dynamic subtest rcs0: SUCCESS (0.068s)
[228.509032] Starting dynamic subtest: bcs0
[228.540467] Dynamic subtest bcs0: SUCCESS (0.043s)
[228.553114] Starting dynamic subtest: vcs0
[228.585038] Dynamic subtest vcs0: SUCCESS (0.044s)
[228.597606] Starting dynamic subtest: vcs1
[228.629316] Dynamic subtest vcs1: SUCCESS (0.044s)
[228.642502] Starting dynamic subtest: vecs0
[228.673369] Dynamic subtest vecs0: SUCCESS (0.044s)
[228.674948] Subtest preempt-user: SUCCESS (0.246s)
[229.107072] [040/155] (804s left) gem_exec_whisper (basic-forked)
[229.167737] Starting subtest: basic-forked
[231.883030] Subtest basic-forked: SUCCESS (2.713s)
[232.218760] [041/155] (801s left) gem_exec_schedule (manyslice)
[232.280160] Starting subtest: manyslice
[232.281751] Starting dynamic subtest: rcs0
[238.325295] Dynamic subtest rcs0: SUCCESS (6.042s)
[238.338109] Starting dynamic subtest: bcs0
[244.700172] Dynamic subtest bcs0: SUCCESS (6.374s)
[244.714617] Starting dynamic subtest: vcs0
[250.197997] Dynamic subtest vcs0: SUCCESS (5.497s)
[250.210973] Starting dynamic subtest: vcs1
[255.190681] Dynamic subtest vcs1: SUCCESS (4.992s)
[255.203200] Starting dynamic subtest: vecs0
[261.175875] Dynamic subtest vecs0: SUCCESS (5.984s)
[261.177532] Subtest manyslice: SUCCESS (28.893s)
[261.573299] [042/155] (772s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[263.072878] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[263.078965] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[263.242968] [043/155] (770s left) kms_frontbuffer_tracking (hdr-2p-primscrn-shrfb-plflip-blt)
[264.743534] Starting subtest: hdr-2p-primscrn-shrfb-plflip-blt
[264.746662] Subtest hdr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[264.930501] [044/155] (768s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[266.441355] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[266.444499] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[266.591148] [045/155] (767s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[266.648121] Subtest tiled-to-tiled: SKIP (0.000s)
[266.726180] [046/155] (767s left) perf (missing-sample-flags)
[266.867418] Starting subtest: missing-sample-flags
[266.868971] Subtest missing-sample-flags: SUCCESS (0.000s)
[266.948023] [047/155] (767s left) gem_userptr_blits (vma-merge)
[267.021380] Starting subtest: vma-merge
[267.115828] Subtest vma-merge: SUCCESS (0.094s)
[267.267239] [048/155] (766s left) kms_psr (psr-cursor-render)
[268.760943] Subtest psr-cursor-render: SKIP (0.000s)
[268.842668] [049/155] (765s left) kms_addfb_basic (clobberred-modifier)
[268.891648] Starting subtest: clobberred-modifier
[268.894697] Subtest clobberred-modifier: SKIP (0.000s)
[270.546511] [050/155] (763s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[272.042455] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[272.061842] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.018s)
[272.205895] [051/155] (762s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[273.706869] Starting subtest: psr-rgb101010-draw-render
[273.709796] Subtest psr-rgb101010-draw-render: SKIP (0.000s)
[273.859361] [052/155] (760s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping)
[275.354120] Starting subtest: pixel-format-x-tiled-modifier-source-clamping
[275.379396] Starting dynamic subtest: pipe-A-plane-0
[276.129383] Dynamic subtest pipe-A-plane-0: SUCCESS (0.750s)
[276.153503] Starting dynamic subtest: pipe-A-plane-3
[276.646139] Dynamic subtest pipe-A-plane-3: SUCCESS (0.516s)
[276.681998] Starting dynamic subtest: pipe-A-plane-5
[277.162857] Dynamic subtest pipe-A-plane-5: SUCCESS (0.515s)
[277.324862] Starting dynamic subtest: pipe-B-plane-0
[277.881630] Dynamic subtest pipe-B-plane-0: SUCCESS (0.567s)
[277.925059] Starting dynamic subtest: pipe-B-plane-3
[278.380687] Dynamic subtest pipe-B-plane-3: SUCCESS (0.497s)
[278.404554] Starting dynamic subtest: pipe-B-plane-5
[278.880657] Dynamic subtest pipe-B-plane-5: SUCCESS (0.499s)
[278.920345] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (3.565s)
[279.124940] [053/155] (755s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-shrfb-msflip-blt)
[280.625726] Starting subtest: fbcpsrhdr-2p-primscrn-shrfb-msflip-blt
[280.628945] Subtest fbcpsrhdr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[280.818990] [054/155] (754s left) gem_softpin (evict-prime)
[280.873187] Starting subtest: evict-prime
[280.877754] Starting dynamic subtest: rcs0
[282.047096] Dynamic subtest rcs0: SUCCESS (1.174s)
[282.060613] Starting dynamic subtest: bcs0
[283.269137] Dynamic subtest bcs0: SUCCESS (1.207s)
[283.283993] Starting dynamic subtest: vcs0
[284.433890] Dynamic subtest vcs0: SUCCESS (1.178s)
[284.449646] Starting dynamic subtest: vcs1
[285.605010] Dynamic subtest vcs1: SUCCESS (1.170s)
[285.617507] Starting dynamic subtest: vecs0
[286.803820] Dynamic subtest vecs0: SUCCESS (1.198s)
[286.817647] Starting dynamic subtest: all
[288.015955] Dynamic subtest all: SUCCESS (1.211s)
[288.017687] Subtest evict-prime: SUCCESS (7.143s)
[288.170563] [055/155] (746s left) gem_exec_params (no-blt)
[288.223812] Starting subtest: no-blt
[288.227269] Subtest no-blt: SUCCESS (0.002s)
[288.439253] [056/155] (746s left) perf_pmu (busy-no-semaphores)
[288.491467] Starting subtest: busy-no-semaphores
[288.493123] Starting dynamic subtest: rcs0
[289.067792] Dynamic subtest rcs0: SUCCESS (0.571s)
[289.081983] Starting dynamic subtest: bcs0
[289.621588] Dynamic subtest bcs0: SUCCESS (0.551s)
[289.634270] Starting dynamic subtest: vcs0
[290.176850] Dynamic subtest vcs0: SUCCESS (0.551s)
[290.190946] Starting dynamic subtest: vcs1
[290.730284] Dynamic subtest vcs1: SUCCESS (0.550s)
[290.743041] Starting dynamic subtest: vecs0
[291.284764] Dynamic subtest vecs0: SUCCESS (0.551s)
[291.287595] Subtest busy-no-semaphores: SUCCESS (2.791s)
[291.493410] [057/155] (743s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[292.992643] Starting subtest: fbc-rgb101010-draw-pwrite
[293.929451] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (0.940s)
[294.148044] [058/155] (741s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[295.649894] Starting subtest: psr-rgb565-draw-render
[295.653231] Subtest psr-rgb565-draw-render: SKIP (0.000s)
[295.826386] [059/155] (739s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[297.327871] Starting subtest: fbc-indfb-scaledprimary
[298.663249] Subtest fbc-indfb-scaledprimary: SUCCESS (1.338s)
[298.950224] [060/155] (736s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-blt)
[300.448713] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-blt
[300.451904] Subtest hdr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[300.630294] [061/155] (734s left) kms_prop_blob (blob-prop-core)
[300.683220] Starting subtest: blob-prop-core
[300.685121] Subtest blob-prop-core: SUCCESS (0.000s)
[300.814876] [062/155] (734s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-indfb-plflip-blt)
[302.314276] Starting subtest: psrhdr-2p-scndscrn-indfb-plflip-blt
[302.317934] Subtest psrhdr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[302.486975] [063/155] (733s left) kms_flip (plain-flip-interruptible)
[303.985129] Starting subtest: plain-flip-interruptible
[303.993465] Starting dynamic subtest: A-HDMI-A4
[304.722657] Dynamic subtest A-HDMI-A4: SUCCESS (0.729s)
[304.742196] Starting dynamic subtest: B-HDMI-A4
[305.400726] Dynamic subtest B-HDMI-A4: SUCCESS (0.677s)
[305.413977] Starting dynamic subtest: C-HDMI-A4
[306.063206] Dynamic subtest C-HDMI-A4: SUCCESS (0.660s)
[306.102294] Starting dynamic subtest: D-HDMI-A4
[306.755534] Dynamic subtest D-HDMI-A4: SUCCESS (0.687s)
[306.757183] Subtest plain-flip-interruptible: SUCCESS (2.771s)
[306.999775] [064/155] (728s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[308.495275] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[308.496948] Starting dynamic subtest: pipe-A
[308.593688] Dynamic subtest pipe-A: SUCCESS (0.101s)
[308.606603] Starting dynamic subtest: pipe-B
[308.751417] Dynamic subtest pipe-B: SUCCESS (0.157s)
[308.764052] Starting dynamic subtest: pipe-C
[308.907868] Dynamic subtest pipe-C: SUCCESS (0.156s)
[308.920429] Starting dynamic subtest: pipe-D
[309.063584] Dynamic subtest pipe-D: SUCCESS (0.155s)
[309.065188] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (0.571s)
[309.270551] [065/155] (726s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[310.770782] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[310.773998] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[310.990622] [066/155] (725s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[312.489853] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[312.493149] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[312.678080] [067/155] (723s left) gem_exec_whisper (basic-queues-priority-all)
[312.741882] Starting subtest: basic-queues-priority-all
[327.074561] Subtest basic-queues-priority-all: SUCCESS (14.329s)
[327.405181] [068/155] (708s left) kms_psr (pr-cursor-blt)
[328.896978] Subtest pr-cursor-blt: SKIP (0.000s)
[328.982223] [069/155] (707s left) kms_plane_lowres (tiling-y)
[330.473162] Starting subtest: tiling-y
[330.474801] Starting dynamic subtest: pipe-A-HDMI-A-4
[340.096124] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (9.622s)
[340.182892] Starting dynamic subtest: pipe-B-HDMI-A-4
[349.710230] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (9.539s)
[349.810997] Starting dynamic subtest: pipe-C-HDMI-A-4
[359.401072] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (9.601s)
[359.487313] Starting dynamic subtest: pipe-D-HDMI-A-4
[369.231052] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (9.756s)
[369.319780] Subtest tiling-y: SUCCESS (38.847s)
[369.557885] [070/155] (666s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[369.615005] Starting subtest: etime-multi-wait-all-submitted-signaled
[369.719662] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.104s)
[369.845876] [071/155] (666s left) kms_content_protection (atomic-dpms)
[371.390825] Starting subtest: atomic-dpms
[371.395466] Subtest atomic-dpms: SKIP (0.002s)
[371.598644] [072/155] (665s left) sw_sync (sync_merge_invalid)
[371.645159] Starting subtest: sync_merge_invalid
[371.651032] Subtest sync_merge_invalid: SUCCESS (0.004s)
[371.742407] [073/155] (665s left) gem_ctx_param (set-priority-invalid-size)
[371.793269] Starting subtest: set-priority-invalid-size
[371.795033] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[371.923335] [074/155] (664s left) gem_userptr_blits (unsync-unmap-cycles)
[371.984646] Subtest unsync-unmap-cycles: SKIP (0.000s)
[372.211768] [075/155] (664s left) kms_draw_crc (draw-method-mmap-gtt)
[373.705675] Starting subtest: draw-method-mmap-gtt
[373.708701] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[373.899866] [076/155] (663s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[375.398782] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[375.401881] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[375.605672] [077/155] (661s left) gen9_exec_parse (batch-invalid-length)
[375.661240] Subtest batch-invalid-length: SKIP (0.000s)
[375.740811] [078/155] (661s left) kms_scaling_modes (scaling-mode-full-aspect)
[377.230818] Starting subtest: scaling-mode-full-aspect
[377.239906] Subtest scaling-mode-full-aspect: SKIP (0.001s)
[377.351100] [079/155] (660s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[378.850509] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[378.852125] Starting dynamic subtest: pipe-A-HDMI-A-4
[400.070246] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (10.467s)
[400.121192] Starting dynamic subtest: pipe-B-HDMI-A-4
[421.966266] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (10.226s)
[421.981435] Starting dynamic subtest: pipe-C-HDMI-A-4
[443.988478] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (10.173s)
[444.004175] Starting dynamic subtest: pipe-D-HDMI-A-4
[465.976045] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (10.032s)
[465.978099] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SUCCESS (40.914s)
[472.220845] [080/155] (571s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[473.732972] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[473.736186] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[473.923746] [081/155] (569s left) kms_lease (lease-invalid-connector)
[475.449882] Starting subtest: lease-invalid-connector
[475.451525] Starting dynamic subtest: pipe-A-HDMI-A-4
[475.453037] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.000s)
[475.469006] Starting dynamic subtest: pipe-B-HDMI-A-4
[475.470900] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.000s)
[475.486185] Starting dynamic subtest: pipe-C-HDMI-A-4
[475.488005] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.000s)
[475.505045] Starting dynamic subtest: pipe-D-HDMI-A-4
[475.509290] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.000s)
[475.511010] Subtest lease-invalid-connector: SUCCESS (0.009s)
[475.580837] [082/155] (568s left) perf (mi-rpc)
[475.709862] Starting subtest: mi-rpc
[475.713635] Subtest mi-rpc: SKIP (0.000s)
[475.787030] [083/155] (567s left) kms_selftest (drm_plane_helper)
[475.844347] Starting subtest: drm_plane_helper
[475.919851] Starting dynamic subtest: drm_test_check_plane_state
[475.974423] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.082s)
[476.012844] Starting dynamic subtest: drm_test_check_invalid_plane_state
[476.041723] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.065s)
[476.043559] Subtest drm_plane_helper: SUCCESS (0.198s)
[476.260903] [084/155] (567s left) kms_vblank (wait-forked-busy-hang)
[477.769104] Starting subtest: wait-forked-busy-hang
[477.771054] Starting dynamic subtest: pipe-A-HDMI-A-4
[504.686107] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (26.915s)
[504.705929] Starting dynamic subtest: pipe-D-HDMI-A-4
[529.729125] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (25.003s)
[529.765879] Subtest wait-forked-busy-hang: SUCCESS (51.927s)
[530.065412] [085/155] (513s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[531.571002] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[531.574291] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[531.740931] [086/155] (512s left) prime_mmap_coherency (read)
[531.795431] Starting subtest: read
[537.201699] Subtest read: SUCCESS (5.403s)
[537.379697] [087/155] (506s left) gem_lmem_swapping (verify-random-ccs)
[541.837971] Starting subtest: verify-random-ccs
[541.840483] Starting dynamic subtest: lmem0
[541.846847] Dynamic subtest lmem0: SKIP (0.001s)
[541.851049] Subtest verify-random-ccs: SKIP (0.007s)
[545.623091] [FACT gem_lmem_swapping (verify-random-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[545.624223] [FACT gem_lmem_swapping (verify-random-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[545.627398] [088/155] (498s left) gem_ctx_persistence (heartbeat-close)
[548.955593] Starting subtest: heartbeat-close
[548.958907] Subtest heartbeat-close: SKIP (0.000s)
[549.060025] [FACT gem_ctx_persistence (heartbeat-close)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[549.063564] [FACT gem_ctx_persistence (heartbeat-close)] new: kernel.kmod_is_loaded.i915: true
[549.067792] [089/155] (495s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[550.569051] Starting subtest: 2x-plain-flip-ts-check-interruptible
[550.588008] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.017s)
[550.722636] [090/155] (493s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[552.220276] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[552.299879] [091/155] (492s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[553.811394] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[554.433102] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.622s)
[554.650876] [092/155] (489s left) gem_exec_reloc (basic-write-cpu)
[554.722375] Subtest basic-write-cpu: SKIP (0.000s)
[554.835602] [093/155] (489s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-indfb-fliptrack-mmap-gtt)
[556.337470] Starting subtest: fbcpsrhdr-2p-indfb-fliptrack-mmap-gtt
[556.340711] Subtest fbcpsrhdr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[556.518195] [094/155] (488s left) syncobj_timeline (multi-wait-signaled)
[556.566244] Starting subtest: multi-wait-signaled
[556.567997] Subtest multi-wait-signaled: SUCCESS (0.001s)
[556.692764] [095/155] (488s left) gem_exec_alignment (pi)
[556.746864] Starting subtest: pi
[579.788427] Subtest pi: SUCCESS (23.039s)
[580.366040] [096/155] (464s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[580.487523] Starting subtest: mixed-tiled-to-y-tiled-ccs
[580.488951] Starting dynamic subtest: smem
[580.610080] Dynamic subtest smem: SUCCESS (0.122s)
[580.625014] Starting dynamic subtest: lmem0
[581.575350] Dynamic subtest lmem0: SUCCESS (0.960s)
[581.576948] Subtest mixed-tiled-to-y-tiled-ccs: SUCCESS (1.085s)
[581.846616] [097/155] (463s left) kms_cursor_crc (cursor-offscreen-32x32)
[583.439704] Starting subtest: cursor-offscreen-32x32
[583.490743] Subtest cursor-offscreen-32x32: SKIP (0.048s)
[583.981899] [098/155] (461s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[585.497912] Starting subtest: yf-tiled-addfb-size-offset-overflow
[585.501277] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[585.706883] [099/155] (459s left) api_intel_bb (object-reloc-keep-cache)
[585.758358] Starting subtest: object-reloc-keep-cache
[585.764296] Subtest object-reloc-keep-cache: SKIP (0.002s)
[585.978502] [100/155] (459s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[587.495628] Starting subtest: x-tiled-64bpp-rotate-270
[587.573341] Subtest x-tiled-64bpp-rotate-270: SKIP (0.075s)
[587.752006] [101/155] (457s left) gem_mmap (pf-nonblock)
[587.801698] Subtest pf-nonblock: SKIP (0.000s)
[587.881991] [102/155] (457s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-mmap-wc)
[589.382365] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-mmap-wc
[589.385852] Subtest psrhdr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[589.569578] [103/155] (456s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-y)
[591.070244] Starting subtest: fbcpsrhdr-tiling-y
[591.073858] Subtest fbcpsrhdr-tiling-y: SKIP (0.000s)
[591.244724] [104/155] (454s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-blt)
[592.744745] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-blt
[592.747744] Subtest fbchdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[592.938270] [105/155] (452s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[594.435644] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[597.600634] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (3.167s)
[597.826433] [106/155] (448s left) kms_frontbuffer_tracking (hdr-1p-rte)
[599.325059] Starting subtest: hdr-1p-rte
[599.328703] Subtest hdr-1p-rte: SKIP (0.000s)
[599.497785] [107/155] (446s left) perf_pmu (busy-double-start)
[599.559835] Starting subtest: busy-double-start
[599.561263] Starting dynamic subtest: rcs0
[603.165797] Dynamic subtest rcs0: SUCCESS (3.610s)
[603.185997] Starting dynamic subtest: bcs0
[606.759718] Dynamic subtest bcs0: SUCCESS (3.591s)
[606.780275] Starting dynamic subtest: vcs0
[610.351770] Dynamic subtest vcs0: SUCCESS (3.590s)
[610.371500] Starting dynamic subtest: vcs1
[613.935753] Dynamic subtest vcs1: SUCCESS (3.582s)
[613.954487] Starting dynamic subtest: vecs0
[617.522741] Dynamic subtest vecs0: SUCCESS (3.585s)
[617.524288] Subtest busy-double-start: SUCCESS (17.968s)
[617.646114] [108/155] (428s left) kms_plane_scaling (invalid-num-scalers)
[619.136799] Starting subtest: invalid-num-scalers
[619.142246] Starting dynamic subtest: pipe-A-HDMI-A-4-invalid-num-scalers
[619.163751] Dynamic subtest pipe-A-HDMI-A-4-invalid-num-scalers: SUCCESS (0.021s)
[619.183501] Starting dynamic subtest: pipe-B-HDMI-A-4-invalid-num-scalers
[619.205756] Dynamic subtest pipe-B-HDMI-A-4-invalid-num-scalers: SUCCESS (0.037s)
[619.225185] Starting dynamic subtest: pipe-C-HDMI-A-4-invalid-num-scalers
[619.248222] Dynamic subtest pipe-C-HDMI-A-4-invalid-num-scalers: SUCCESS (0.036s)
[619.267370] Starting dynamic subtest: pipe-D-HDMI-A-4-invalid-num-scalers
[619.288741] Dynamic subtest pipe-D-HDMI-A-4-invalid-num-scalers: SUCCESS (0.035s)
[619.290152] Subtest invalid-num-scalers: SUCCESS (0.154s)
[619.440399] [109/155] (426s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[620.934533] Starting subtest: short-flip-before-cursor-atomic-transitions
[621.973672] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (1.040s)
[622.184534] [110/155] (424s left) kms_addfb_basic (bad-pitch-63)
[622.235279] Starting subtest: bad-pitch-63
[622.236962] Subtest bad-pitch-63: SUCCESS (0.000s)
[623.839406] [111/155] (422s left) syncobj_wait (signal)
[623.904334] Starting subtest: signal
[623.905903] Subtest signal: SUCCESS (0.000s)
[624.038009] [112/155] (422s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[625.532662] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (0.000s)
[625.619115] [113/155] (421s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[627.129226] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[627.702881] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.574s)
[627.941754] [114/155] (418s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[629.440204] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-mmap-gtt
[629.445380] Subtest fbchdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[629.617167] [115/155] (417s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[631.108807] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[631.110240] Starting dynamic subtest: pipe-A-HDMI-A-4
[633.549150] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.429s)
[633.568542] Starting dynamic subtest: pipe-B-HDMI-A-4
[634.222300] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.662s)
[634.265021] Starting dynamic subtest: pipe-C-HDMI-A-4
[634.931800] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.696s)
[634.973353] Starting dynamic subtest: pipe-D-HDMI-A-4
[635.640999] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.695s)
[635.644173] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SUCCESS (4.524s)
[635.891854] [116/155] (411s left) gem_render_copy_redux (interruptible)
[635.948951] Starting subtest: interruptible
[636.811992] Subtest interruptible: SUCCESS (0.865s)
[637.018368] [117/155] (410s left) template (a)
[637.068523] Starting subtest: A
[637.070321] Subtest A: SUCCESS (0.000s)
[637.192867] [118/155] (409s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[638.978410] Starting subtest: cursor-rapid-movement-512x170
[638.980968] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[639.213291] [119/155] (407s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[640.704414] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[640.782924] [120/155] (406s left) kms_psr (pr-sprite-plane-onoff)
[642.275479] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[642.366643] [121/155] (404s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-move)
[643.864515] Starting subtest: psrhdr-1p-primscrn-spr-indfb-move
[643.867567] Subtest psrhdr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[644.055545] [122/155] (403s left) syncobj_timeline (etime-single-wait-submitted)
[644.107106] Starting subtest: etime-single-wait-submitted
[644.213828] Subtest etime-single-wait-submitted: SUCCESS (0.104s)
[644.437301] [123/155] (403s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[645.927680] Starting subtest: addfb25-yf-tiled-legacy
[645.929240] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[646.118134] [124/155] (401s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-render)
[647.616921] Starting subtest: psrhdr-rgb565-draw-render
[647.620100] Subtest psrhdr-rgb565-draw-render: SKIP (0.000s)
[647.801783] [125/155] (400s left) kms_atomic_transition (plane-all-transition-fencing)
[649.293671] Starting subtest: plane-all-transition-fencing
[649.295170] Starting dynamic subtest: pipe-A-HDMI-A-4
[653.200250] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (3.906s)
[653.288611] Starting dynamic subtest: pipe-B-HDMI-A-4
[657.243958] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (3.969s)
[657.297172] Subtest plane-all-transition-fencing: SUCCESS (8.005s)
[657.494032] [126/155] (390s left) device_reset (unbind-cold-reset-rebind)
[657.620569] Starting subtest: unbind-cold-reset-rebind
[657.624042] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[657.735922] [127/155] (390s left) i915_pm_rpm (system-suspend)
[661.273987] Starting subtest: system-suspend
[683.724084] Subtest system-suspend: SUCCESS (11.860s)
[689.682173] [128/155] (363s left) gem_ctx_persistence (engines-persistence)
[689.757386] Starting subtest: engines-persistence
[689.759026] Starting dynamic subtest: rcs0
[690.585935] Dynamic subtest rcs0: SUCCESS (0.827s)
[690.605303] Starting dynamic subtest: bcs0
[691.352920] Dynamic subtest bcs0: SUCCESS (0.764s)
[691.374957] Starting dynamic subtest: vcs0
[692.113857] Dynamic subtest vcs0: SUCCESS (0.758s)
[692.134845] Starting dynamic subtest: vcs1
[692.885173] Dynamic subtest vcs1: SUCCESS (0.768s)
[692.905838] Starting dynamic subtest: vecs0
[693.655197] Dynamic subtest vecs0: SUCCESS (0.764s)
[693.659308] Subtest engines-persistence: SUCCESS (3.901s)
[693.813845] [129/155] (359s left) i915_selftest (mock)
[694.890225] Starting subtest: mock
[694.892174] Starting dynamic subtest: sanitycheck
[695.702860] Dynamic subtest sanitycheck: SUCCESS (0.810s)
[695.746616] Starting dynamic subtest: shmem
[696.476095] Dynamic subtest shmem: SUCCESS (0.765s)
[696.521183] Starting dynamic subtest: fence
[704.767356] Dynamic subtest fence: SUCCESS (8.284s)
[704.795430] Starting dynamic subtest: scatterlist
[706.489114] Dynamic subtest scatterlist: SUCCESS (1.720s)
[706.510357] Starting dynamic subtest: syncmap
[709.178983] Dynamic subtest syncmap: SUCCESS (2.685s)
[709.195852] Starting dynamic subtest: uncore
[709.905042] Dynamic subtest uncore: SUCCESS (0.722s)
[709.938760] Starting dynamic subtest: ring
[710.637841] Dynamic subtest ring: SUCCESS (0.729s)
[710.666982] Starting dynamic subtest: engine
[711.381276] Dynamic subtest engine: SUCCESS (0.740s)
[711.424495] Starting dynamic subtest: timelines
[716.678894] Dynamic subtest timelines: SUCCESS (5.291s)
[716.692953] Starting dynamic subtest: requests
[719.523963] Dynamic subtest requests: SUCCESS (2.843s)
[719.538293] Starting dynamic subtest: objects
[720.426912] Dynamic subtest objects: SUCCESS (0.901s)
[720.441541] Starting dynamic subtest: phys
[721.325859] Dynamic subtest phys: SUCCESS (0.897s)
[721.339831] Starting dynamic subtest: dmabuf
[722.175168] Dynamic subtest dmabuf: SUCCESS (0.845s)
[722.188530] Starting dynamic subtest: vma
[732.538241] Dynamic subtest vma: SUCCESS (10.366s)
[732.554388] Starting dynamic subtest: evict
[734.516582] Dynamic subtest evict: SUCCESS (1.977s)
[734.530615] Starting dynamic subtest: gtt
[738.305701] Dynamic subtest gtt: SUCCESS (3.787s)
[738.320707] Starting dynamic subtest: hugepages
[739.399884] Dynamic subtest hugepages: SUCCESS (1.092s)
[739.413599] Starting dynamic subtest: memory_region
[743.538789] Dynamic subtest memory_region: SUCCESS (4.137s)
[743.540284] Subtest mock: SUCCESS (48.651s)
[743.592823] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[743.593956] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[743.597118] [130/155] (309s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc)
[748.345819] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc
[748.348486] Subtest psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[748.573396] [FACT kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[748.576944] [FACT kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc)] new: kernel.kmod_is_loaded.i915: true
[748.580975] [131/155] (304s left) kms_big_fb (linear-64bpp-rotate-0)
[750.092996] Starting subtest: linear-64bpp-rotate-0
[752.859170] Subtest linear-64bpp-rotate-0: SUCCESS (2.767s)
[753.063775] [132/155] (300s left) kms_flip (flip-vs-wf_vblank-interruptible)
[754.560149] Starting subtest: flip-vs-wf_vblank-interruptible
[754.568837] Starting dynamic subtest: A-HDMI-A4
[755.593237] Dynamic subtest A-HDMI-A4: SUCCESS (1.025s)
[755.611524] Starting dynamic subtest: B-HDMI-A4
[756.555538] Dynamic subtest B-HDMI-A4: SUCCESS (0.959s)
[756.573474] Starting dynamic subtest: C-HDMI-A4
[757.523771] Dynamic subtest C-HDMI-A4: SUCCESS (0.966s)
[757.542113] Starting dynamic subtest: D-HDMI-A4
[758.490521] Dynamic subtest D-HDMI-A4: SUCCESS (0.965s)
[758.491858] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (3.932s)
[758.723802] [133/155] (294s left) gem_create (create-massive)
[758.773000] Starting subtest: create-massive
[758.777107] Subtest create-massive: SUCCESS (0.000s)
[759.042280] [134/155] (294s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-pwrite)
[760.541186] Starting subtest: hdr-rgb101010-draw-pwrite
[760.544026] Subtest hdr-rgb101010-draw-pwrite: SKIP (0.000s)
[760.686282] [135/155] (292s left) gem_exec_params (rs-invalid)
[760.746808] Starting subtest: rs-invalid
[760.750648] Subtest rs-invalid: SUCCESS (0.004s)
[760.944396] [136/155] (292s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[760.995046] Starting subtest: single-wait-for-submit-unsubmitted
[761.097164] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.103s)
[761.257813] [137/155] (292s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-indfb-pgflip-blt)
[762.755977] Starting subtest: fbcpsrhdr-1p-primscrn-indfb-pgflip-blt
[762.758918] Subtest fbcpsrhdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[762.933390] [138/155] (291s left) gem_mmap_gtt (fault-concurrent)
[762.984563] Subtest fault-concurrent: SKIP (0.000s)
[763.065818] [139/155] (291s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[764.605527] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[764.608592] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[764.807350] [140/155] (289s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[766.298084] Starting subtest: short-flip-after-cursor-atomic-transitions
[767.404495] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (1.040s)
[767.704988] [141/155] (286s left) gem_mmap_gtt (medium-copy)
[767.780211] Subtest medium-copy: SKIP (0.000s)
[767.868597] [142/155] (286s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[767.919592] Starting subtest: multi-wait-all-for-submit-available-submitted
[767.921192] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.001s)
[768.044275] [143/155] (286s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[769.542560] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[769.545882] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[769.710526] [144/155] (284s left) kms_joiner (basic-ultra-joiner)
[771.224868] Starting subtest: basic-ultra-joiner
[771.227707] Subtest basic-ultra-joiner: SKIP (0.000s)
[771.355597] [145/155] (283s left) kms_chamelium_color (ctm-red-to-blue)
[772.860551] Subtest ctm-red-to-blue: SKIP (0.000s)
[772.951030] [146/155] (281s left) kms_frontbuffer_tracking (fbchdr-modesetfrombusy)
[774.449237] Starting subtest: fbchdr-modesetfrombusy
[774.452175] Subtest fbchdr-modesetfrombusy: SKIP (0.000s)
[774.646372] [147/155] (280s left) api_intel_allocator (reloc-allocator)
[774.697684] Starting subtest: reloc-allocator
[774.699178] Starting dynamic subtest: basic
[774.714511] Dynamic subtest basic: SUCCESS (0.018s)
[774.730356] Starting dynamic subtest: parallel-one
[774.731801] Dynamic subtest parallel-one: SUCCESS (0.005s)
[774.747878] Starting dynamic subtest: print
[774.749466] Dynamic subtest print: SUCCESS (0.000s)
[774.764905] Starting dynamic subtest: reuse
[774.766623] Dynamic subtest reuse: SUCCESS (0.000s)
[774.781406] Starting dynamic subtest: fork-reopen-allocator
[774.782886] Dynamic subtest fork-reopen-allocator: SUCCESS (0.016s)
[774.784423] Subtest reloc-allocator: SUCCESS (0.047s)
[774.925091] [148/155] (280s left) gem_mmap_wc (write)
[774.977294] Subtest write: SKIP (0.000s)
[775.051348] [149/155] (280s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[776.549545] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc
[776.552583] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[776.745029] [150/155] (278s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[778.233786] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[778.235181] Starting dynamic subtest: pipe-A-valid-mode
[779.074487] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.837s)
[779.076609] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (0.840s)
[779.278353] [151/155] (276s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[780.769324] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs
[780.771089] Starting dynamic subtest: pipe-A-HDMI-A-4
[780.785637] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[780.801249] Starting dynamic subtest: pipe-B-HDMI-A-4
[780.814727] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[780.829574] Starting dynamic subtest: pipe-C-HDMI-A-4
[780.843188] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[780.858206] Starting dynamic subtest: pipe-D-HDMI-A-4
[780.873926] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[780.876824] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.010s)
[781.049744] [152/155] (274s left) gem_mmap_gtt (zero-extend)
[781.100406] Subtest zero-extend: SKIP (0.000s)
[781.176452] [153/155] (274s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[782.673883] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[782.676679] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[782.865262] [154/155] (272s left) perf_pmu (rc6)
[782.938322] Starting subtest: rc6
[782.940056] Starting dynamic subtest: gt0
[789.284254] Dynamic subtest gt0: SUCCESS (6.341s)
[789.299894] Starting dynamic subtest: runtime-pm-gt0
[796.904663] Dynamic subtest runtime-pm-gt0: SUCCESS (7.615s)
[796.920046] Starting dynamic subtest: runtime-pm-long-gt0
[809.465300] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.560s)
[809.481688] Starting dynamic subtest: other-idle-gt0
[809.485015] Dynamic subtest other-idle-gt0: SKIP (0.000s)
[809.486801] Subtest rc6: SUCCESS (26.524s)
[810.549597] [155/155] (245s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[812.049937] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-mmap-cpu
[812.053304] Subtest fbchdr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[812.154797] 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_exec_alignment
results: parsing output: 95/ for test: gem_render_copy
results: parsing output: 96/ for test: kms_cursor_crc
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: api_intel_bb
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: gem_mmap
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: kms_frontbuffer_tracking
results: parsing output: 106/ for test: perf_pmu
results: parsing output: 107/ for test: kms_plane_scaling
results: parsing output: 108/ for test: kms_cursor_legacy
results: parsing output: 109/ for test: kms_addfb_basic
results: parsing output: 110/ for test: syncobj_wait
results: parsing output: 111/ for test: kms_psr2_sf
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_ccs
results: parsing output: 115/ for test: gem_render_copy_redux
results: parsing output: 116/ for test: template
results: parsing output: 117/ for test: kms_cursor_crc
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: kms_addfb_basic
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_atomic_transition
results: parsing output: 125/ for test: device_reset
results: parsing output: 126/ for test: i915_pm_rpm
results: parsing output: 127/ for test: gem_ctx_persistence
results: parsing output: 128/ for test: i915_selftest
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_big_fb
results: parsing output: 131/ for test: kms_flip
results: parsing output: 132/ for test: gem_create
results: parsing output: 133/ for test: kms_frontbuffer_tracking
results: parsing output: 134/ for test: gem_exec_params
results: parsing output: 135/ for test: syncobj_wait
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: gem_mmap_gtt
results: parsing output: 138/ for test: kms_frontbuffer_tracking
results: parsing output: 139/ for test: kms_cursor_legacy
results: parsing output: 140/ for test: gem_mmap_gtt
results: parsing output: 141/ for test: syncobj_timeline
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: kms_joiner
results: parsing output: 144/ for test: kms_chamelium_color
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: api_intel_allocator
results: parsing output: 147/ for test: gem_mmap_wc
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: kms_flip_scaled_crc
results: parsing output: 150/ for test: kms_ccs
results: parsing output: 151/ for test: gem_mmap_gtt
results: parsing output: 152/ for test: kms_frontbuffer_tracking
results: parsing output: 153/ for test: perf_pmu
results: parsing output: 154/ for test: kms_frontbuffer_tracking
Done.