[63.049434] Initializing watchdogs
[63.049499]   /dev/watchdog0
[63.068355] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[63.078312] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[63.081798] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.084358] [001/128] (960s left) gem_wait (busy)
[63.258733] Starting subtest: busy
[63.259663] Starting dynamic subtest: all-engines
[63.843345] Dynamic subtest all-engines: SUCCESS (0.587s)
[63.850542] Starting dynamic subtest: rcs0
[64.382209] Dynamic subtest rcs0: SUCCESS (0.541s)
[64.389166] Starting dynamic subtest: bcs0
[64.920421] Dynamic subtest bcs0: SUCCESS (0.540s)
[64.927464] Starting dynamic subtest: vcs0
[65.458226] Dynamic subtest vcs0: SUCCESS (0.539s)
[65.465243] Starting dynamic subtest: vcs1
[65.996453] Dynamic subtest vcs1: SUCCESS (0.540s)
[66.003373] Starting dynamic subtest: vecs0
[66.534356] Dynamic subtest vecs0: SUCCESS (0.539s)
[66.541362] Starting dynamic subtest: vecs1
[67.105317] Dynamic subtest vecs1: SUCCESS (0.572s)
[67.112588] Starting dynamic subtest: ccs0
[67.699216] Dynamic subtest ccs0: SUCCESS (0.595s)
[67.700150] Subtest busy: SUCCESS (4.454s)
[67.951378] [002/128] (955s left) drm_fdinfo (virtual-busy)
[68.016193] Starting subtest: virtual-busy
[68.018113] Subtest virtual-busy: SKIP (0.000s)
[68.095922] [003/128] (955s left) sw_sync (sync_multi_producer_single_consumer)
[68.141300] Starting subtest: sync_multi_producer_single_consumer
[69.213828] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s)
[69.276579] [004/128] (954s left) kms_dp_linktrain_fallback (dsc-fallback)
[69.475446] Starting subtest: dsc-fallback
[69.478102] Subtest dsc-fallback: SKIP (0.000s)
[69.565371] [005/128] (954s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k)
[69.849715] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s)
[69.999645] [006/128] (953s left) gem_exec_params (invalid-flag)
[70.077322] Starting subtest: invalid-flag
[70.078244] Subtest invalid-flag: SUCCESS (0.000s)
[70.245072] [007/128] (953s left) gem_mmap_offset (partial-unmap)
[70.315072] Starting subtest: partial-unmap
[70.316044] Starting dynamic subtest: lmem0
[70.326369] Dynamic subtest lmem0: SUCCESS (0.012s)
[70.333977] Starting dynamic subtest: smem0
[70.335064] Dynamic subtest smem0: SUCCESS (0.004s)
[70.336185] Subtest partial-unmap: SUCCESS (0.016s)
[70.445697] [008/128] (953s left) kms_cursor_crc (cursor-onscreen-32x10)
[70.726660] Starting subtest: cursor-onscreen-32x10
[70.775464] Subtest cursor-onscreen-32x10: SKIP (0.046s)
[71.124928] [009/128] (952s left) syncobj_timeline (wait-all-for-submit-snapshot)
[71.197446] Starting subtest: wait-all-for-submit-snapshot
[71.282073] Subtest wait-all-for-submit-snapshot: SUCCESS (0.084s)
[71.386257] [010/128] (952s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[71.589517] Starting subtest: fbc-tiling-linear
[73.948872] Subtest fbc-tiling-linear: SUCCESS (2.362s)
[74.120279] [011/128] (949s left) gem_eio (in-flight-contexts-10ms)
[74.403116] Starting subtest: in-flight-contexts-10ms
[87.940468] Subtest in-flight-contexts-10ms: SUCCESS (13.537s)
[88.166823] [012/128] (935s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[88.372174] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[88.373977] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[88.688045] [013/128] (935s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[88.899851] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[90.226354] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.325s)
[90.405837] [014/128] (933s left) gem_exec_reloc (basic-write-gtt-noreloc)
[90.485568] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[90.562844] [015/128] (933s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[90.639661] Starting subtest: legacy-engines-hostile-preempt
[90.640565] Starting dynamic subtest: render
[90.753371] Dynamic subtest render: SUCCESS (0.113s)
[90.765675] Starting dynamic subtest: bsd1
[90.801174] Dynamic subtest bsd1: SUCCESS (0.046s)
[90.837187] Starting dynamic subtest: bsd2
[90.875781] Dynamic subtest bsd2: SUCCESS (0.073s)
[90.903620] Starting dynamic subtest: blt
[90.952321] Dynamic subtest blt: SUCCESS (0.075s)
[90.986597] Starting dynamic subtest: vebox
[91.027203] Dynamic subtest vebox: SUCCESS (0.073s)
[91.028927] Subtest legacy-engines-hostile-preempt: SUCCESS (0.387s)
[91.219546] [016/128] (933s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[91.426089] Starting subtest: 2x-absolute-wf_vblank-interruptible
[91.441286] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.014s)
[91.543541] [017/128] (932s left) sw_sync (timeline_closed)
[91.591224] Starting subtest: timeline_closed
[91.592175] Subtest timeline_closed: SUCCESS (0.000s)
[91.675305] [018/128] (932s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[91.881536] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[91.925384] [019/128] (932s left) gem_exec_basic (basic)
[92.005389] Starting subtest: basic
[92.006292] Starting dynamic subtest: rcs0-smem
[92.008163] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[92.016579] Starting dynamic subtest: bcs0-smem
[92.017465] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[92.025601] Starting dynamic subtest: vcs0-smem
[92.026812] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[92.034484] Starting dynamic subtest: vcs1-smem
[92.035559] Dynamic subtest vcs1-smem: SUCCESS (0.000s)
[92.043632] Starting dynamic subtest: vecs0-smem
[92.044810] Dynamic subtest vecs0-smem: SUCCESS (0.000s)
[92.052790] Starting dynamic subtest: vecs1-smem
[92.053958] Dynamic subtest vecs1-smem: SUCCESS (0.000s)
[92.061896] Starting dynamic subtest: ccs0-smem
[92.063104] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[92.071089] Starting dynamic subtest: rcs0-lmem0
[92.072325] Dynamic subtest rcs0-lmem0: SUCCESS (0.001s)
[92.080231] Starting dynamic subtest: bcs0-lmem0
[92.081508] Dynamic subtest bcs0-lmem0: SUCCESS (0.000s)
[92.089539] Starting dynamic subtest: vcs0-lmem0
[92.090755] Dynamic subtest vcs0-lmem0: SUCCESS (0.000s)
[92.098795] Starting dynamic subtest: vcs1-lmem0
[92.099960] Dynamic subtest vcs1-lmem0: SUCCESS (0.000s)
[92.107900] Starting dynamic subtest: vecs0-lmem0
[92.109086] Dynamic subtest vecs0-lmem0: SUCCESS (0.000s)
[92.116785] Starting dynamic subtest: vecs1-lmem0
[92.117643] Dynamic subtest vecs1-lmem0: SUCCESS (0.000s)
[92.125857] Starting dynamic subtest: ccs0-lmem0
[92.127114] Dynamic subtest ccs0-lmem0: SUCCESS (0.000s)
[92.128389] Subtest basic: SUCCESS (0.009s)
[92.233496] [020/128] (932s left) kms_color (legacy-gamma)
[92.433178] Starting subtest: legacy-gamma
[92.434233] Starting dynamic subtest: pipe-A-DP-3
[93.092641] Dynamic subtest pipe-A-DP-3: SUCCESS (0.658s)
[93.104269] Starting dynamic subtest: pipe-B-DP-3
[93.685705] Dynamic subtest pipe-B-DP-3: SUCCESS (0.593s)
[93.695885] Starting dynamic subtest: pipe-C-DP-3
[94.294580] Dynamic subtest pipe-C-DP-3: SUCCESS (0.609s)
[94.303821] Starting dynamic subtest: pipe-D-DP-3
[94.910399] Dynamic subtest pipe-D-DP-3: SUCCESS (0.615s)
[94.911521] Subtest legacy-gamma: SUCCESS (2.476s)
[95.201805] [021/128] (929s left) gem_exec_schedule (preemptive-hang)
[95.398735] Starting subtest: preemptive-hang
[95.399667] Starting dynamic subtest: rcs0
[105.179743] Dynamic subtest rcs0: SUCCESS (9.767s)
[105.188185] Starting dynamic subtest: bcs0
[114.125261] Dynamic subtest bcs0: SUCCESS (8.958s)
[114.133557] Starting dynamic subtest: vcs0
[123.157314] Dynamic subtest vcs0: SUCCESS (9.031s)
[123.165723] Starting dynamic subtest: vcs1
[132.181339] Dynamic subtest vcs1: SUCCESS (9.024s)
[132.189825] Starting dynamic subtest: vecs0
[141.155284] Dynamic subtest vecs0: SUCCESS (8.973s)
[141.163590] Starting dynamic subtest: vecs1
[150.172134] Dynamic subtest vecs1: SUCCESS (9.017s)
[150.180552] Starting dynamic subtest: ccs0
[159.192185] Dynamic subtest ccs0: SUCCESS (9.019s)
[159.193160] Subtest preemptive-hang: SUCCESS (63.790s)
[159.453109] [022/128] (865s left) gem_ctx_param (get-priority-new-ctx)
[159.521347] Starting subtest: get-priority-new-ctx
[159.523405] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[159.689079] [023/128] (865s left) kms_psr (fbc-psr-sprite-plane-onoff)
[159.888462] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.000s)
[159.942643] [024/128] (864s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[160.022916] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[160.025296] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[160.280661] [025/128] (864s left) gem_exec_store (basic)
[160.361811] Starting subtest: basic
[160.516683] Subtest basic: SUCCESS (0.154s)
[160.816065] [026/128] (864s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[161.016225] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[161.017168] Starting dynamic subtest: pipe-A-DP-3
[161.039503] Dynamic subtest pipe-A-DP-3: SKIP (0.002s)
[161.047820] Starting dynamic subtest: pipe-B-DP-3
[161.070129] Dynamic subtest pipe-B-DP-3: SKIP (0.002s)
[161.078372] Starting dynamic subtest: pipe-C-DP-3
[161.104050] Dynamic subtest pipe-C-DP-3: SKIP (0.002s)
[161.112152] Starting dynamic subtest: pipe-D-DP-3
[161.133029] Dynamic subtest pipe-D-DP-3: SKIP (0.002s)
[161.135195] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.011s)
[161.463310] [027/128] (863s left) drm_read (short-buffer-block)
[161.732900] Starting subtest: short-buffer-block
[161.733875] Subtest short-buffer-block: SUCCESS (0.000s)
[161.975384] [028/128] (863s left) kms_atomic (test-only)
[162.173168] Starting subtest: test-only
[162.616521] Starting dynamic subtest: pipe-A-DP-3
[163.519402] Dynamic subtest pipe-A-DP-3: SUCCESS (0.902s)
[163.520332] Subtest test-only: SUCCESS (1.346s)
[163.802170] [029/128] (861s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[164.000185] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[164.001032] Starting dynamic subtest: pipe-A
[166.135729] Dynamic subtest pipe-A: SUCCESS (2.135s)
[166.150295] Starting dynamic subtest: pipe-B
[168.239029] Dynamic subtest pipe-B: SUCCESS (2.103s)
[168.255883] Starting dynamic subtest: pipe-C
[168.559096] Dynamic subtest pipe-C: SUCCESS (0.319s)
[168.583533] Starting dynamic subtest: pipe-D
[168.880043] Dynamic subtest pipe-D: SUCCESS (0.320s)
[168.881415] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (4.880s)
[169.212839] [030/128] (856s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[169.425616] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[169.427397] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[169.578407] [031/128] (855s left) kms_vblank (ts-continuation-idle-hang)
[169.775226] Starting subtest: ts-continuation-idle-hang
[169.777164] Starting dynamic subtest: pipe-A-DP-3
[196.577501] Dynamic subtest pipe-A-DP-3: SUCCESS (26.800s)
[196.588507] Starting dynamic subtest: pipe-D-DP-3
[221.590497] Dynamic subtest pipe-D-DP-3: SUCCESS (25.009s)
[221.591423] Subtest ts-continuation-idle-hang: SUCCESS (51.814s)
[221.862871] [032/128] (803s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[222.069837] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[222.071546] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[222.184457] [033/128] (803s left) kms_flip (nonblocking-read)
[222.381996] Starting subtest: nonblocking-read
[222.382939] Subtest nonblocking-read: SUCCESS (0.000s)
[222.500754] [034/128] (803s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[222.699611] Starting subtest: flip-vs-cursor-busy-crc-atomic
[223.397279] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.696s)
[223.667781] [035/128] (801s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[223.749439] Starting subtest: x-tiled-to-vebox-y-tiled
[223.751244] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[223.991193] [036/128] (801s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[224.063690] Starting subtest: multi-wait-all-for-submit-submitted
[224.165974] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.102s)
[224.316691] [037/128] (801s left) gem_ccs (ctrl-surf-copy)
[224.392577] Starting subtest: ctrl-surf-copy
[224.393514] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0
[224.438374] Dynamic subtest linear-compressed-compfmt0-smem-lmem0: SUCCESS (0.045s)
[224.446614] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0
[224.636673] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.198s)
[224.645244] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0
[224.661156] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0: SUCCESS (0.024s)
[224.669616] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0
[224.867701] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.206s)
[224.876143] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0
[224.891993] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0: SUCCESS (0.024s)
[224.900449] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0
[225.105554] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.213s)
[225.113755] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0
[225.130595] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0: SUCCESS (0.025s)
[225.138944] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0
[225.346691] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.215s)
[225.347865] Subtest ctrl-surf-copy: SUCCESS (0.954s)
[225.492837] [038/128] (800s left) gem_media_fill (media-fill)
[225.568148] Subtest media-fill: SKIP (0.000s)
[225.700667] [039/128] (800s left) kms_flip (wf_vblank-ts-check-interruptible)
[225.901159] Starting subtest: wf_vblank-ts-check-interruptible
[225.905505] Starting dynamic subtest: A-DP3
[233.991390] Dynamic subtest A-DP3: SUCCESS (8.085s)
[234.001516] Starting dynamic subtest: B-DP3
[242.010505] Dynamic subtest B-DP3: SUCCESS (8.018s)
[242.019149] Starting dynamic subtest: C-DP3
[250.027772] Dynamic subtest C-DP3: SUCCESS (8.016s)
[250.037398] Starting dynamic subtest: D-DP3
[258.042533] Dynamic subtest D-DP3: SUCCESS (8.014s)
[258.044484] Subtest wf_vblank-ts-check-interruptible: SUCCESS (32.142s)
[258.354229] [040/128] (767s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[258.554634] Starting subtest: cursorA-vs-flipB-atomic-transitions
[258.557435] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[258.636723] [041/128] (767s left) dmabuf_sync_file (import-multiple-read-write)
[258.745055] Starting subtest: import-multiple-read-write
[258.748298] Subtest import-multiple-read-write: SUCCESS (0.004s)
[258.834460] [FACT dmabuf_sync_file (import-multiple-read-write)] new: kernel.kmod_is_loaded.vgem: true
[258.836280] [042/128] (767s left) gem_ctx_sseu (engines)
[258.925190] Subtest engines: SKIP (0.000s)
[259.001337] [043/128] (767s left) i915_query (query-topology-unsupported)
[259.081158] Starting subtest: query-topology-unsupported
[259.083342] Subtest query-topology-unsupported: SKIP (0.000s)
[259.209035] [044/128] (766s left) kms_chamelium_hpd (hdmi-hpd)
[259.489391] Subtest hdmi-hpd: SKIP (0.000s)
[259.656700] [045/128] (766s left) perf_pmu (pmu-read)
[259.727795] Starting subtest: pmu-read
[259.731667] Subtest pmu-read: SUCCESS (0.004s)
[259.866390] [046/128] (766s left) kms_invalid_mode (zero-hdisplay)
[260.079152] Starting subtest: zero-hdisplay
[260.080166] Starting dynamic subtest: pipe-A-DP-3
[260.164516] Dynamic subtest pipe-A-DP-3: SUCCESS (0.085s)
[260.178677] Starting dynamic subtest: pipe-B-DP-3
[260.179852] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s)
[260.192578] Starting dynamic subtest: pipe-C-DP-3
[260.193796] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[260.206200] Starting dynamic subtest: pipe-D-DP-3
[260.207215] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s)
[260.208228] Subtest zero-hdisplay: SUCCESS (0.094s)
[260.412708] [047/128] (765s left) kms_atomic_interruptible (universal-setplane-primary)
[260.621142] Starting subtest: universal-setplane-primary
[260.622061] Starting dynamic subtest: pipe-A-DP-3
[266.949757] Dynamic subtest pipe-A-DP-3: SUCCESS (6.327s)
[266.950984] Subtest universal-setplane-primary: SUCCESS (6.329s)
[267.206912] [048/128] (759s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[267.423050] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[267.424902] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[267.563813] [049/128] (758s left) gem_pxp (protected-raw-src-copy-not-readible)
[270.159247] Starting subtest: protected-raw-src-copy-not-readible
[270.161225] Subtest protected-raw-src-copy-not-readible: SKIP (0.000s)
[270.242132] [050/128] (756s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[270.340076] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[270.402163] [051/128] (756s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[270.616013] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[270.617714] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[270.750188] [052/128] (755s left) kms_addfb_basic (bad-pitch-999)
[270.832235] Starting subtest: bad-pitch-999
[270.833191] Subtest bad-pitch-999: SUCCESS (0.000s)
[271.099507] [053/128] (755s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[271.308761] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[271.310432] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[271.462912] [054/128] (755s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[271.680756] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[271.682466] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[271.864331] [055/128] (755s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[272.070330] Starting subtest: plane-upscale-20x20-with-modifiers
[272.071191] Starting dynamic subtest: pipe-A
[272.646160] Dynamic subtest pipe-A: SUCCESS (0.575s)
[272.667858] Starting dynamic subtest: pipe-B
[273.301209] Dynamic subtest pipe-B: SUCCESS (0.654s)
[273.323779] Starting dynamic subtest: pipe-C
[273.956130] Dynamic subtest pipe-C: SUCCESS (0.654s)
[273.979550] Starting dynamic subtest: pipe-D
[274.608955] Dynamic subtest pipe-D: SUCCESS (0.652s)
[274.610068] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (2.539s)
[274.940380] [056/128] (752s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-wc)
[275.151842] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-wc
[275.153527] Subtest psr-1p-offscren-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[275.268292] [057/128] (751s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[275.480341] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[275.482162] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[275.614603] [058/128] (751s left) kms_atomic (plane-invalid-params-fence)
[275.822319] Starting subtest: plane-invalid-params-fence
[275.824389] Starting dynamic subtest: pipe-A-DP-3
[276.360270] Dynamic subtest pipe-A-DP-3: SUCCESS (0.535s)
[276.361584] Subtest plane-invalid-params-fence: SUCCESS (0.537s)
[276.627938] [059/128] (750s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[276.706981] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[276.708055] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[276.848691] [060/128] (750s left) kms_setmode (invalid-clone-single-crtc-stealing)
[276.927216] Starting subtest: invalid-clone-single-crtc-stealing
[276.929941] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[277.077459] [061/128] (750s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[277.296935] Starting subtest: fbc-2p-pri-indfb-multidraw
[277.298673] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[277.434970] [062/128] (749s left) prime_self_import (export-vs-gem_close-race)
[277.486175] Starting subtest: export-vs-gem_close-race
[282.573431] Subtest export-vs-gem_close-race: SUCCESS (5.087s)
[282.678024] [063/128] (744s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[282.929300] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[283.997939] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (1.069s)
[284.230455] [064/128] (743s left) kms_vrr (negative-basic)
[284.436374] Starting subtest: negative-basic
[284.439050] Starting dynamic subtest: pipe-A-DP-3
[289.867621] Dynamic subtest pipe-A-DP-3: SUCCESS (5.427s)
[289.957595] Subtest negative-basic: SUCCESS (5.520s)
[290.233380] [065/128] (737s left) kms_psr (psr-primary-blt)
[290.441150] Subtest psr-primary-blt: SKIP (0.000s)
[290.503246] [066/128] (737s left) gem_exec_schedule (implicit-write-read)
[290.596482] Starting subtest: implicit-write-read
[290.597435] Starting dynamic subtest: rcs0
[290.878990] Dynamic subtest rcs0: SUCCESS (0.282s)
[290.888145] Starting dynamic subtest: bcs0
[291.073380] Dynamic subtest bcs0: SUCCESS (0.194s)
[291.082375] Starting dynamic subtest: vcs0
[291.272563] Dynamic subtest vcs0: SUCCESS (0.199s)
[291.281629] Starting dynamic subtest: vcs1
[291.471211] Dynamic subtest vcs1: SUCCESS (0.198s)
[291.480276] Starting dynamic subtest: vecs0
[291.670878] Dynamic subtest vecs0: SUCCESS (0.199s)
[291.680076] Starting dynamic subtest: vecs1
[291.873494] Dynamic subtest vecs1: SUCCESS (0.202s)
[291.882566] Starting dynamic subtest: ccs0
[292.113061] Dynamic subtest ccs0: SUCCESS (0.239s)
[292.113946] Subtest implicit-write-read: SUCCESS (1.517s)
[292.558322] [067/128] (735s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[292.775880] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[292.777564] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[292.926037] [068/128] (734s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[293.138414] Starting subtest: fbc-dirtyfb-ioctl
[293.140368] Starting dynamic subtest: A-DP-3
[294.557562] Dynamic subtest A-DP-3: SUCCESS (1.417s)
[294.558574] Subtest fbc-dirtyfb-ioctl: SUCCESS (1.418s)
[294.819375] [069/128] (733s left) syncobj_wait (single-wait-all-for-submit-signaled)
[294.899689] Starting subtest: single-wait-all-for-submit-signaled
[294.900815] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[295.010961] [070/128] (732s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[295.223739] Subtest psr2-plane-move-sf-dmg-area: SKIP (0.000s)
[295.278278] [071/128] (732s left) gen9_exec_parse (secure-batches)
[295.364178] Subtest secure-batches: SKIP (0.000s)
[295.446732] [072/128] (732s left) gem_ctx_freq (sysfs)
[295.534468] Starting subtest: sysfs
[295.535424] Starting dynamic subtest: gt0
[298.323117] Dynamic subtest gt0: FAIL (2.720s)
[298.324904] Subtest sysfs: FAIL (2.721s)
[298.433855] [073/128] (729s left) gem_eio (in-flight-1us)
[298.692898] Starting subtest: in-flight-1us
[303.526132] Subtest in-flight-1us: SUCCESS (4.834s)
[303.766279] [074/128] (724s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[303.850803] Starting subtest: etime-single-wait-for-submit-submitted
[303.958802] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.107s)
[304.094410] [075/128] (724s left) kms_lease (lease-get)
[304.305375] Starting subtest: lease-get
[304.307436] Starting dynamic subtest: pipe-A-DP-3
[304.308339] Dynamic subtest pipe-A-DP-3: SUCCESS (0.002s)
[304.320316] Starting dynamic subtest: pipe-B-DP-3
[304.321247] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s)
[304.331494] Starting dynamic subtest: pipe-C-DP-3
[304.332424] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[304.342396] Starting dynamic subtest: pipe-D-DP-3
[304.343341] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s)
[304.344243] Subtest lease-get: SUCCESS (0.012s)
[304.421577] [076/128] (723s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[304.635027] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[304.636823] Subtest psr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[304.820825] [077/128] (723s left) i915_pm_freq_api (freq-basic-api)
[304.907063] Starting subtest: freq-basic-api
[304.907928] Starting dynamic subtest: gt0
[304.910248] Dynamic subtest gt0: SUCCESS (0.003s)
[304.911180] Subtest freq-basic-api: SUCCESS (0.004s)
[305.092963] [078/128] (723s left) gem_ctx_param (invalid-get-no-zeromap)
[305.170583] Starting subtest: invalid-get-no-zeromap
[305.172641] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[305.306506] [079/128] (723s left) i915_selftest (mock)
[306.724760] Starting subtest: mock
[306.725852] Starting dynamic subtest: sanitycheck
[307.492079] Dynamic subtest sanitycheck: SUCCESS (0.766s)
[307.501648] Starting dynamic subtest: shmem
[308.263714] Dynamic subtest shmem: SUCCESS (0.769s)
[308.273820] Starting dynamic subtest: fence
[316.084201] Dynamic subtest fence: SUCCESS (7.817s)
[316.099655] Starting dynamic subtest: scatterlist
[317.861785] Dynamic subtest scatterlist: SUCCESS (1.775s)
[317.872059] Starting dynamic subtest: syncmap
[320.779362] Dynamic subtest syncmap: SUCCESS (2.915s)
[320.789544] Starting dynamic subtest: uncore
[321.548488] Dynamic subtest uncore: SUCCESS (0.767s)
[321.558775] Starting dynamic subtest: ring
[322.315649] Dynamic subtest ring: SUCCESS (0.764s)
[322.330673] Starting dynamic subtest: engine
[323.062028] Dynamic subtest engine: SUCCESS (0.743s)
[323.072057] Starting dynamic subtest: timelines
[327.145148] Dynamic subtest timelines: SUCCESS (4.080s)
[327.159533] Starting dynamic subtest: requests
[329.810590] Dynamic subtest requests: SUCCESS (2.663s)
[329.821597] Starting dynamic subtest: objects
[330.785445] Dynamic subtest objects: SUCCESS (0.973s)
[330.796033] Starting dynamic subtest: phys
[331.687247] Dynamic subtest phys: SUCCESS (0.900s)
[331.703080] Starting dynamic subtest: dmabuf
[332.567024] Dynamic subtest dmabuf: SUCCESS (0.878s)
[332.576408] Starting dynamic subtest: vma
[339.554045] Dynamic subtest vma: SUCCESS (6.986s)
[339.567994] Starting dynamic subtest: evict
[341.165699] Dynamic subtest evict: SUCCESS (1.610s)
[341.180062] Starting dynamic subtest: gtt
[344.764464] Dynamic subtest gtt: SUCCESS (3.596s)
[344.787739] Starting dynamic subtest: hugepages
[345.768018] Dynamic subtest hugepages: SUCCESS (1.002s)
[345.777179] Starting dynamic subtest: memory_region
[349.850704] Dynamic subtest memory_region: SUCCESS (4.081s)
[349.852094] Subtest mock: SUCCESS (43.126s)
[349.931533] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[349.933357] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[349.935540] [080/128] (678s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[351.925055] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[351.926869] Subtest psr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[352.106123] [FACT kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[352.110127] [FACT kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)] new: kernel.kmod_is_loaded.i915: true
[352.111443] [FACT kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)] new: kernel.kmod_is_loaded.xe: true
[352.113669] [081/128] (676s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[352.321759] Starting subtest: cursorB-vs-flipA-legacy
[352.324812] Subtest cursorB-vs-flipA-legacy: SKIP (0.002s)
[352.434578] [082/128] (676s left) gem_mmap_gtt (basic-read-write)
[352.515393] Subtest basic-read-write: SKIP (0.000s)
[352.580965] [083/128] (676s left) prime_self_import (basic-llseek-size)
[352.633285] Starting subtest: basic-llseek-size
[352.666431] Subtest basic-llseek-size: SUCCESS (0.034s)
[352.857652] [084/128] (676s left) perf (invalid-open-flags)
[353.218590] Starting subtest: invalid-open-flags
[353.219469] Subtest invalid-open-flags: SUCCESS (0.000s)
[353.268570] [085/128] (675s left) perf (per-context-mode-unprivileged)
[353.460988] Starting subtest: per-context-mode-unprivileged
[353.463181] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[353.518353] [086/128] (675s left) i915_pm_rps (thresholds-idle-park)
[353.603723] Starting subtest: thresholds-idle-park
[353.605580] Subtest thresholds-idle-park: SKIP (0.000s)
[353.688944] [087/128] (675s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[353.900596] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[353.902283] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[354.055566] [088/128] (675s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[354.263888] Starting subtest: cursor-vs-flip-varying-size
[386.014899] Subtest cursor-vs-flip-varying-size: SUCCESS (31.750s)
[386.258460] [089/128] (642s left) gem_userptr_blits (unsync-unmap)
[386.346055] Subtest unsync-unmap: SKIP (0.000s)
[386.533669] [090/128] (642s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[386.742419] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[386.744590] Starting dynamic subtest: pipe-A-DP-3
[387.326249] Dynamic subtest pipe-A-DP-3: SUCCESS (0.579s)
[387.335831] Starting dynamic subtest: pipe-B-DP-3
[388.012245] Dynamic subtest pipe-B-DP-3: SUCCESS (0.685s)
[388.021523] Starting dynamic subtest: pipe-C-DP-3
[388.698257] Dynamic subtest pipe-C-DP-3: SUCCESS (0.684s)
[388.707634] Starting dynamic subtest: pipe-D-DP-3
[389.386396] Dynamic subtest pipe-D-DP-3: SUCCESS (0.686s)
[389.387397] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SUCCESS (2.640s)
[389.689014] [091/128] (639s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[389.766111] Starting subtest: multi-wait-for-submit-unsubmitted
[389.869824] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.103s)
[390.004783] [092/128] (639s left) syncobj_timeline (invalid-wait-illegal-handle)
[390.083539] Starting subtest: invalid-wait-illegal-handle
[390.084599] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[390.257024] [093/128] (639s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[390.472433] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[390.474237] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[390.602866] [094/128] (638s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[390.813934] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[390.815759] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[390.963500] [095/128] (638s left) api_intel_bb (intel-bb-blit-x)
[391.044359] Starting subtest: intel-bb-blit-x
[391.726325] Subtest intel-bb-blit-x: SUCCESS (0.682s)
[391.862285] [096/128] (637s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[392.072901] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[392.074557] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[392.209056] [097/128] (637s left) perf_pmu (busy-accuracy-98)
[392.280221] Starting subtest: busy-accuracy-98
[392.281179] Starting dynamic subtest: rcs0
[395.335428] Dynamic subtest rcs0: SUCCESS (3.054s)
[395.345340] Starting dynamic subtest: bcs0
[398.389394] Dynamic subtest bcs0: SUCCESS (3.053s)
[398.399241] Starting dynamic subtest: vcs0
[401.445336] Dynamic subtest vcs0: SUCCESS (3.055s)
[401.455224] Starting dynamic subtest: vcs1
[404.500465] Dynamic subtest vcs1: SUCCESS (3.054s)
[404.510583] Starting dynamic subtest: vecs0
[407.554481] Dynamic subtest vecs0: SUCCESS (3.053s)
[407.564205] Starting dynamic subtest: vecs1
[410.607642] Dynamic subtest vecs1: SUCCESS (3.052s)
[410.617385] Starting dynamic subtest: ccs0
[413.659668] Dynamic subtest ccs0: SUCCESS (3.051s)
[413.660558] Subtest busy-accuracy-98: SUCCESS (21.379s)
[413.855691] [098/128] (615s left) gem_spin_batch (spin-all)
[413.945101] Starting subtest: spin-all
[413.984416] Subtest spin-all: SUCCESS (0.039s)
[414.317781] [099/128] (615s left) kms_selftest (drm_cmdline_parser)
[414.369460] Starting subtest: drm_cmdline_parser
[414.382997] Starting dynamic subtest: drm_test_cmdline_force_d_only
[414.529227] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.143s)
[414.564869] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[414.621285] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.090s)
[414.660835] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[414.727670] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.105s)
[414.768826] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[414.845277] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.111s)
[414.877910] Starting dynamic subtest: drm_test_cmdline_force_e_only
[414.950712] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.104s)
[414.992250] Starting dynamic subtest: drm_test_cmdline_res
[415.080647] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.126s)
[415.119622] Starting dynamic subtest: drm_test_cmdline_res_vesa
[415.195636] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.111s)
[415.234676] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[415.303691] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.103s)
[415.313272] Starting dynamic subtest: drm_test_cmdline_res_rblank
[415.401719] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.095s)
[415.443116] Starting dynamic subtest: drm_test_cmdline_res_bpp
[415.496699] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.093s)
[415.535436] Starting dynamic subtest: drm_test_cmdline_res_refresh
[415.608711] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.108s)
[415.649180] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[415.713640] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.101s)
[415.754175] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[415.793309] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.077s)
[415.818568] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[415.884742] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.089s)
[415.926803] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[415.982894] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.095s)
[415.996336] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[416.083572] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.097s)
[416.124421] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[416.218639] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.131s)
[416.259219] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[416.323809] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.102s)
[416.364180] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[416.432601] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.104s)
[416.473534] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[416.523392] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.088s)
[416.562303] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[416.615283] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.089s)
[416.625853] Starting dynamic subtest: drm_test_cmdline_name
[416.727432] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.111s)
[416.737575] Starting dynamic subtest: drm_test_cmdline_name_bpp
[416.850095] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.121s)
[416.863363] Starting dynamic subtest: drm_test_cmdline_name_option
[416.971663] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.117s)
[417.013174] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[417.067353] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.094s)
[417.077145] Starting dynamic subtest: drm_test_cmdline_rotate_0
[417.179661] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.111s)
[417.219180] Starting dynamic subtest: drm_test_cmdline_rotate_90
[417.295529] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.112s)
[417.334556] Starting dynamic subtest: drm_test_cmdline_rotate_180
[417.375617] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.076s)
[417.404067] Starting dynamic subtest: drm_test_cmdline_rotate_270
[417.489623] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.112s)
[417.529149] Starting dynamic subtest: drm_test_cmdline_hmirror
[417.620487] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.127s)
[417.659572] Starting dynamic subtest: drm_test_cmdline_vmirror
[417.746129] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.121s)
[417.787833] Starting dynamic subtest: drm_test_cmdline_margin_options
[417.862699] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.113s)
[417.903254] Starting dynamic subtest: drm_test_cmdline_multiple_options
[417.960330] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.095s)
[417.970889] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[418.064693] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.103s)
[418.104172] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[418.190664] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.122s)
[418.229860] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[418.272777] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.078s)
[418.302333] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[418.377776] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.103s)
[418.418442] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[418.504634] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.123s)
[418.544175] Starting dynamic subtest: drm_test_cmdline_invalid
[418.667183] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.156s)
[418.698151] Starting dynamic subtest: drm_test_cmdline_tv_options
[418.802971] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.130s)
[418.804435] Subtest drm_cmdline_parser: SUCCESS (4.430s)
[419.083759] [100/128] (610s left) debugfs_test (sysfs)
[419.168630] Starting subtest: sysfs
[419.766602] Subtest sysfs: SUCCESS (0.597s)
[419.991397] [101/128] (610s left) kms_psr (psr2-primary-render)
[420.199365] Subtest psr2-primary-render: SKIP (0.000s)
[420.264396] [102/128] (609s left) gem_lmem_swapping (heavy-multi)
[423.034016] Starting subtest: heavy-multi
[423.034899] Starting dynamic subtest: lmem0
[427.967409] Dynamic subtest lmem0: SUCCESS (4.935s)
[427.968438] Subtest heavy-multi: SUCCESS (4.936s)
[429.581395] [FACT gem_lmem_swapping (heavy-multi)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[429.582543] [FACT gem_lmem_swapping (heavy-multi)] deleted: kernel.kmod_is_loaded.i915: true
[429.585015] [103/128] (600s left) kms_plane_cursor (primary)
[433.802442] Starting subtest: primary
[433.804299] Starting dynamic subtest: pipe-A-DP-3-size-64
[437.170384] Dynamic subtest pipe-A-DP-3-size-64: SUCCESS (3.366s)
[437.236467] Starting dynamic subtest: pipe-A-DP-3-size-128
[440.437136] Dynamic subtest pipe-A-DP-3-size-128: SUCCESS (3.216s)
[440.512444] Starting dynamic subtest: pipe-A-DP-3-size-256
[443.870574] Dynamic subtest pipe-A-DP-3-size-256: SUCCESS (3.382s)
[443.998301] Starting dynamic subtest: pipe-B-DP-3-size-64
[447.441202] Dynamic subtest pipe-B-DP-3-size-64: SUCCESS (3.456s)
[447.489368] Starting dynamic subtest: pipe-B-DP-3-size-128
[450.891062] Dynamic subtest pipe-B-DP-3-size-128: SUCCESS (3.415s)
[450.936828] Starting dynamic subtest: pipe-B-DP-3-size-256
[454.324944] Dynamic subtest pipe-B-DP-3-size-256: SUCCESS (3.399s)
[454.436790] Starting dynamic subtest: pipe-C-DP-3-size-64
[457.913814] Dynamic subtest pipe-C-DP-3-size-64: SUCCESS (3.491s)
[457.957989] Starting dynamic subtest: pipe-C-DP-3-size-128
[461.313911] Dynamic subtest pipe-C-DP-3-size-128: SUCCESS (3.366s)
[461.358058] Starting dynamic subtest: pipe-C-DP-3-size-256
[464.763897] Dynamic subtest pipe-C-DP-3-size-256: SUCCESS (3.416s)
[464.873599] Starting dynamic subtest: pipe-D-DP-3-size-64
[468.252401] Dynamic subtest pipe-D-DP-3-size-64: SUCCESS (3.392s)
[468.299739] Starting dynamic subtest: pipe-D-DP-3-size-128
[471.636310] Dynamic subtest pipe-D-DP-3-size-128: SUCCESS (3.349s)
[471.680411] Starting dynamic subtest: pipe-D-DP-3-size-256
[475.053144] Dynamic subtest pipe-D-DP-3-size-256: SUCCESS (3.383s)
[475.179837] Subtest primary: SUCCESS (41.375s)
[475.473074] [FACT kms_plane_cursor (primary)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[475.476365] [FACT kms_plane_cursor (primary)] new: kernel.kmod_is_loaded.amdgpu: true
[475.476515] [FACT kms_plane_cursor (primary)] new: kernel.kmod_is_loaded.i915: true
[475.479536] [104/128] (554s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[475.685537] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[475.687685] Starting dynamic subtest: pipe-A-valid-mode
[475.777487] Dynamic subtest pipe-A-valid-mode: SKIP (0.089s)
[475.779548] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.090s)
[475.984639] [105/128] (554s left) gem_exec_whisper (basic-contexts-forked)
[476.084198] Starting subtest: basic-contexts-forked
[498.493544] Subtest basic-contexts-forked: SUCCESS (22.408s)
[498.729120] [106/128] (531s left) kms_psr (fbc-pr-sprite-blt)
[498.936373] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[498.987148] [107/128] (531s left) gem_exec_reloc (basic-cpu)
[499.070248] Subtest basic-cpu: SKIP (0.000s)
[499.172354] [108/128] (531s left) gem_exec_fence (syncobj-import)
[499.671564] Starting subtest: syncobj-import
[499.697646] Subtest syncobj-import: SUCCESS (0.026s)
[500.135200] [109/128] (530s left) kms_busy (extended-pageflip-hang-newfb)
[500.347498] Starting subtest: extended-pageflip-hang-newfb
[500.349707] Starting dynamic subtest: pipe-A
[508.228626] Dynamic subtest pipe-A: SUCCESS (7.878s)
[508.247814] Starting dynamic subtest: pipe-D
[516.114202] Dynamic subtest pipe-D: SUCCESS (7.879s)
[516.115132] Subtest extended-pageflip-hang-newfb: SUCCESS (15.767s)
[516.396992] [110/128] (514s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[516.608318] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[516.610136] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[516.753606] [111/128] (513s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[516.965922] Starting subtest: psr-rgb101010-draw-render
[516.967700] Subtest psr-rgb101010-draw-render: SKIP (0.000s)
[517.134166] [112/128] (513s left) kms_setmode (basic)
[517.212304] Starting subtest: basic
[517.341972] Starting dynamic subtest: pipe-A-DP-3
[519.503379] Dynamic subtest pipe-A-DP-3: SUCCESS (2.158s)
[519.634778] Starting dynamic subtest: pipe-B-DP-3
[521.785983] Dynamic subtest pipe-B-DP-3: SUCCESS (2.158s)
[521.860091] Subtest basic: SUCCESS (4.647s)
[522.130209] [113/128] (508s left) kms_content_protection (dp-mst-type-1)
[522.395301] Starting subtest: dp-mst-type-1
[522.397130] Subtest dp-mst-type-1: SKIP (0.000s)
[522.593613] [114/128] (508s left) kms_atomic_transition (plane-all-transition)
[522.799675] Starting subtest: plane-all-transition
[522.801973] Starting dynamic subtest: pipe-A-DP-3
[526.526331] Dynamic subtest pipe-A-DP-3: SUCCESS (3.724s)
[526.618665] Starting dynamic subtest: pipe-B-DP-3
[530.380900] Dynamic subtest pipe-B-DP-3: SUCCESS (3.778s)
[530.433794] Subtest plane-all-transition: SUCCESS (7.633s)
[530.694767] [115/128] (500s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[530.925404] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[531.961701] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (1.036s)
[532.202798] [116/128] (498s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[532.411487] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[532.413642] Starting dynamic subtest: pipe-A-DP-3
[532.422133] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[532.432336] Starting dynamic subtest: pipe-B-DP-3
[532.440976] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[532.451008] Starting dynamic subtest: pipe-C-DP-3
[532.459310] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[532.469574] Starting dynamic subtest: pipe-D-DP-3
[532.480570] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[532.482774] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[532.873967] [117/128] (498s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[533.087585] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[533.089927] Starting dynamic subtest: pipe-A-valid-mode
[537.982607] Dynamic subtest pipe-A-valid-mode: SUCCESS (4.893s)
[537.984107] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SUCCESS (4.896s)
[538.270230] [118/128] (493s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[538.484966] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[538.486827] Subtest fbcpsr-1p-pri-indfb-multidraw: SKIP (0.000s)
[538.620751] [119/128] (492s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[538.837622] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[538.839408] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[538.967093] [120/128] (492s left) gem_workarounds (reset-context)
[539.060599] Starting subtest: reset-context
[539.295604] Subtest reset-context: SUCCESS (0.235s)
[539.480527] [121/128] (492s left) kms_plane_scaling (plane-downscale-factor-0-25-with-pixel-format)
[539.688485] Starting subtest: plane-downscale-factor-0-25-with-pixel-format
[539.689421] Starting dynamic subtest: pipe-A
[540.451328] Dynamic subtest pipe-A: SKIP (0.760s)
[540.462382] Starting dynamic subtest: pipe-B
[541.596139] Dynamic subtest pipe-B: SKIP (1.145s)
[541.606682] Starting dynamic subtest: pipe-C
[542.742182] Dynamic subtest pipe-C: SKIP (1.144s)
[542.752830] Starting dynamic subtest: pipe-D
[543.888954] Dynamic subtest pipe-D: SKIP (1.146s)
[543.890329] Subtest plane-downscale-factor-0-25-with-pixel-format: SKIP (4.199s)
[544.014696] [122/128] (487s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[544.229272] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.000s)
[544.290680] [123/128] (487s left) prime_vgem (wait)
[544.386998] Starting subtest: wait
[544.387873] Starting dynamic subtest: rcs0
[544.444442] Dynamic subtest rcs0: SUCCESS (0.057s)
[544.456832] Starting dynamic subtest: bcs0
[544.522736] Dynamic subtest bcs0: SUCCESS (0.077s)
[544.533387] Starting dynamic subtest: vcs0
[544.560980] Dynamic subtest vcs0: SUCCESS (0.037s)
[544.571810] Starting dynamic subtest: vcs1
[544.602128] Dynamic subtest vcs1: SUCCESS (0.040s)
[544.612525] Starting dynamic subtest: vecs0
[544.642469] Dynamic subtest vecs0: SUCCESS (0.040s)
[544.653133] Starting dynamic subtest: vecs1
[544.680899] Dynamic subtest vecs1: SUCCESS (0.038s)
[544.691717] Starting dynamic subtest: ccs0
[544.719966] Dynamic subtest ccs0: SUCCESS (0.038s)
[544.720996] Subtest wait: SUCCESS (0.333s)
[544.863700] [124/128] (486s left) syncobj_timeline (device-signal-unordered)
[544.951055] Starting subtest: device-signal-unordered
[544.951940] Subtest device-signal-unordered: SUCCESS (0.000s)
[545.046593] [125/128] (486s left) kms_cursor_crc (cursor-sliding-256x85)
[545.444484] Starting subtest: cursor-sliding-256x85
[545.449505] Starting dynamic subtest: pipe-A-DP-3
[549.652144] Dynamic subtest pipe-A-DP-3: SUCCESS (4.201s)
[549.704851] Starting dynamic subtest: pipe-D-DP-3
[553.973266] Dynamic subtest pipe-D-DP-3: SUCCESS (4.278s)
[553.974274] Subtest cursor-sliding-256x85: SUCCESS (8.529s)
[554.331457] [126/128] (477s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[554.543026] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[554.544902] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[554.704089] [127/128] (477s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[554.917065] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[554.931723] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.014s)
[555.047207] [128/128] (476s left) gem_exec_balancer (parallel-balancer)
[555.375507] Starting subtest: parallel-balancer
[556.668955] Subtest parallel-balancer: SUCCESS (1.293s)
[556.786385] Closing watchdogs
results: parsing output: 0/ for test: gem_wait
results: parsing output: 1/ for test: drm_fdinfo
results: parsing output: 2/ for test: sw_sync
results: parsing output: 3/ for test: kms_dp_linktrain_fallback
results: parsing output: 4/ for test: kms_chamelium_edid
results: parsing output: 5/ for test: gem_exec_params
results: parsing output: 6/ for test: gem_mmap_offset
results: parsing output: 7/ for test: kms_cursor_crc
results: parsing output: 8/ for test: syncobj_timeline
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gem_eio
results: parsing output: 11/ for test: kms_ccs
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: gem_exec_reloc
results: parsing output: 14/ for test: gem_ctx_persistence
results: parsing output: 15/ for test: kms_flip
results: parsing output: 16/ for test: sw_sync
results: parsing output: 17/ for test: kms_psr2_sf
results: parsing output: 18/ for test: gem_exec_basic
results: parsing output: 19/ for test: kms_color
results: parsing output: 20/ for test: gem_exec_schedule
results: parsing output: 21/ for test: gem_ctx_param
results: parsing output: 22/ for test: kms_psr
results: parsing output: 23/ for test: gem_render_copy
results: parsing output: 24/ for test: gem_exec_store
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: drm_read
results: parsing output: 27/ for test: kms_atomic
results: parsing output: 28/ for test: kms_plane_scaling
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_vblank
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_flip
results: parsing output: 33/ for test: kms_cursor_legacy
results: parsing output: 34/ for test: gem_render_copy
results: parsing output: 35/ for test: syncobj_wait
results: parsing output: 36/ for test: gem_ccs
results: parsing output: 37/ for test: gem_media_fill
results: parsing output: 38/ for test: kms_flip
results: parsing output: 39/ for test: kms_cursor_legacy
results: parsing output: 40/ for test: dmabuf_sync_file
results: parsing output: 41/ for test: gem_ctx_sseu
results: parsing output: 42/ for test: i915_query
results: parsing output: 43/ for test: kms_chamelium_hpd
results: parsing output: 44/ for test: perf_pmu
results: parsing output: 45/ for test: kms_invalid_mode
results: parsing output: 46/ for test: kms_atomic_interruptible
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gem_pxp
results: parsing output: 49/ for test: kms_pipe_b_c_ivb
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_addfb_basic
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: kms_plane_scaling
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_atomic
results: parsing output: 58/ for test: syncobj_timeline
results: parsing output: 59/ for test: kms_setmode
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: prime_self_import
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: kms_vrr
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: gem_exec_schedule
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_dirtyfb
results: parsing output: 68/ for test: syncobj_wait
results: parsing output: 69/ for test: kms_psr2_sf
results: parsing output: 70/ for test: gen9_exec_parse
results: parsing output: 71/ for test: gem_ctx_freq
results: parsing output: 72/ for test: gem_eio
results: parsing output: 73/ for test: syncobj_timeline
results: parsing output: 74/ for test: kms_lease
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: i915_pm_freq_api
results: parsing output: 77/ for test: gem_ctx_param
results: parsing output: 78/ for test: i915_selftest
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_cursor_legacy
results: parsing output: 81/ for test: gem_mmap_gtt
results: parsing output: 82/ for test: prime_self_import
results: parsing output: 83/ for test: perf
results: parsing output: 84/ for test: perf
results: parsing output: 85/ for test: i915_pm_rps
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_cursor_legacy
results: parsing output: 88/ for test: gem_userptr_blits
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: syncobj_wait
results: parsing output: 91/ for test: syncobj_timeline
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: api_intel_bb
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: perf_pmu
results: parsing output: 97/ for test: gem_spin_batch
results: parsing output: 98/ for test: kms_selftest
results: parsing output: 99/ for test: debugfs_test
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: gem_lmem_swapping
results: parsing output: 102/ for test: kms_plane_cursor
results: parsing output: 103/ for test: kms_flip_scaled_crc
results: parsing output: 104/ for test: gem_exec_whisper
results: parsing output: 105/ for test: kms_psr
results: parsing output: 106/ for test: gem_exec_reloc
results: parsing output: 107/ for test: gem_exec_fence
results: parsing output: 108/ for test: kms_busy
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_setmode
results: parsing output: 112/ for test: kms_content_protection
results: parsing output: 113/ for test: kms_atomic_transition
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: kms_flip_scaled_crc
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: gem_workarounds
results: parsing output: 120/ for test: kms_plane_scaling
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: prime_vgem
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: kms_cursor_crc
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_flip
results: parsing output: 127/ for test: gem_exec_balancer
Done.