[68.117028] Initializing watchdogs
[68.117103]   /dev/watchdog0
[68.138682] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[68.149752] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[68.153716] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[68.156228] [001/156] (960s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[69.735254] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[69.862138] [002/156] (958s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[71.397590] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[71.399342] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[71.524685] [003/156] (957s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[73.064457] Starting subtest: short-busy-flip-before-cursor-toggle
[73.066251] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[73.163587] [004/156] (955s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[74.703086] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[74.704978] Subtest hdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[74.921441] [005/156] (954s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[76.438983] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[76.453047] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.013s)
[76.545663] [006/156] (952s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[78.075814] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu
[78.077472] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[78.188304] [007/156] (950s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[79.726215] Starting subtest: fbc-farfromfence-mmap-gtt
[79.728046] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[79.841445] [008/156] (949s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[81.379912] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[81.381621] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[81.491422] [009/156] (947s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[83.032415] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[83.034129] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[83.166963] [010/156] (946s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-pwrite)
[84.706698] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-pwrite
[84.708380] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[84.939523] [011/156] (944s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[86.459929] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[86.462188] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[86.584739] [012/156] (942s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[88.141496] Starting subtest: x-tiled-16bpp-rotate-90
[88.204062] Subtest x-tiled-16bpp-rotate-90: SKIP (0.062s)
[88.390485] [013/156] (941s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[89.897231] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[89.898156] Starting dynamic subtest: pipe-A
[90.520395] Dynamic subtest pipe-A: SUCCESS (0.623s)
[90.532054] Starting dynamic subtest: pipe-B
[91.096444] Dynamic subtest pipe-B: SUCCESS (0.575s)
[91.118046] Starting dynamic subtest: pipe-C
[91.688710] Dynamic subtest pipe-C: SUCCESS (0.592s)
[91.706072] Starting dynamic subtest: pipe-D
[92.280268] Dynamic subtest pipe-D: SUCCESS (0.591s)
[92.281448] Subtest plane-downscale-factor-0-5-with-modifiers: SUCCESS (2.382s)
[92.550703] [014/156] (937s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[94.059185] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[94.060095] Starting dynamic subtest: pipe-A-HDMI-A-3
[94.068947] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s)
[94.077504] Starting dynamic subtest: pipe-B-HDMI-A-3
[94.086549] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s)
[94.094971] Starting dynamic subtest: pipe-C-HDMI-A-3
[94.103678] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s)
[94.112187] Starting dynamic subtest: pipe-D-HDMI-A-3
[94.122229] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s)
[94.123990] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SKIP (0.006s)
[94.378458] [015/156] (935s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-mmap-wc)
[95.889919] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-mmap-wc
[95.891594] Subtest hdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[96.026619] [016/156] (933s left) gem_create (create-ext-set-pat)
[96.244028] Starting subtest: create-ext-set-pat
[96.246420] Subtest create-ext-set-pat: SKIP (0.000s)
[96.368286] [017/156] (933s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[96.438317] Starting subtest: etime-single-wait-for-submit-unsubmitted
[96.539490] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.101s)
[96.682966] [018/156] (933s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-mmap-cpu)
[98.198473] Starting subtest: fbcpsrhdr-rgb565-draw-mmap-cpu
[98.200131] Subtest fbcpsrhdr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[98.418280] [019/156] (931s left) gem_ctx_param (set-priority-invalid-size)
[98.500409] Starting subtest: set-priority-invalid-size
[98.501367] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[98.611739] [020/156] (931s left) kms_psr (psr2-primary-render)
[100.122435] Subtest psr2-primary-render: SKIP (0.000s)
[100.181402] [021/156] (930s left) gem_userptr_blits (create-destroy-sync)
[100.276506] Starting subtest: create-destroy-sync
[105.291539] Subtest create-destroy-sync: SUCCESS (5.014s)
[105.423993] [022/156] (924s left) i915_query (query-garbage)
[105.497011] Starting subtest: query-garbage
[105.498182] Subtest query-garbage: SUCCESS (0.000s)
[105.609549] [023/156] (924s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[105.686961] Starting subtest: y-tiled-to-vebox-x-tiled
[105.689410] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[105.931778] [024/156] (924s left) gem_exec_reloc (basic-gtt-wc)
[106.012056] Subtest basic-gtt-wc: SKIP (0.000s)
[106.104039] [025/156] (924s left) i915_pm_rpm (gem-pread)
[110.077361] Starting subtest: gem-pread
[111.357975] Subtest gem-pread: SUCCESS (1.280s)
[112.261308] [026/156] (918s left) kms_psr (psr2-basic)
[113.798073] Subtest psr2-basic: SKIP (0.000s)
[113.857033] [027/156] (916s left) gem_tiled_partial_pwrite_pread (reads)
[113.934905] Subtest reads: SKIP (0.000s)
[114.012404] [028/156] (916s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[114.083114] Starting subtest: single-wait-for-submit-available-submitted
[114.084075] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s)
[114.277127] [029/156] (916s left) syncobj_wait (multi-wait-submitted)
[114.349297] Starting subtest: multi-wait-submitted
[114.451649] Subtest multi-wait-submitted: SUCCESS (0.102s)
[114.563651] [030/156] (916s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-pwrite)
[116.074297] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-pwrite
[116.076042] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[116.198249] [031/156] (914s left) gem_exec_parallel (basic)
[116.310260] Starting subtest: basic
[116.311226] Starting dynamic subtest: rcs0
[117.870418] Dynamic subtest rcs0: SUCCESS (1.560s)
[117.880449] Starting dynamic subtest: bcs0
[119.346431] Dynamic subtest bcs0: SUCCESS (1.475s)
[119.356462] Starting dynamic subtest: vcs0
[120.823183] Dynamic subtest vcs0: SUCCESS (1.476s)
[120.832839] Starting dynamic subtest: vcs1
[122.306989] Dynamic subtest vcs1: SUCCESS (1.483s)
[122.315876] Starting dynamic subtest: vecs0
[123.751832] Dynamic subtest vecs0: SUCCESS (1.444s)
[123.762692] Starting dynamic subtest: vecs1
[125.268867] Dynamic subtest vecs1: SUCCESS (1.516s)
[125.278800] Starting dynamic subtest: ccs0
[126.752364] Dynamic subtest ccs0: SUCCESS (1.483s)
[126.753545] Subtest basic: SUCCESS (10.441s)
[127.063474] [032/156] (903s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[128.577994] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[128.579879] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[128.701073] [033/156] (902s left) syncobj_wait (single-wait-for-submit-submitted)
[128.802271] Starting subtest: single-wait-for-submit-submitted
[128.908445] Subtest single-wait-for-submit-submitted: SUCCESS (0.105s)
[129.048737] [034/156] (901s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[130.560567] Starting subtest: fbcpsr-rgb565-draw-blt
[130.562220] Subtest fbcpsr-rgb565-draw-blt: SKIP (0.000s)
[130.712347] [035/156] (900s left) perf_pmu (busy-accuracy-98)
[130.807543] Starting subtest: busy-accuracy-98
[130.808492] Starting dynamic subtest: rcs0
[133.864608] Dynamic subtest rcs0: SUCCESS (3.056s)
[133.875256] Starting dynamic subtest: bcs0
[136.921550] Dynamic subtest bcs0: SUCCESS (3.056s)
[136.932846] Starting dynamic subtest: vcs0
[139.981203] Dynamic subtest vcs0: SUCCESS (3.059s)
[139.991355] Starting dynamic subtest: vcs1
[143.037430] Dynamic subtest vcs1: SUCCESS (3.056s)
[143.047362] Starting dynamic subtest: vecs0
[146.096210] Dynamic subtest vecs0: SUCCESS (3.059s)
[146.106190] Starting dynamic subtest: vecs1
[149.154892] Dynamic subtest vecs1: SUCCESS (3.059s)
[149.165126] Starting dynamic subtest: ccs0
[152.214492] Dynamic subtest ccs0: SUCCESS (3.060s)
[152.215421] Subtest busy-accuracy-98: SUCCESS (21.406s)
[152.406608] [036/156] (878s left) kms_dsc (dsc-fractional-bpp-with-bpc)
[153.921136] Starting subtest: dsc-fractional-bpp-with-bpc
[153.934145] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.001s)
[154.022524] [037/156] (877s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[155.564179] Starting subtest: cursorB-vs-flipB-toggle
[155.567227] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[155.713371] [038/156] (875s left) syncobj_wait (wait-all-delayed-signal)
[155.819411] Starting subtest: wait-all-delayed-signal
[155.921579] Subtest wait-all-delayed-signal: SUCCESS (0.101s)
[156.077533] [039/156] (875s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[157.585872] Starting subtest: psr-rgb565-draw-mmap-wc
[157.587502] Subtest psr-rgb565-draw-mmap-wc: SKIP (0.000s)
[157.811384] [040/156] (873s left) gem_wait (busy)
[157.904239] Starting subtest: busy
[157.905242] Starting dynamic subtest: all-engines
[158.480549] Dynamic subtest all-engines: SUCCESS (0.576s)
[158.490668] Starting dynamic subtest: rcs0
[159.020165] Dynamic subtest rcs0: SUCCESS (0.539s)
[159.030168] Starting dynamic subtest: bcs0
[159.558202] Dynamic subtest bcs0: SUCCESS (0.538s)
[159.568165] Starting dynamic subtest: vcs0
[160.096128] Dynamic subtest vcs0: SUCCESS (0.538s)
[160.106107] Starting dynamic subtest: vcs1
[160.634477] Dynamic subtest vcs1: SUCCESS (0.538s)
[160.644477] Starting dynamic subtest: vecs0
[161.171984] Dynamic subtest vecs0: SUCCESS (0.537s)
[161.181692] Starting dynamic subtest: vecs1
[161.710020] Dynamic subtest vecs1: SUCCESS (0.538s)
[161.719808] Starting dynamic subtest: ccs0
[162.248286] Dynamic subtest ccs0: SUCCESS (0.538s)
[162.249230] Subtest busy: SUCCESS (4.344s)
[162.497603] [041/156] (869s left) gem_close_race (basic-threads)
[162.609166] Starting subtest: basic-threads
[163.818597] Subtest basic-threads: SUCCESS (1.209s)
[164.146381] [042/156] (867s left) kms_lease (possible-crtcs-filtering)
[165.653338] Starting subtest: possible-crtcs-filtering
[165.661992] Subtest possible-crtcs-filtering: SUCCESS (0.009s)
[165.784739] [043/156] (865s left) prime_busy (hang)
[165.883058] Starting subtest: hang
[165.886158] Starting dynamic subtest: rcs0
[192.498513] Dynamic subtest rcs0: SUCCESS (26.613s)
[192.508828] Starting dynamic subtest: bcs0
[199.640144] Dynamic subtest bcs0: SUCCESS (7.141s)
[199.650316] Starting dynamic subtest: vcs0
[206.618822] Dynamic subtest vcs0: SUCCESS (6.978s)
[206.628755] Starting dynamic subtest: vcs1
[213.592361] Dynamic subtest vcs1: SUCCESS (6.972s)
[213.602231] Starting dynamic subtest: vecs0
[220.635126] Dynamic subtest vecs0: SUCCESS (7.043s)
[220.645266] Starting dynamic subtest: vecs1
[227.612583] Dynamic subtest vecs1: SUCCESS (6.976s)
[227.622629] Starting dynamic subtest: ccs0
[241.510454] Dynamic subtest ccs0: SUCCESS (13.897s)
[241.511422] Subtest hang: SUCCESS (75.625s)
[241.647775] [044/156] (790s left) kms_getfb (getfb2-handle-zero)
[243.155179] Starting subtest: getfb2-handle-zero
[243.156105] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[243.338640] [045/156] (788s left) gem_close (basic)
[243.459657] Starting subtest: basic
[243.460702] Subtest basic: SUCCESS (0.000s)
[243.649938] [046/156] (788s left) gem_ccs (ctrl-surf-copy)
[243.728626] Starting subtest: ctrl-surf-copy
[243.729548] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0
[243.784950] Dynamic subtest linear-compressed-compfmt0-smem-lmem0: SUCCESS (0.055s)
[243.794913] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0
[243.972235] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.187s)
[243.982535] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0
[243.999076] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0: SUCCESS (0.026s)
[244.009197] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0
[244.181048] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.181s)
[244.191142] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0
[244.209365] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0: SUCCESS (0.028s)
[244.219498] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0
[244.403131] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.193s)
[244.413186] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0
[244.430964] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0: SUCCESS (0.027s)
[244.441071] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0
[244.634906] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.203s)
[244.636334] Subtest ctrl-surf-copy: SUCCESS (0.906s)
[244.853606] [047/156] (787s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[246.367283] Starting subtest: fbc-indfb-scaledprimary
[247.708101] Subtest fbc-indfb-scaledprimary: SUCCESS (1.341s)
[247.975053] [048/156] (784s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[249.478487] Starting subtest: crc-primary-suspend-y-tiled-ccs
[249.479458] Starting dynamic subtest: pipe-A-HDMI-A-3
[249.483035] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[249.493481] Starting dynamic subtest: pipe-B-HDMI-A-3
[249.497166] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[249.507527] Starting dynamic subtest: pipe-C-HDMI-A-3
[249.511210] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[249.521192] Starting dynamic subtest: pipe-D-HDMI-A-3
[249.524926] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[249.526676] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.005s)
[249.812200] [049/156] (782s left) gem_userptr_blits (readonly-pwrite-unsync)
[249.895179] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[250.090519] [050/156] (782s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-move)
[251.602574] Starting subtest: fbchdr-1p-primscrn-spr-indfb-move
[251.604246] Subtest fbchdr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[251.774175] [051/156] (780s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[253.311275] Starting subtest: 4-tiled-64bpp-rotate-0
[255.193755] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.881s)
[255.410369] [052/156] (777s left) kms_cursor_crc (cursor-random-512x512)
[257.195020] Starting subtest: cursor-random-512x512
[257.196839] Subtest cursor-random-512x512: SKIP (0.001s)
[257.420771] [053/156] (775s left) core_getclient (basic)
[257.493261] Starting subtest: basic
[257.494215] Subtest basic: SUCCESS (0.000s)
[257.647838] [054/156] (775s left) gem_mmap_gtt (fault-concurrent)
[257.724216] Subtest fault-concurrent: SKIP (0.000s)
[257.807196] [055/156] (774s left) kms_flip (flip-vs-absolute-wf_vblank)
[259.316124] Starting subtest: flip-vs-absolute-wf_vblank
[259.320877] Starting dynamic subtest: A-HDMI-A3
[267.377467] Dynamic subtest A-HDMI-A3: SUCCESS (8.056s)
[267.389818] Starting dynamic subtest: B-HDMI-A3
[275.362693] Dynamic subtest B-HDMI-A3: SUCCESS (7.984s)
[275.374126] Starting dynamic subtest: C-HDMI-A3
[283.347432] Dynamic subtest C-HDMI-A3: SUCCESS (7.984s)
[283.358373] Starting dynamic subtest: D-HDMI-A3
[291.330466] Dynamic subtest D-HDMI-A3: SUCCESS (7.982s)
[291.331410] Subtest flip-vs-absolute-wf_vblank: SUCCESS (32.016s)
[291.542980] [056/156] (741s left) kms_flip (flip-vs-panning-vs-hang)
[293.050450] Starting subtest: flip-vs-panning-vs-hang
[293.052546] Starting dynamic subtest: A-HDMI-A3
[345.526621] Dynamic subtest A-HDMI-A3: SUCCESS (52.474s)
[345.537076] Starting dynamic subtest: D-HDMI-A3
[395.513943] Dynamic subtest D-HDMI-A3: SUCCESS (49.985s)
[395.514967] Subtest flip-vs-panning-vs-hang: SUCCESS (102.463s)
[395.774249] [057/156] (637s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[397.280183] Starting subtest: primary-x-tiled-reflect-x-0
[407.682311] Subtest primary-x-tiled-reflect-x-0: SUCCESS (10.401s)
[408.006783] [058/156] (624s left) gem_mmap_gtt (fault-concurrent-y)
[408.084121] Subtest fault-concurrent-Y: SKIP (0.000s)
[408.152223] [059/156] (624s left) gem_huc_copy (huc-copy)
[408.257326] Starting subtest: huc-copy
[408.262845] Subtest huc-copy: SUCCESS (0.006s)
[408.421780] [060/156] (624s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[409.943316] Starting subtest: y-tiled-8bpp-rotate-90
[409.945122] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[410.069293] [061/156] (623s left) kms_psr (pr-cursor-mmap-cpu)
[411.598467] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[411.663213] [062/156] (621s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-move)
[413.174272] Starting subtest: psrhdr-1p-primscrn-cur-indfb-move
[413.176144] Subtest psrhdr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[413.316958] [063/156] (619s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-fullscreen)
[414.864267] Starting subtest: psrhdr-2p-primscrn-spr-indfb-fullscreen
[414.866034] Subtest psrhdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[414.991695] [064/156] (618s left) kms_psr (fbc-pr-cursor-plane-onoff)
[416.524943] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[416.580450] [065/156] (616s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[418.094890] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[418.096580] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[418.325407] [066/156] (615s left) i915_drm_fdinfo (basics)
[418.394294] Starting subtest: basics
[418.395239] Subtest basics: SUCCESS (0.000s)
[418.497360] [067/156] (615s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-msflip-blt)
[420.005328] Starting subtest: psrhdr-2p-scndscrn-shrfb-msflip-blt
[420.007149] Subtest psrhdr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[420.147569] [068/156] (613s left) gem_mmap_gtt (basic-wc)
[420.248147] Subtest basic-wc: SKIP (0.000s)
[420.318819] [069/156] (613s left) kms_big_fb (linear-16bpp-rotate-0)
[421.839278] Starting subtest: linear-16bpp-rotate-0
[423.757106] Subtest linear-16bpp-rotate-0: SUCCESS (1.917s)
[423.971829] [070/156] (609s left) gem_ctx_persistence (engines-queued)
[424.050394] Starting subtest: engines-queued
[424.051495] Starting dynamic subtest: rcs0
[424.144185] Dynamic subtest rcs0: SUCCESS (0.094s)
[424.154325] Starting dynamic subtest: bcs0
[424.166258] Dynamic subtest bcs0: SUCCESS (0.022s)
[424.176425] Starting dynamic subtest: vcs0
[424.221529] Dynamic subtest vcs0: SUCCESS (0.055s)
[424.233251] Starting dynamic subtest: vcs1
[424.271227] Dynamic subtest vcs1: SUCCESS (0.049s)
[424.283867] Starting dynamic subtest: vecs0
[424.313299] Dynamic subtest vecs0: SUCCESS (0.041s)
[424.325808] Starting dynamic subtest: vecs1
[424.381355] Dynamic subtest vecs1: SUCCESS (0.067s)
[424.398069] Starting dynamic subtest: ccs0
[424.559729] Dynamic subtest ccs0: SUCCESS (0.178s)
[424.560899] Subtest engines-queued: SUCCESS (0.510s)
[424.686801] [071/156] (609s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-render)
[426.198072] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-render
[426.199921] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[426.322574] [072/156] (607s left) gem_spin_batch (resubmit-all)
[426.426751] Starting subtest: resubmit-all
[426.427671] Starting dynamic subtest: rcs0
[426.464103] Dynamic subtest rcs0: SUCCESS (0.037s)
[426.474932] Starting dynamic subtest: bcs0
[426.476196] Dynamic subtest bcs0: SUCCESS (0.002s)
[426.486949] Starting dynamic subtest: vcs0
[426.488176] Dynamic subtest vcs0: SUCCESS (0.003s)
[426.498807] Starting dynamic subtest: vcs1
[426.500066] Dynamic subtest vcs1: SUCCESS (0.003s)
[426.510205] Starting dynamic subtest: vecs0
[426.511349] Dynamic subtest vecs0: SUCCESS (0.003s)
[426.521432] Starting dynamic subtest: vecs1
[426.522554] Dynamic subtest vecs1: SUCCESS (0.002s)
[426.532563] Starting dynamic subtest: ccs0
[426.533701] Dynamic subtest ccs0: SUCCESS (0.002s)
[426.534783] Subtest resubmit-all: SUCCESS (0.056s)
[426.773810] [073/156] (607s left) kms_cursor_crc (cursor-offscreen-128x42)
[428.485513] Starting subtest: cursor-offscreen-128x42
[428.489715] Starting dynamic subtest: pipe-A-HDMI-A-3
[431.016471] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.526s)
[431.059620] Starting dynamic subtest: pipe-D-HDMI-A-3
[433.448456] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.399s)
[433.449435] Subtest cursor-offscreen-128x42: SUCCESS (4.962s)
[433.791982] [074/156] (600s left) perf_pmu (idle-no-semaphores)
[433.860369] Starting subtest: idle-no-semaphores
[433.861363] Starting dynamic subtest: rcs0
[434.434412] Dynamic subtest rcs0: SUCCESS (0.572s)
[434.448644] Starting dynamic subtest: bcs0
[434.952561] Dynamic subtest bcs0: SUCCESS (0.515s)
[434.966663] Starting dynamic subtest: vcs0
[435.470529] Dynamic subtest vcs0: SUCCESS (0.515s)
[435.484495] Starting dynamic subtest: vcs1
[435.987581] Dynamic subtest vcs1: SUCCESS (0.514s)
[436.001780] Starting dynamic subtest: vecs0
[436.505564] Dynamic subtest vecs0: SUCCESS (0.515s)
[436.519493] Starting dynamic subtest: vecs1
[437.019495] Dynamic subtest vecs1: SUCCESS (0.510s)
[437.033531] Starting dynamic subtest: ccs0
[437.536548] Dynamic subtest ccs0: SUCCESS (0.514s)
[437.538599] Subtest idle-no-semaphores: SUCCESS (3.676s)
[437.721567] [075/156] (596s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[439.230239] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt
[439.231980] Subtest psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[439.370545] [076/156] (594s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[440.902786] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[440.904584] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.000s)
[440.993566] [077/156] (593s left) kms_chamelium_hpd (dp-hpd-storm)
[442.569390] Subtest dp-hpd-storm: SKIP (0.000s)
[442.736252] [078/156] (591s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[444.251285] Starting subtest: 2x-long-flip-vs-cursor-legacy
[444.254332] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.002s)
[444.361527] [079/156] (590s left) kms_properties (colorop-properties-legacy)
[445.897777] Starting subtest: colorop-properties-legacy
[445.898639] Starting dynamic subtest: pipe-A-HDMI-A-3
[446.010131] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.112s)
[446.023941] Starting dynamic subtest: pipe-B-HDMI-A-3
[446.161451] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.150s)
[446.173410] Starting dynamic subtest: pipe-C-HDMI-A-3
[446.293973] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.131s)
[446.306749] Starting dynamic subtest: pipe-D-HDMI-A-3
[446.428621] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.133s)
[446.429723] Subtest colorop-properties-legacy: SUCCESS (0.532s)
[446.649531] [080/156] (587s left) gem_mmap_offset (partial-remap)
[446.726319] Starting subtest: partial-remap
[446.727244] Starting dynamic subtest: lmem0
[446.729711] Dynamic subtest lmem0: SUCCESS (0.003s)
[446.740628] Starting dynamic subtest: smem0
[446.742889] Dynamic subtest smem0: SUCCESS (0.004s)
[446.743842] Subtest partial-remap: SUCCESS (0.009s)
[446.905654] [081/156] (587s left) gem_exec_fence (concurrent)
[447.108898] Starting subtest: concurrent
[447.111384] Subtest concurrent: SKIP (0.000s)
[447.938584] [FACT gem_exec_fence (concurrent)] new: kernel.kmod_is_loaded.vgem: true
[447.940706] [082/156] (586s left) sysfs_timeslice_duration (invalid)
[448.027078] Starting subtest: invalid
[448.028041] Starting dynamic subtest: vecs0
[448.029012] Dynamic subtest vecs0: SUCCESS (0.000s)
[448.040409] Starting dynamic subtest: ccs0
[448.041726] Dynamic subtest ccs0: SUCCESS (0.001s)
[448.052804] Starting dynamic subtest: vcs0
[448.054128] Dynamic subtest vcs0: SUCCESS (0.000s)
[448.065030] Starting dynamic subtest: bcs0
[448.066154] Dynamic subtest bcs0: SUCCESS (0.000s)
[448.077534] Starting dynamic subtest: vecs1
[448.078452] Dynamic subtest vecs1: SUCCESS (0.000s)
[448.089057] Starting dynamic subtest: rcs0
[448.090370] Dynamic subtest rcs0: SUCCESS (0.000s)
[448.100930] Starting dynamic subtest: vcs1
[448.102241] Dynamic subtest vcs1: SUCCESS (0.000s)
[448.103538] Subtest invalid: SUCCESS (0.008s)
[448.151701] [083/156] (586s left) gem_exec_fence (nb-await)
[448.356442] Starting subtest: nb-await
[448.357430] Starting dynamic subtest: rcs0
[448.454197] Dynamic subtest rcs0: SUCCESS (0.097s)
[448.468059] Starting dynamic subtest: bcs0
[448.519277] Dynamic subtest bcs0: SUCCESS (0.064s)
[448.550949] Starting dynamic subtest: vcs0
[448.599761] Dynamic subtest vcs0: SUCCESS (0.079s)
[448.631497] Starting dynamic subtest: vcs1
[448.681646] Dynamic subtest vcs1: SUCCESS (0.080s)
[448.717309] Starting dynamic subtest: vecs0
[448.769436] Dynamic subtest vecs0: SUCCESS (0.086s)
[448.785069] Starting dynamic subtest: vecs1
[448.835519] Dynamic subtest vecs1: SUCCESS (0.064s)
[448.852255] Starting dynamic subtest: ccs0
[448.905300] Dynamic subtest ccs0: SUCCESS (0.068s)
[448.907338] Subtest nb-await: SUCCESS (0.550s)
[449.662254] [084/156] (585s left) syncobj_wait (wait-any-complex)
[449.741376] Starting subtest: wait-any-complex
[449.804299] Subtest wait-any-complex: SUCCESS (0.062s)
[450.023622] [085/156] (584s left) kms_vblank (query-idle)
[451.538401] Starting subtest: query-idle
[451.539286] Starting dynamic subtest: pipe-A-HDMI-A-3
[453.817425] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.277s)
[453.830365] Starting dynamic subtest: pipe-D-HDMI-A-3
[456.002270] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.182s)
[456.003352] Subtest query-idle: SUCCESS (4.464s)
[456.191056] [086/156] (578s left) kms_busy (extended-modeset-hang-newfb)
[457.715480] Starting subtest: extended-modeset-hang-newfb
[457.717947] Starting dynamic subtest: pipe-A
[473.309260] Dynamic subtest pipe-A: SUCCESS (15.592s)
[473.322391] Starting dynamic subtest: pipe-D
[488.891883] Dynamic subtest pipe-D: SUCCESS (15.578s)
[488.892894] Subtest extended-modeset-hang-newfb: SUCCESS (31.175s)
[489.135128] [087/156] (545s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[490.652987] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[490.654985] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[490.797595] [088/156] (544s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[492.348048] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-mmap-gtt
[492.349949] Subtest hdr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[492.498333] [089/156] (542s left) kms_vblank (ts-continuation-dpms-rpm)
[494.018763] Starting subtest: ts-continuation-dpms-rpm
[494.019618] Starting dynamic subtest: pipe-A-HDMI-A-3
[496.374483] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.355s)
[496.388511] Starting dynamic subtest: pipe-D-HDMI-A-3
[497.703156] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (1.325s)
[497.704257] Subtest ts-continuation-dpms-rpm: SUCCESS (3.685s)
[497.940803] [090/156] (537s left) kms_addfb_basic (addfb25-4-tiled)
[499.460012] Starting subtest: addfb25-4-tiled
[499.460970] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[499.604688] [091/156] (535s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[501.150198] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[501.151994] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[501.325326] [092/156] (534s left) i915_query (query-regions-unallocated)
[501.421499] Starting subtest: query-regions-unallocated
[502.559948] Subtest query-regions-unallocated: SUCCESS (1.138s)
[502.658700] [093/156] (532s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[502.738789] Starting subtest: multi-wait-all-available-submitted-signaled
[502.739726] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.001s)
[502.881887] [094/156] (532s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-render)
[504.402049] Starting subtest: fbchdr-rgb101010-draw-render
[504.403915] Subtest fbchdr-rgb101010-draw-render: SKIP (0.000s)
[504.546040] [095/156] (531s left) dmabuf_sync_file (export-multiwait)
[504.629771] Starting subtest: export-multiwait
[504.630727] Subtest export-multiwait: SUCCESS (0.000s)
[504.712675] [096/156] (531s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[506.239177] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[507.512679] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.275s)
[507.673329] [097/156] (528s left) kms_atomic (plane-primary-legacy)
[509.194997] Starting subtest: plane-primary-legacy
[509.195959] Starting dynamic subtest: pipe-A-HDMI-A-3
[510.119454] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.924s)
[510.120394] Subtest plane-primary-legacy: SUCCESS (0.926s)
[510.347147] [098/156] (525s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[511.861946] Starting subtest: read-crc-frame-sequence
[511.862941] Starting dynamic subtest: pipe-A-HDMI-A-3
[512.506558] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.644s)
[512.519572] Starting dynamic subtest: pipe-B-HDMI-A-3
[513.001203] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.493s)
[513.014125] Starting dynamic subtest: pipe-C-HDMI-A-3
[513.535211] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.532s)
[513.548077] Starting dynamic subtest: pipe-D-HDMI-A-3
[514.005084] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.468s)
[514.006062] Subtest read-crc-frame-sequence: SUCCESS (2.144s)
[514.277449] [099/156] (521s left) kms_pm_rpm (dpms-non-lpsp)
[518.020961] Starting subtest: dpms-non-lpsp
[518.175218] Subtest dpms-non-lpsp: SUCCESS (0.155s)
[519.028959] [100/156] (517s left) kms_chamelium_audio (dp-audio)
[520.615471] Subtest dp-audio: SKIP (0.000s)
[520.757905] [101/156] (515s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[520.852440] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[520.853439] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[521.013843] [102/156] (515s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[522.539088] Starting subtest: fbc-rgb565-draw-mmap-wc
[522.540968] Subtest fbc-rgb565-draw-mmap-wc: SKIP (0.000s)
[522.682776] [103/156] (513s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[524.236341] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[524.238247] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[524.374641] [104/156] (512s left) gem_wait (invalid-flags)
[524.481307] Starting subtest: invalid-flags
[524.482261] Subtest invalid-flags: SUCCESS (0.000s)
[524.785571] [105/156] (511s left) gem_pxp (hw-rejects-pxp-context)
[527.401433] Starting subtest: hw-rejects-pxp-context
[527.402355] Subtest hw-rejects-pxp-context: SUCCESS (0.004s)
[527.577268] [106/156] (508s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[529.098984] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[529.100840] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[529.263869] [107/156] (507s left) kms_content_protection (atomic-dpms)
[530.866286] Starting subtest: atomic-dpms
[530.870466] Subtest atomic-dpms: SKIP (0.002s)
[531.059789] [108/156] (505s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-blt)
[532.581868] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-blt
[532.583489] Subtest fbchdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[532.741531] [109/156] (504s left) kms_prop_blob (blob-prop-lifetime)
[532.851485] Starting subtest: blob-prop-lifetime
[532.867355] Subtest blob-prop-lifetime: SUCCESS (0.017s)
[533.022859] [110/156] (503s left) gem_exec_schedule (u-semaphore-user)
[533.119225] Starting subtest: u-semaphore-user
[533.203112] Subtest u-semaphore-user: SUCCESS (0.084s)
[533.658421] [111/156] (503s left) gem_exec_balancer (indices)
[533.759918] Starting subtest: indices
[535.450509] Subtest indices: SUCCESS (1.691s)
[535.839314] [112/156] (501s left) gem_exec_params (rel-constants-invalid-ring)
[535.929271] Starting subtest: rel-constants-invalid-ring
[535.930252] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[536.056933] [113/156] (501s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-indfb-msflip-blt)
[537.574240] Starting subtest: fbcpsrhdr-2p-primscrn-indfb-msflip-blt
[537.576139] Subtest fbcpsrhdr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[537.712959] [114/156] (499s left) gem_exec_alignment (single)
[537.827369] Starting subtest: single
[537.832488] Subtest single: SUCCESS (0.005s)
[537.974438] [115/156] (499s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[538.065289] Starting subtest: legacy-engines-hostile-preempt
[538.066260] Starting dynamic subtest: render
[538.167383] Dynamic subtest render: SUCCESS (0.101s)
[538.185765] Starting dynamic subtest: bsd1
[538.212560] Dynamic subtest bsd1: SUCCESS (0.043s)
[538.228594] Starting dynamic subtest: bsd2
[538.239363] Dynamic subtest bsd2: SUCCESS (0.024s)
[538.252180] Starting dynamic subtest: blt
[538.308549] Dynamic subtest blt: SUCCESS (0.068s)
[538.338160] Starting dynamic subtest: vebox
[538.364806] Dynamic subtest vebox: SUCCESS (0.054s)
[538.366214] Subtest legacy-engines-hostile-preempt: SUCCESS (0.301s)
[538.514422] [116/156] (498s left) syncobj_timeline (signal-point-0)
[538.596491] Starting subtest: signal-point-0
[538.597439] Subtest signal-point-0: SUCCESS (0.000s)
[538.791743] [117/156] (498s left) gem_userptr_blits (relocations)
[538.882591] Starting subtest: relocations
[538.884297] Subtest relocations: SKIP (0.001s)
[539.109061] [118/156] (498s left) kms_plane_multiple (tiling-y)
[540.625210] Starting subtest: tiling-y
[540.627009] Subtest tiling-y: SKIP (0.000s)
[540.805725] [119/156] (496s left) gem_exec_await (wide-all)
[541.108103] Starting subtest: wide-all
[563.282578] Subtest wide-all: SUCCESS (22.175s)
[563.528345] [120/156] (474s left) gem_exec_params (invalid-fence-in-submit)
[563.666802] Starting subtest: invalid-fence-in-submit
[563.671462] Subtest invalid-fence-in-submit: SUCCESS (0.004s)
[563.852068] [121/156] (473s left) kms_flip (2x-wf_vblank-ts-check)
[565.378766] Starting subtest: 2x-wf_vblank-ts-check
[565.390404] Subtest 2x-wf_vblank-ts-check: SKIP (0.013s)
[565.495625] [122/156] (472s left) api_intel_bb (crc32)
[565.588472] Starting subtest: crc32
[565.589398] Starting dynamic subtest: rcs0-lmem0
[565.867780] Dynamic subtest rcs0-lmem0: SUCCESS (0.277s)
[565.885455] Starting dynamic subtest: rcs0-smem0
[566.206988] Dynamic subtest rcs0-smem0: SUCCESS (0.336s)
[566.219992] Starting dynamic subtest: bcs0-lmem0
[566.474913] Dynamic subtest bcs0-lmem0: SUCCESS (0.266s)
[566.492276] Starting dynamic subtest: bcs0-smem0
[566.845070] Dynamic subtest bcs0-smem0: SUCCESS (0.366s)
[566.860502] Starting dynamic subtest: vcs0-lmem0
[567.240181] Dynamic subtest vcs0-lmem0: SUCCESS (0.390s)
[567.286472] Starting dynamic subtest: vcs0-smem0
[567.770217] Dynamic subtest vcs0-smem0: SUCCESS (0.525s)
[567.785423] Starting dynamic subtest: vcs1-lmem0
[568.159796] Dynamic subtest vcs1-lmem0: SUCCESS (0.385s)
[568.180676] Starting dynamic subtest: vcs1-smem0
[568.669843] Dynamic subtest vcs1-smem0: SUCCESS (0.506s)
[568.684493] Starting dynamic subtest: vecs0-lmem0
[569.060262] Dynamic subtest vecs0-lmem0: SUCCESS (0.388s)
[569.108287] Starting dynamic subtest: vecs0-smem0
[569.604121] Dynamic subtest vecs0-smem0: SUCCESS (0.539s)
[569.619431] Starting dynamic subtest: vecs1-lmem0
[569.993758] Dynamic subtest vecs1-lmem0: SUCCESS (0.385s)
[570.014651] Starting dynamic subtest: vecs1-smem0
[570.500716] Dynamic subtest vecs1-smem0: SUCCESS (0.502s)
[570.516126] Starting dynamic subtest: ccs0-lmem0
[570.786413] Dynamic subtest ccs0-lmem0: SUCCESS (0.281s)
[570.807085] Starting dynamic subtest: ccs0-smem0
[571.185569] Dynamic subtest ccs0-smem0: SUCCESS (0.394s)
[571.189448] Subtest crc32: SUCCESS (5.599s)
[571.372510] [123/156] (466s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[572.905292] Starting subtest: yf-tiled-addfb-size-overflow
[572.907228] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[573.055962] [124/156] (465s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-indfb-plflip-blt)
[574.599206] Starting subtest: fbcpsrhdr-1p-primscrn-indfb-plflip-blt
[574.600998] Subtest fbcpsrhdr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[574.722732] [125/156] (463s left) gem_exec_whisper (basic-fds-forked-all)
[574.837160] Starting subtest: basic-fds-forked-all
[597.550208] Subtest basic-fds-forked-all: SUCCESS (22.712s)
[597.801999] [126/156] (440s left) syncobj_wait (signal)
[597.890355] Starting subtest: signal
[597.891336] Subtest signal: SUCCESS (0.000s)
[598.017067] [127/156] (440s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[599.540219] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[599.541992] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[599.656562] [128/156] (438s left) kms_psr (psr-sprite-mmap-gtt)
[601.190366] Subtest psr-sprite-mmap-gtt: SKIP (0.000s)
[601.255504] [129/156] (437s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[602.774188] Starting subtest: bad-rotation-90-y-tiled-ccs
[602.775130] Starting dynamic subtest: pipe-A-HDMI-A-3
[602.783764] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[602.796400] Starting dynamic subtest: pipe-B-HDMI-A-3
[602.805590] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[602.817564] Starting dynamic subtest: pipe-C-HDMI-A-3
[602.826361] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[602.838255] Starting dynamic subtest: pipe-D-HDMI-A-3
[602.847446] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[602.849552] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.007s)
[603.088899] [130/156] (435s left) vgem_basic (setversion)
[603.155648] Starting subtest: setversion
[603.157420] Subtest setversion: SUCCESS (0.000s)
[603.246118] [131/156] (435s left) gem_exec_create (madvise)
[603.337632] Starting subtest: madvise
[603.338557] Starting dynamic subtest: smem
[623.505228] Dynamic subtest smem: SUCCESS (20.166s)
[623.517606] Starting dynamic subtest: lmem0
[643.752264] Dynamic subtest lmem0: SUCCESS (20.246s)
[643.753392] Subtest madvise: SUCCESS (40.414s)
[644.790777] [132/156] (393s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-mmap-gtt)
[646.313885] Starting subtest: hdr-rgb101010-draw-mmap-gtt
[646.315558] Subtest hdr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[646.444496] [133/156] (392s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[648.008394] Starting subtest: plane-lut1d-pre-ctm3x4
[648.226067] Starting dynamic subtest: pipe-A-plane-0
[648.458513] Dynamic subtest pipe-A-plane-0: SUCCESS (0.232s)
[648.502893] Starting dynamic subtest: pipe-A-plane-1
[648.656957] Dynamic subtest pipe-A-plane-1: SUCCESS (0.195s)
[648.669329] Starting dynamic subtest: pipe-A-plane-2
[648.824924] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[649.113662] Starting dynamic subtest: pipe-B-plane-0
[649.267907] Dynamic subtest pipe-B-plane-0: SUCCESS (0.167s)
[649.308461] Starting dynamic subtest: pipe-B-plane-1
[649.468051] Dynamic subtest pipe-B-plane-1: SUCCESS (0.195s)
[649.489217] Starting dynamic subtest: pipe-B-plane-2
[649.649982] Dynamic subtest pipe-B-plane-2: SUCCESS (0.178s)
[649.929562] Starting dynamic subtest: pipe-C-plane-0
[650.110261] Dynamic subtest pipe-C-plane-0: SUCCESS (0.199s)
[650.122557] Starting dynamic subtest: pipe-C-plane-1
[650.278355] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s)
[650.315639] Starting dynamic subtest: pipe-C-plane-2
[650.477288] Dynamic subtest pipe-C-plane-2: SUCCESS (0.195s)
[650.788289] Starting dynamic subtest: pipe-D-plane-0
[650.960995] Dynamic subtest pipe-D-plane-0: SUCCESS (0.198s)
[650.998616] Starting dynamic subtest: pipe-D-plane-1
[651.178130] Dynamic subtest pipe-D-plane-1: SUCCESS (0.212s)
[651.198732] Starting dynamic subtest: pipe-D-plane-2
[651.377772] Dynamic subtest pipe-D-plane-2: SUCCESS (0.195s)
[651.451165] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (3.442s)
[651.687592] [134/156] (387s left) kms_pm_backlight (fade)
[653.203444] Subtest fade: SKIP (0.000s)
[653.262153] [135/156] (385s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[654.789041] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[654.846063] [136/156] (384s left) i915_pciid
[655.098915] [137/156] (383s left) perf_pmu (all-busy-idle-check-all)
[655.173138] Starting subtest: all-busy-idle-check-all
[655.856646] Subtest all-busy-idle-check-all: SUCCESS (0.684s)
[655.998165] [138/156] (383s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[657.519299] Starting subtest: 2x-cursor-vs-flip-legacy
[657.521182] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.002s)
[657.721305] [139/156] (381s left) kms_joiner (basic-force-big-joiner)
[659.246955] Starting subtest: basic-force-big-joiner
[659.248878] Subtest basic-force-big-joiner: SKIP (0.000s)
[659.336829] [140/156] (379s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[660.872071] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[660.873957] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[661.094630] [141/156] (378s left) kms_psr (fbc-psr2-suspend)
[662.617137] Subtest fbc-psr2-suspend: SKIP (0.000s)
[662.678929] [142/156] (376s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-onoff)
[664.202078] Starting subtest: hdr-1p-primscrn-cur-indfb-onoff
[664.203882] Subtest hdr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[664.373223] [143/156] (375s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt)
[665.938755] Starting subtest: fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt
[665.940385] Subtest fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[666.084457] [144/156] (373s left) gem_fence_thrash (bo-write-verify-x)
[666.174443] Starting subtest: bo-write-verify-x
[666.207273] Subtest bo-write-verify-x: SKIP (0.032s)
[666.280130] [145/156] (373s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[667.796390] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[667.798187] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[668.009594] [146/156] (371s left) gem_ppgtt (shrink-vs-evict-pinned)
[668.114129] Starting subtest: shrink-vs-evict-pinned
[675.883838] Subtest shrink-vs-evict-pinned: SUCCESS (7.769s)
[675.982090] [147/156] (363s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[677.498332] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[677.499272] Starting dynamic subtest: pipe-A-HDMI-A-3
[677.521841] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.002s)
[677.534437] Starting dynamic subtest: pipe-B-HDMI-A-3
[677.557481] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.002s)
[677.569597] Starting dynamic subtest: pipe-C-HDMI-A-3
[677.593511] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.002s)
[677.606495] Starting dynamic subtest: pipe-D-HDMI-A-3
[677.631943] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.002s)
[677.634015] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.016s)
[677.814573] [148/156] (362s left) gen9_exec_parse (secure-batches)
[677.902491] Subtest secure-batches: SKIP (0.000s)
[677.986908] [149/156] (362s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[679.508041] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[679.509826] Subtest psr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[679.649617] [150/156] (360s left) gem_exec_reloc (basic-gtt-noreloc)
[679.767350] Subtest basic-gtt-noreloc: SKIP (0.000s)
[679.847444] [151/156] (360s left) kms_frontbuffer_tracking (hdr-1p-rte)
[681.369882] Starting subtest: hdr-1p-rte
[681.371577] Subtest hdr-1p-rte: SKIP (0.000s)
[681.535610] [152/156] (358s left) gem_exec_schedule (preempt-hang)
[681.772966] Starting subtest: preempt-hang
[681.773931] Starting dynamic subtest: rcs0
[682.123524] Dynamic subtest rcs0: SUCCESS (0.351s)
[682.136332] Starting dynamic subtest: bcs0
[682.463851] Dynamic subtest bcs0: SUCCESS (0.339s)
[682.476155] Starting dynamic subtest: vcs0
[682.789226] Dynamic subtest vcs0: SUCCESS (0.324s)
[682.801776] Starting dynamic subtest: vcs1
[683.121349] Dynamic subtest vcs1: SUCCESS (0.331s)
[683.134220] Starting dynamic subtest: vecs0
[683.449483] Dynamic subtest vecs0: SUCCESS (0.326s)
[683.462171] Starting dynamic subtest: vecs1
[683.792448] Dynamic subtest vecs1: SUCCESS (0.343s)
[683.805394] Starting dynamic subtest: ccs0
[684.133852] Dynamic subtest ccs0: SUCCESS (0.340s)
[684.134749] Subtest preempt-hang: SUCCESS (2.362s)
[684.466980] [153/156] (355s left) gem_ctx_shared (q-smoketest-all)
[684.566265] Starting subtest: Q-smoketest-all
[716.869331] Subtest Q-smoketest-all: SUCCESS (32.295s)
[717.197647] [154/156] (323s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[717.277442] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[717.381340] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.102s)
[717.486760] [155/156] (322s left) kms_cursor_edge_walk (64x64-top-edge)
[719.007164] Starting subtest: 64x64-top-edge
[719.008130] Starting dynamic subtest: pipe-A-HDMI-A-3
[722.415419] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (3.407s)
[722.429471] Starting dynamic subtest: pipe-D-HDMI-A-3
[725.654447] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (3.236s)
[725.655439] Subtest 64x64-top-edge: SUCCESS (6.648s)
[725.862781] [156/156] (314s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-pwrite)
[727.385984] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-pwrite
[727.387832] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[727.526691] Closing watchdogs
results: parsing output: 0/ for test: kms_chamelium_frames
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_cursor_legacy
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_big_fb
results: parsing output: 12/ for test: kms_plane_scaling
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_create
results: parsing output: 16/ for test: syncobj_timeline
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: gem_ctx_param
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: gem_userptr_blits
results: parsing output: 21/ for test: i915_query
results: parsing output: 22/ for test: gem_render_copy
results: parsing output: 23/ for test: gem_exec_reloc
results: parsing output: 24/ for test: i915_pm_rpm
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: syncobj_wait
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_exec_parallel
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: syncobj_wait
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: perf_pmu
results: parsing output: 35/ for test: kms_dsc
results: parsing output: 36/ for test: kms_cursor_legacy
results: parsing output: 37/ for test: syncobj_wait
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_wait
results: parsing output: 40/ for test: gem_close_race
results: parsing output: 41/ for test: kms_lease
results: parsing output: 42/ for test: prime_busy
results: parsing output: 43/ for test: kms_getfb
results: parsing output: 44/ for test: gem_close
results: parsing output: 45/ for test: gem_ccs
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_ccs
results: parsing output: 48/ for test: gem_userptr_blits
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: kms_cursor_crc
results: parsing output: 52/ for test: core_getclient
results: parsing output: 53/ for test: gem_mmap_gtt
results: parsing output: 54/ for test: kms_flip
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: kms_rotation_crc
results: parsing output: 57/ for test: gem_mmap_gtt
results: parsing output: 58/ for test: gem_huc_copy
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_psr
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: i915_drm_fdinfo
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_mmap_gtt
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: gem_ctx_persistence
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_spin_batch
results: parsing output: 72/ for test: kms_cursor_crc
results: parsing output: 73/ for test: perf_pmu
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_flip_scaled_crc
results: parsing output: 76/ for test: kms_chamelium_hpd
results: parsing output: 77/ for test: kms_cursor_legacy
results: parsing output: 78/ for test: kms_properties
results: parsing output: 79/ for test: gem_mmap_offset
results: parsing output: 80/ for test: gem_exec_fence
results: parsing output: 81/ for test: sysfs_timeslice_duration
results: parsing output: 82/ for test: gem_exec_fence
results: parsing output: 83/ for test: syncobj_wait
results: parsing output: 84/ for test: kms_vblank
results: parsing output: 85/ for test: kms_busy
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_vblank
results: parsing output: 89/ for test: kms_addfb_basic
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: i915_query
results: parsing output: 92/ for test: syncobj_timeline
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: dmabuf_sync_file
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: kms_atomic
results: parsing output: 97/ for test: kms_pipe_crc_basic
results: parsing output: 98/ for test: kms_pm_rpm
results: parsing output: 99/ for test: kms_chamelium_audio
results: parsing output: 100/ for test: syncobj_wait
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_wait
results: parsing output: 104/ for test: gem_pxp
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_content_protection
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_prop_blob
results: parsing output: 109/ for test: gem_exec_schedule
results: parsing output: 110/ for test: gem_exec_balancer
results: parsing output: 111/ for test: gem_exec_params
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_exec_alignment
results: parsing output: 114/ for test: gem_ctx_persistence
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: gem_userptr_blits
results: parsing output: 117/ for test: kms_plane_multiple
results: parsing output: 118/ for test: gem_exec_await
results: parsing output: 119/ for test: gem_exec_params
results: parsing output: 120/ for test: kms_flip
results: parsing output: 121/ for test: api_intel_bb
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_exec_whisper
results: parsing output: 125/ for test: syncobj_wait
results: parsing output: 126/ for test: kms_plane
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: kms_ccs
results: parsing output: 129/ for test: vgem_basic
results: parsing output: 130/ for test: gem_exec_create
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_color_pipeline
results: parsing output: 133/ for test: kms_pm_backlight
results: parsing output: 134/ for test: kms_psr2_sf
results: parsing output: 135/ for test: i915_pciid
results: parsing output: 136/ for test: perf_pmu
results: parsing output: 137/ for test: kms_cursor_legacy
results: parsing output: 138/ for test: kms_joiner
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: kms_psr
results: parsing output: 141/ for test: kms_frontbuffer_tracking
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: gem_fence_thrash
results: parsing output: 144/ for test: kms_flip_scaled_crc
results: parsing output: 145/ for test: gem_ppgtt
results: parsing output: 146/ for test: kms_ccs
results: parsing output: 147/ for test: gen9_exec_parse
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: gem_exec_reloc
results: parsing output: 150/ for test: kms_frontbuffer_tracking
results: parsing output: 151/ for test: gem_exec_schedule
results: parsing output: 152/ for test: gem_ctx_shared
results: parsing output: 153/ for test: syncobj_timeline
results: parsing output: 154/ for test: kms_cursor_edge_walk
results: parsing output: 155/ for test: kms_frontbuffer_tracking
Done.