[65.741774] Initializing watchdogs
[65.741839]   /dev/watchdog0
[65.760833] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[65.771306] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[65.774698] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[65.777079] [001/133] (960s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[65.957974] Starting subtest: nonblocking-crc-frame-sequence
[65.958902] Starting dynamic subtest: pipe-A-DP-3
[66.691945] Dynamic subtest pipe-A-DP-3: SUCCESS (0.733s)
[66.699595] Starting dynamic subtest: pipe-B-DP-3
[67.310458] Dynamic subtest pipe-B-DP-3: SUCCESS (0.617s)
[67.318304] Starting dynamic subtest: pipe-C-DP-3
[67.920242] Dynamic subtest pipe-C-DP-3: SUCCESS (0.609s)
[67.927774] Starting dynamic subtest: pipe-D-DP-3
[68.551705] Dynamic subtest pipe-D-DP-3: SUCCESS (0.630s)
[68.552694] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.593s)
[68.861908] [002/133] (957s left) i915_module_load (reload)
[68.905154] Starting subtest: reload
[71.578453] Subtest reload: SUCCESS (2.674s)
[71.617913] [003/133] (954s left) gem_eio (in-flight-1us)
[71.937479] Starting subtest: in-flight-1us
[76.390420] Subtest in-flight-1us: SUCCESS (4.453s)
[76.633315] [FACT gem_eio (in-flight-1us)] new: kernel.kmod_is_loaded.vgem: true
[76.635374] [004/133] (949s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[76.830987] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[78.146544] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.315s)
[78.356583] [005/133] (948s left) kms_addfb_basic (bad-pitch-1024)
[78.435891] Starting subtest: bad-pitch-1024
[78.436802] Subtest bad-pitch-1024: SUCCESS (0.000s)
[78.716452] [006/133] (947s left) kms_getfb (getfb2-handle-zero)
[78.900998] Starting subtest: getfb2-handle-zero
[78.901814] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[79.085492] [007/133] (947s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[79.161056] Starting subtest: single-wait-all-for-submit-signaled
[79.161979] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[79.307619] [008/133] (947s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[79.382067] Starting subtest: invalid-multi-wait-all-unsubmitted
[79.382984] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[79.541030] [009/133] (947s left) kms_atomic_interruptible (universal-setplane-cursor)
[79.723846] Starting subtest: universal-setplane-cursor
[79.724703] Starting dynamic subtest: pipe-A-DP-3
[86.021892] Dynamic subtest pipe-A-DP-3: SUCCESS (6.295s)
[86.022927] Subtest universal-setplane-cursor: SUCCESS (6.297s)
[86.310832] [010/133] (940s left) gem_exec_reloc (basic-wc-cpu)
[86.395130] Subtest basic-wc-cpu: SKIP (0.000s)
[86.492459] [011/133] (940s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[86.695514] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[86.697251] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[86.863384] [012/133] (940s left) gem_pxp (hw-rejects-pxp-buffer)
[89.469358] Starting subtest: hw-rejects-pxp-buffer
[89.470452] Subtest hw-rejects-pxp-buffer: SUCCESS (0.000s)
[89.640213] [013/133] (937s left) gem_exec_balancer (invalid-bonds)
[89.736387] Starting subtest: invalid-bonds
[89.738583] Subtest invalid-bonds: SKIP (0.000s)
[90.142362] [014/133] (936s left) gem_exec_whisper (basic-forked-all)
[90.230163] Starting subtest: basic-forked-all
[92.976916] Subtest basic-forked-all: SUCCESS (2.745s)
[93.240934] [015/133] (933s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[93.435528] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[93.437224] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[93.622191] [016/133] (933s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[93.810425] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[93.812195] Subtest psr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[93.988527] [017/133] (933s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[94.181539] Starting subtest: psr-rgb565-draw-render
[94.183210] Subtest psr-rgb565-draw-render: SKIP (0.000s)
[94.351037] [018/133] (933s left) kms_psr (pr-cursor-mmap-cpu)
[94.537718] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[94.603527] [019/133] (932s left) gem_close_race (basic-process)
[94.720279] Starting subtest: basic-process
[94.802817] Subtest basic-process: SUCCESS (0.082s)
[95.108196] [020/133] (932s left) syncobj_timeline (etime-single-wait-all-submitted)
[95.189009] Starting subtest: etime-single-wait-all-submitted
[95.294945] Subtest etime-single-wait-all-submitted: SUCCESS (0.105s)
[95.425083] [021/133] (932s left) kms_cursor_crc (cursor-random-128x42)
[95.823097] Starting subtest: cursor-random-128x42
[95.827925] Starting dynamic subtest: pipe-A-DP-3
[100.283539] Dynamic subtest pipe-A-DP-3: SUCCESS (4.455s)
[100.335118] Starting dynamic subtest: pipe-D-DP-3
[104.869438] Dynamic subtest pipe-D-DP-3: SUCCESS (4.542s)
[104.870431] Subtest cursor-random-128x42: SUCCESS (9.045s)
[105.299988] [022/133] (922s left) syncobj_timeline (invalid-wait-bad-flags)
[105.378944] Starting subtest: invalid-wait-bad-flags
[105.379894] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[105.564550] [023/133] (922s left) gem_sync (basic-all)
[105.649017] Starting subtest: basic-all
[108.637703] Subtest basic-all: SUCCESS (2.988s)
[108.880221] [024/133] (918s left) kms_big_fb (linear-16bpp-rotate-90)
[109.078300] Starting subtest: linear-16bpp-rotate-90
[109.131382] Subtest linear-16bpp-rotate-90: SKIP (0.053s)
[109.344098] [025/133] (918s left) gem_flink_basic (bad-flink)
[109.420901] Starting subtest: bad-flink
[109.421848] Subtest bad-flink: SUCCESS (0.000s)
[109.628293] [026/133] (918s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[109.820271] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[109.822033] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[110.013364] [027/133] (918s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[110.292154] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[110.445727] [028/133] (917s left) gem_exec_fence (syncobj-invalid-wait)
[111.011545] Starting subtest: syncobj-invalid-wait
[111.012496] Subtest syncobj-invalid-wait: SUCCESS (0.001s)
[111.471773] [029/133] (916s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[111.664925] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[112.755917] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (1.091s)
[112.989998] [030/133] (915s left) gem_exec_schedule (implicit-boths)
[113.082519] Starting subtest: implicit-boths
[113.083469] Starting dynamic subtest: rcs0
[113.377363] Dynamic subtest rcs0: SUCCESS (0.294s)
[113.386699] Starting dynamic subtest: bcs0
[113.581217] Dynamic subtest bcs0: SUCCESS (0.204s)
[113.590979] Starting dynamic subtest: vcs0
[113.793128] Dynamic subtest vcs0: SUCCESS (0.211s)
[113.802807] Starting dynamic subtest: vcs1
[114.004437] Dynamic subtest vcs1: SUCCESS (0.211s)
[114.013636] Starting dynamic subtest: vecs0
[114.217534] Dynamic subtest vecs0: SUCCESS (0.213s)
[114.226677] Starting dynamic subtest: vecs1
[114.429184] Dynamic subtest vecs1: SUCCESS (0.211s)
[114.438745] Starting dynamic subtest: ccs0
[114.641381] Dynamic subtest ccs0: SUCCESS (0.212s)
[114.642206] Subtest implicit-boths: SUCCESS (1.559s)
[115.189072] [031/133] (913s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[115.383251] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[116.657749] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.274s)
[116.907710] [032/133] (911s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[117.098287] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[117.100065] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[117.258631] [033/133] (911s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[117.448326] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[117.450006] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[117.653424] [034/133] (910s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[117.844155] Starting subtest: fbc-rgb101010-draw-blt
[120.690663] Subtest fbc-rgb101010-draw-blt: SUCCESS (2.847s)
[120.933987] [035/133] (907s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[121.124365] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[121.125223] Starting dynamic subtest: pipe-A
[121.206103] Dynamic subtest pipe-A: SUCCESS (0.082s)
[121.216424] Starting dynamic subtest: pipe-B
[121.403826] Dynamic subtest pipe-B: SUCCESS (0.197s)
[121.420026] Starting dynamic subtest: pipe-C
[121.617055] Dynamic subtest pipe-C: SUCCESS (0.213s)
[121.631217] Starting dynamic subtest: pipe-D
[121.830173] Dynamic subtest pipe-D: SUCCESS (0.213s)
[121.831234] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (0.706s)
[122.209874] [036/133] (906s left) gem_userptr_blits (probe)
[122.308819] Starting subtest: probe
[122.427980] Subtest probe: SUCCESS (0.119s)
[122.620265] [037/133] (906s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[122.813560] Starting subtest: yf-tiled-8bpp-rotate-270
[122.815345] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[123.010348] [038/133] (905s left) gem_eio (wait-wedge-1us)
[123.333422] Starting subtest: wait-wedge-1us
[124.862127] Subtest wait-wedge-1us: SUCCESS (1.529s)
[125.128704] [039/133] (903s left) syncobj_wait (invalid-signal-one-illegal-handle)
[125.211251] Starting subtest: invalid-signal-one-illegal-handle
[125.212188] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[125.391855] [040/133] (903s left) gem_exec_parallel (basic)
[125.486542] Starting subtest: basic
[125.487459] Starting dynamic subtest: rcs0
[127.060291] Dynamic subtest rcs0: SUCCESS (1.573s)
[127.071340] Starting dynamic subtest: bcs0
[128.526390] Dynamic subtest bcs0: SUCCESS (1.466s)
[128.536757] Starting dynamic subtest: vcs0
[130.025573] Dynamic subtest vcs0: SUCCESS (1.499s)
[130.035346] Starting dynamic subtest: vcs1
[131.505533] Dynamic subtest vcs1: SUCCESS (1.479s)
[131.517289] Starting dynamic subtest: vecs0
[132.980206] Dynamic subtest vecs0: SUCCESS (1.474s)
[132.991918] Starting dynamic subtest: vecs1
[134.466593] Dynamic subtest vecs1: SUCCESS (1.486s)
[134.478101] Starting dynamic subtest: ccs0
[135.978418] Dynamic subtest ccs0: SUCCESS (1.511s)
[135.979344] Subtest basic: SUCCESS (10.492s)
[136.296272] [041/133] (892s left) gem_ccs (ctrl-surf-copy)
[136.380152] Starting subtest: ctrl-surf-copy
[136.381112] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0
[136.434557] Dynamic subtest linear-compressed-compfmt0-smem-lmem0: SUCCESS (0.054s)
[136.444547] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0
[136.620322] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.185s)
[136.630385] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0
[136.646673] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0: SUCCESS (0.025s)
[136.656668] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0
[136.845997] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.199s)
[136.856221] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0
[136.872364] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0: SUCCESS (0.026s)
[136.882377] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0
[137.091106] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.218s)
[137.101274] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0
[137.117494] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0: SUCCESS (0.026s)
[137.127405] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0
[137.335457] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.217s)
[137.336457] Subtest ctrl-surf-copy: SUCCESS (0.955s)
[137.506227] [042/133] (891s left) gem_exec_fence (basic-busy-all)
[137.593623] Starting subtest: basic-busy-all
[137.732212] Subtest basic-busy-all: SUCCESS (0.138s)
[138.659675] [043/133] (890s left) kms_psr (psr2-primary-blt)
[138.844895] Subtest psr2-primary-blt: SKIP (0.000s)
[138.903989] [044/133] (890s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[138.980123] Starting subtest: single-wait-for-submit-unsubmitted
[139.086698] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[139.261075] [045/133] (890s left) kms_flip (flip-vs-rmfb-interruptible)
[139.445421] Starting subtest: flip-vs-rmfb-interruptible
[139.449925] Starting dynamic subtest: A-DP3
[147.271988] Dynamic subtest A-DP3: SUCCESS (7.821s)
[147.311765] Starting dynamic subtest: B-DP3
[155.033123] Dynamic subtest B-DP3: SUCCESS (7.758s)
[155.069424] Starting dynamic subtest: C-DP3
[162.776259] Dynamic subtest C-DP3: SUCCESS (7.739s)
[162.810531] Starting dynamic subtest: D-DP3
[170.521116] Dynamic subtest D-DP3: SUCCESS (7.741s)
[170.529520] Subtest flip-vs-rmfb-interruptible: SUCCESS (31.082s)
[170.932813] [046/133] (858s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[171.115387] Starting subtest: cursor-vs-flip-varying-size
[203.957921] Subtest cursor-vs-flip-varying-size: SUCCESS (32.842s)
[204.248168] [047/133] (825s left) i915_query (hwconfig_table)
[204.324415] Starting subtest: hwconfig_table
[204.491272] Subtest hwconfig_table: SUCCESS (0.001s)
[204.575333] [048/133] (825s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[204.771846] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[204.773490] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[204.969785] [049/133] (824s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[205.153386] Starting subtest: cursorB-vs-flipB-atomic
[205.155125] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[205.335695] [050/133] (824s left) gen9_exec_parse (valid-registers)
[205.419996] Subtest valid-registers: SKIP (0.000s)
[205.501929] [051/133] (824s left) kms_addfb_basic (bo-too-small)
[205.687843] Starting subtest: bo-too-small
[205.688744] Subtest bo-too-small: SUCCESS (0.000s)
[205.857898] [052/133] (824s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[206.054481] Starting subtest: y-tiled-8bpp-rotate-0
[206.056201] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[206.252385] [053/133] (823s left) gem_linear_blits (interruptible)
[206.646783] Starting subtest: interruptible
[214.041928] Subtest interruptible: SUCCESS (7.395s)
[214.206751] [054/133] (815s left) gem_create (hog-create)
[214.323567] Starting subtest: hog-create
[214.324496] Starting dynamic subtest: lmem0
[246.609299] Dynamic subtest lmem0: SUCCESS (32.285s)
[246.620319] Starting dynamic subtest: smem0
[278.865210] Dynamic subtest smem0: SUCCESS (32.255s)
[278.866176] Subtest hog-create: SUCCESS (64.541s)
[279.156691] [055/133] (751s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[279.243376] Starting subtest: multi-wait-all-for-submit-submitted
[279.350482] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.106s)
[279.474250] [056/133] (750s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[279.667952] Starting subtest: fbcpsr-rgb565-draw-pwrite
[279.669584] Subtest fbcpsr-rgb565-draw-pwrite: SKIP (0.000s)
[279.870580] [057/133] (750s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[280.055629] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[280.057899] Starting dynamic subtest: pipe-A-DP-3
[280.066147] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[280.076492] Starting dynamic subtest: pipe-B-DP-3
[280.087978] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[280.098175] Starting dynamic subtest: pipe-C-DP-3
[280.106260] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[280.116559] Starting dynamic subtest: pipe-D-DP-3
[280.126260] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[280.128468] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SKIP (0.006s)
[280.549483] [058/133] (749s left) gem_exec_balancer (parallel-ordering)
[280.892569] Starting subtest: parallel-ordering
[282.530618] Subtest parallel-ordering: SUCCESS (1.639s)
[282.749714] [059/133] (747s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[282.947026] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[286.305320] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (3.359s)
[286.492744] [060/133] (744s left) kms_addfb_basic (basic-x-tiled-legacy)
[286.569661] Starting subtest: basic-x-tiled-legacy
[286.571297] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[286.869539] [061/133] (743s left) perf (polling)
[287.266013] Starting subtest: polling
[287.266903] Starting dynamic subtest: 0-rcs0
[297.285815] Dynamic subtest 0-rcs0: SUCCESS (10.019s)
[297.286744] Subtest polling: SUCCESS (10.020s)
[297.351477] [062/133] (733s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[297.544773] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[297.545622] Starting dynamic subtest: pipe-A-DP-3
[297.554399] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[297.569350] Starting dynamic subtest: pipe-B-DP-3
[297.577929] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[297.589480] Starting dynamic subtest: pipe-C-DP-3
[297.597584] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[297.607954] Starting dynamic subtest: pipe-D-DP-3
[297.617335] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[297.619361] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SKIP (0.013s)
[298.039875] [063/133] (732s left) api_intel_bb (simple-bb-ctx)
[298.120443] Starting subtest: simple-bb-ctx
[298.154175] Subtest simple-bb-ctx: SUCCESS (0.034s)
[298.320201] [064/133] (732s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[298.508227] Starting subtest: plane-primary-overlay-mutable-zpos
[300.634295] Subtest plane-primary-overlay-mutable-zpos: SKIP (2.125s)
[301.045118] [065/133] (729s left) kms_pm_rpm (pm-caching)
[303.056822] Starting subtest: pm-caching
[303.058477] Subtest pm-caching: SKIP (0.000s)
[303.505171] [066/133] (727s left) gem_ctx_persistence (engines-hang)
[303.590354] Starting subtest: engines-hang
[303.591221] Starting dynamic subtest: rcs0
[303.692387] Dynamic subtest rcs0: SUCCESS (0.101s)
[303.709466] Starting dynamic subtest: bcs0
[303.797483] Dynamic subtest bcs0: SUCCESS (0.103s)
[303.829949] Starting dynamic subtest: vcs0
[303.850389] Dynamic subtest vcs0: SUCCESS (0.051s)
[303.876480] Starting dynamic subtest: vcs1
[303.910406] Dynamic subtest vcs1: SUCCESS (0.058s)
[303.937358] Starting dynamic subtest: vecs0
[303.964531] Dynamic subtest vecs0: SUCCESS (0.052s)
[303.985288] Starting dynamic subtest: vecs1
[304.014505] Dynamic subtest vecs1: SUCCESS (0.048s)
[304.041282] Starting dynamic subtest: ccs0
[304.057316] Dynamic subtest ccs0: SUCCESS (0.041s)
[304.058413] Subtest engines-hang: SUCCESS (0.468s)
[304.252337] [067/133] (726s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[304.436556] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[304.437430] Starting dynamic subtest: pipe-A
[306.370968] Dynamic subtest pipe-A: SUCCESS (1.934s)
[306.385612] Starting dynamic subtest: pipe-B
[308.419403] Dynamic subtest pipe-B: SUCCESS (2.047s)
[308.458054] Starting dynamic subtest: pipe-C
[308.750900] Dynamic subtest pipe-C: SUCCESS (0.329s)
[308.769283] Starting dynamic subtest: pipe-D
[309.066173] Dynamic subtest pipe-D: SUCCESS (0.314s)
[309.069614] Subtest plane-downscale-factor-0-5-with-pixel-format: SUCCESS (4.631s)
[309.430679] [068/133] (721s left) api_intel_allocator (fork-simple-once)
[309.508192] Starting subtest: fork-simple-once
[309.549984] Subtest fork-simple-once: SUCCESS (0.042s)
[309.760766] [069/133] (721s left) gem_pread (self)
[309.838216] Subtest self: SKIP (0.000s)
[309.906947] [070/133] (721s left) gem_exec_schedule (preempt-other-chain)
[310.002522] Starting subtest: preempt-other-chain
[310.003372] Starting dynamic subtest: rcs0
[310.633287] Dynamic subtest rcs0: SUCCESS (0.630s)
[310.644610] Starting dynamic subtest: bcs0
[311.252227] Dynamic subtest bcs0: SUCCESS (0.618s)
[311.263135] Starting dynamic subtest: vcs0
[311.879078] Dynamic subtest vcs0: SUCCESS (0.626s)
[311.890406] Starting dynamic subtest: vcs1
[312.496372] Dynamic subtest vcs1: SUCCESS (0.616s)
[312.507257] Starting dynamic subtest: vecs0
[313.254294] Dynamic subtest vecs0: SUCCESS (0.757s)
[313.265153] Starting dynamic subtest: vecs1
[313.872253] Dynamic subtest vecs1: SUCCESS (0.617s)
[313.883467] Starting dynamic subtest: ccs0
[314.493615] Dynamic subtest ccs0: SUCCESS (0.620s)
[314.494653] Subtest preempt-other-chain: SUCCESS (4.491s)
[314.886767] [071/133] (716s left) gem_ctx_persistence (legacy-engines-mixed)
[314.973499] Starting subtest: legacy-engines-mixed
[314.974437] Starting dynamic subtest: render
[315.089500] Dynamic subtest render: SUCCESS (0.115s)
[315.111034] Starting dynamic subtest: bsd1
[315.154188] Dynamic subtest bsd1: SUCCESS (0.062s)
[315.192876] Starting dynamic subtest: bsd2
[315.231344] Dynamic subtest bsd2: SUCCESS (0.073s)
[315.252225] Starting dynamic subtest: blt
[315.295460] Dynamic subtest blt: SUCCESS (0.062s)
[315.320182] Starting dynamic subtest: vebox
[315.360175] Dynamic subtest vebox: SUCCESS (0.062s)
[315.365637] Subtest legacy-engines-mixed: SUCCESS (0.388s)
[315.563469] [072/133] (715s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[315.753149] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[315.754864] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[315.913246] [073/133] (715s left) gem_mmap_gtt (bad-object)
[315.988212] Subtest bad-object: SKIP (0.000s)
[316.057134] [074/133] (715s left) kms_psr (fbc-psr-basic)
[316.242280] Subtest fbc-psr-basic: SKIP (0.000s)
[316.307128] [075/133] (715s left) gem_userptr_blits (access-control)
[316.403727] Starting subtest: access-control
[316.405523] Subtest access-control: SKIP (0.000s)
[316.595375] [076/133] (715s left) gem_ctx_param (non-root-set)
[316.675857] Starting subtest: non-root-set
[316.693215] Subtest non-root-set: SUCCESS (0.017s)
[316.862733] [077/133] (714s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[317.053887] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[317.055534] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[317.221603] [078/133] (714s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[317.405635] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[317.408049] Starting dynamic subtest: pipe-A-DP-3
[317.416260] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[317.427250] Starting dynamic subtest: pipe-B-DP-3
[317.435387] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[317.446186] Starting dynamic subtest: pipe-C-DP-3
[317.454299] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[317.465147] Starting dynamic subtest: pipe-D-DP-3
[317.476018] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[317.478156] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.007s)
[317.872489] [079/133] (714s left) core_setmaster (master-drop-set-user)
[318.041010] Starting subtest: master-drop-set-user
[318.077452] Subtest master-drop-set-user: SUCCESS (0.037s)
[318.124999] [080/133] (713s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[318.321272] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[318.357495] Starting dynamic subtest: pipe-A-plane-0
[318.359253] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[318.370371] Starting dynamic subtest: pipe-A-plane-3
[318.372718] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[318.383378] Starting dynamic subtest: pipe-A-plane-5
[318.385166] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[318.594575] Starting dynamic subtest: pipe-B-plane-0
[318.596598] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[318.614551] Starting dynamic subtest: pipe-B-plane-3
[318.616411] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[318.628604] Starting dynamic subtest: pipe-B-plane-5
[318.630300] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[318.683963] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.362s)
[318.955802] [081/133] (713s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[319.144279] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[319.145201] Starting dynamic subtest: pipe-A-valid-mode
[321.013996] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.866s)
[321.015241] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (1.870s)
[321.356502] [082/133] (710s left) syncobj_timeline (reset-unsignaled)
[321.436364] Starting subtest: reset-unsignaled
[321.437280] Subtest reset-unsignaled: SUCCESS (0.000s)
[321.596908] [083/133] (710s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[321.680940] Starting subtest: yf-tiled-to-vebox-x-tiled
[321.682716] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[321.979526] [084/133] (710s left) perf_pmu (busy-idle-check-all)
[322.048849] Starting subtest: busy-idle-check-all
[322.049805] Starting dynamic subtest: rcs0
[322.734054] Dynamic subtest rcs0: SUCCESS (0.684s)
[322.752426] Starting dynamic subtest: bcs0
[323.388544] Dynamic subtest bcs0: SUCCESS (0.652s)
[323.408700] Starting dynamic subtest: vcs0
[324.051368] Dynamic subtest vcs0: SUCCESS (0.658s)
[324.096146] Starting dynamic subtest: vcs1
[324.739317] Dynamic subtest vcs1: SUCCESS (0.683s)
[324.759800] Starting dynamic subtest: vecs0
[325.403679] Dynamic subtest vecs0: SUCCESS (0.659s)
[325.423977] Starting dynamic subtest: vecs1
[326.065368] Dynamic subtest vecs1: SUCCESS (0.657s)
[326.085979] Starting dynamic subtest: ccs0
[326.728457] Dynamic subtest ccs0: SUCCESS (0.658s)
[326.734230] Subtest busy-idle-check-all: SUCCESS (4.681s)
[326.943679] [085/133] (705s left) kms_draw_crc (draw-method-mmap-cpu)
[327.130443] Starting subtest: draw-method-mmap-cpu
[327.131423] Starting dynamic subtest: xrgb8888-untiled
[327.461526] Dynamic subtest xrgb8888-untiled: SUCCESS (0.330s)
[327.503994] Starting dynamic subtest: rgb565-untiled
[327.794920] Dynamic subtest rgb565-untiled: SUCCESS (0.328s)
[327.815148] Starting dynamic subtest: xrgb2101010-untiled
[328.078059] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.278s)
[328.119372] Starting dynamic subtest: xbgr16161616f-untiled
[328.410224] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.328s)
[328.424177] Starting dynamic subtest: xrgb8888-xtiled
[328.578318] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.166s)
[328.619161] Starting dynamic subtest: rgb565-xtiled
[328.760734] Dynamic subtest rgb565-xtiled: SUCCESS (0.178s)
[328.785289] Starting dynamic subtest: xrgb2101010-xtiled
[328.928138] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.165s)
[328.968055] Starting dynamic subtest: xbgr16161616f-xtiled
[329.111139] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.178s)
[329.126881] Starting dynamic subtest: xrgb8888-4tiled
[329.278196] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.162s)
[329.321924] Starting dynamic subtest: rgb565-4tiled
[329.477232] Dynamic subtest rgb565-4tiled: SUCCESS (0.195s)
[329.491501] Starting dynamic subtest: xrgb2101010-4tiled
[329.627498] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.148s)
[329.643333] Starting dynamic subtest: xbgr16161616f-4tiled
[329.794859] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.166s)
[329.800799] Subtest draw-method-mmap-cpu: SUCCESS (2.667s)
[329.993118] [086/133] (702s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[330.176405] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[330.210643] Starting dynamic subtest: pipe-A-plane-0
[330.212326] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[330.224116] Starting dynamic subtest: pipe-A-plane-3
[330.225807] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[330.237830] Starting dynamic subtest: pipe-A-plane-5
[330.239487] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[330.448066] Starting dynamic subtest: pipe-B-plane-0
[330.450191] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[330.469895] Starting dynamic subtest: pipe-B-plane-3
[330.471869] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[330.485125] Starting dynamic subtest: pipe-B-plane-5
[330.486849] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[330.539035] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SKIP (0.360s)
[330.793886] [087/133] (701s left) kms_joiner (invalid-modeset-force-big-joiner)
[330.979966] Starting subtest: invalid-modeset-force-big-joiner
[330.980758] Starting dynamic subtest: big_joiner_on_last_pipe
[331.194439] Dynamic subtest big_joiner_on_last_pipe: SUCCESS (0.215s)
[331.195295] Subtest invalid-modeset-force-big-joiner: SUCCESS (0.216s)
[331.506437] [088/133] (701s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[331.694950] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[331.697130] Starting dynamic subtest: pipe-A-valid-mode
[337.815334] Dynamic subtest pipe-A-valid-mode: SUCCESS (6.117s)
[337.816844] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SUCCESS (6.121s)
[338.120456] [089/133] (694s left) gem_ctx_shared (single-timeline)
[338.211246] Starting subtest: single-timeline
[338.250510] Subtest single-timeline: SUCCESS (0.038s)
[338.569886] [090/133] (694s left) vgem_basic (unload)
[338.618165] Starting subtest: unload
[367.653787] Subtest unload: SUCCESS (29.035s)
[367.838903] [091/133] (665s left) gem_spin_batch (legacy-resubmit-new)
[367.927363] Starting subtest: legacy-resubmit-new
[367.928294] Starting dynamic subtest: default
[367.959393] Dynamic subtest default: SUCCESS (0.033s)
[367.972789] Starting dynamic subtest: render
[367.973633] Dynamic subtest render: SUCCESS (0.005s)
[367.985535] Starting dynamic subtest: bsd
[367.986445] Dynamic subtest bsd: SUCCESS (0.006s)
[367.998481] Starting dynamic subtest: bsd1
[367.999440] Dynamic subtest bsd1: SUCCESS (0.004s)
[368.010977] Starting dynamic subtest: bsd2
[368.012085] Dynamic subtest bsd2: SUCCESS (0.005s)
[368.023759] Starting dynamic subtest: blt
[368.024784] Dynamic subtest blt: SUCCESS (0.005s)
[368.036140] Starting dynamic subtest: vebox
[368.037172] Dynamic subtest vebox: SUCCESS (0.005s)
[368.038247] Subtest legacy-resubmit-new: SUCCESS (0.071s)
[368.338864] [092/133] (664s left) kms_psr (fbc-pr-dpms)
[368.522603] Subtest fbc-pr-dpms: SKIP (0.000s)
[368.583067] [093/133] (664s left) kms_cursor_crc (cursor-offscreen-128x128)
[368.957490] Starting subtest: cursor-offscreen-128x128
[368.962563] Starting dynamic subtest: pipe-A-DP-3
[371.490625] Dynamic subtest pipe-A-DP-3: SUCCESS (2.527s)
[371.547214] Starting dynamic subtest: pipe-D-DP-3
[373.995819] Dynamic subtest pipe-D-DP-3: SUCCESS (2.459s)
[373.996754] Subtest cursor-offscreen-128x128: SUCCESS (5.038s)
[374.414207] [094/133] (658s left) gem_exec_reloc (basic-cpu)
[374.497170] Subtest basic-cpu: SKIP (0.000s)
[374.590807] [095/133] (658s left) syncobj_wait (invalid-wait-illegal-handle)
[374.669526] Starting subtest: invalid-wait-illegal-handle
[374.670499] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[374.826566] [096/133] (658s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[375.027475] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[378.459993] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (3.433s)
[378.646389] [097/133] (654s left) gem_ctx_param (set-priority-not-supported)
[378.722337] Starting subtest: set-priority-not-supported
[378.724243] Subtest set-priority-not-supported: SKIP (0.000s)
[378.850374] [098/133] (654s left) kms_chamelium_color (ctm-max)
[379.042620] Subtest ctm-max: SKIP (0.000s)
[379.104405] [099/133] (654s left) sriov_basic (enable-vfs-autoprobe-on)
[379.190244] Subtest enable-vfs-autoprobe-on: SKIP (0.000s)
[379.287279] [100/133] (654s left) kms_frontbuffer_tracking (fbc-tiling-y)
[379.476835] Starting subtest: fbc-tiling-y
[379.478421] Subtest fbc-tiling-y: SKIP (0.000s)
[379.655808] [101/133] (653s left) kms_cursor_edge_walk (128x128-left-edge)
[379.835551] Starting subtest: 128x128-left-edge
[379.838095] Starting dynamic subtest: pipe-A-DP-3
[383.323315] Dynamic subtest pipe-A-DP-3: SUCCESS (3.486s)
[383.344985] Starting dynamic subtest: pipe-D-DP-3
[386.657548] Dynamic subtest pipe-D-DP-3: SUCCESS (3.330s)
[386.658497] Subtest 128x128-left-edge: SUCCESS (6.822s)
[386.949824] [102/133] (646s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[387.139423] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[390.031555] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (2.893s)
[390.279728] [103/133] (643s left) kms_debugfs (display-on-read-all)
[390.466763] Starting subtest: display-on-read-all
[390.632619] Subtest display-on-read-all: SUCCESS (0.165s)
[390.939681] [104/133] (642s left) kms_flip (2x-plain-flip-fb-recreate)
[391.122905] Starting subtest: 2x-plain-flip-fb-recreate
[391.138320] Subtest 2x-plain-flip-fb-recreate: SKIP (0.015s)
[391.298242] [105/133] (642s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[391.493101] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[391.494849] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[391.711179] [106/133] (642s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[391.793457] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[391.794366] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[392.000429] [107/133] (642s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[392.190393] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[392.205838] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.015s)
[392.361422] [108/133] (641s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[392.547296] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[392.548192] Starting dynamic subtest: pipe-A-DP-3
[392.556316] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[392.567970] Starting dynamic subtest: pipe-B-DP-3
[392.576177] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[392.587623] Starting dynamic subtest: pipe-C-DP-3
[392.595828] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[392.607530] Starting dynamic subtest: pipe-D-DP-3
[392.617749] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[392.619869] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SKIP (0.007s)
[393.063538] [109/133] (641s left) kms_lease (invalid-create-leases)
[393.251276] Starting subtest: invalid-create-leases
[393.259216] Subtest invalid-create-leases: SUCCESS (0.009s)
[393.454987] [110/133] (640s left) kms_selftest (drm_dp_mst_helper)
[393.507253] Starting subtest: drm_dp_mst_helper
[393.520415] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[393.591811] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.070s)
[393.603661] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[393.701446] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.109s)
[393.736147] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[393.812628] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.105s)
[393.813754] Subtest drm_dp_mst_helper: SUCCESS (0.305s)
[394.042853] [111/133] (640s left) gen7_exec_parse (oacontrol-tracking)
[394.130181] Subtest oacontrol-tracking: SKIP (0.000s)
[394.227909] [112/133] (640s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[394.433789] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[394.435298] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[394.592480] [113/133] (640s left) gem_exec_schedule (thriceslice)
[394.681805] Starting subtest: thriceslice
[394.682769] Starting dynamic subtest: rcs0
[394.713419] Dynamic subtest rcs0: SUCCESS (0.031s)
[394.726597] Starting dynamic subtest: bcs0
[394.765616] Dynamic subtest bcs0: SUCCESS (0.051s)
[394.785432] Starting dynamic subtest: vcs0
[394.803678] Dynamic subtest vcs0: SUCCESS (0.037s)
[394.825646] Starting dynamic subtest: vcs1
[394.841398] Dynamic subtest vcs1: SUCCESS (0.036s)
[394.863482] Starting dynamic subtest: vecs0
[394.880050] Dynamic subtest vecs0: SUCCESS (0.037s)
[394.899295] Starting dynamic subtest: vecs1
[394.917151] Dynamic subtest vecs1: SUCCESS (0.035s)
[394.934276] Starting dynamic subtest: ccs0
[394.972451] Dynamic subtest ccs0: SUCCESS (0.054s)
[394.976674] Subtest thriceslice: SUCCESS (0.292s)
[395.374931] [114/133] (639s left) syncobj_eventfd (invalid-illegal-eventfd)
[395.452484] Starting subtest: invalid-illegal-eventfd
[395.453439] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[395.643408] [115/133] (639s left) kms_psr (psr-sprite-plane-move)
[395.841399] Subtest psr-sprite-plane-move: SKIP (0.000s)
[395.903670] [116/133] (638s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[396.098415] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[396.099308] Starting dynamic subtest: pipe-A-DP-3
[396.107239] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[396.118591] Starting dynamic subtest: pipe-B-DP-3
[396.126870] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[396.138103] Starting dynamic subtest: pipe-C-DP-3
[396.146141] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[396.157635] Starting dynamic subtest: pipe-D-DP-3
[396.168455] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[396.170563] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.009s)
[396.587214] [117/133] (638s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[399.118854] Starting subtest: gem-execbuf-stress-pc8
[399.240895] Subtest gem-execbuf-stress-pc8: SKIP (0.125s)
[399.541903] [118/133] (635s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[399.737031] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[399.738869] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[399.939642] [119/133] (635s left) sysfs_timeslice_duration (duration)
[400.022111] Starting subtest: duration
[400.023042] Starting dynamic subtest: vecs0
[413.186747] Dynamic subtest vecs0: SUCCESS (13.163s)
[413.202598] Starting dynamic subtest: ccs0
[426.323526] Dynamic subtest ccs0: SUCCESS (13.132s)
[426.339722] Starting dynamic subtest: vcs0
[439.481693] Dynamic subtest vcs0: SUCCESS (13.153s)
[439.498157] Starting dynamic subtest: bcs0
[452.623465] Dynamic subtest bcs0: SUCCESS (13.138s)
[452.637406] Starting dynamic subtest: vecs1
[465.779745] Dynamic subtest vecs1: SUCCESS (13.154s)
[465.798715] Starting dynamic subtest: rcs0
[478.943932] Dynamic subtest rcs0: SUCCESS (13.159s)
[478.960217] Starting dynamic subtest: vcs1
[492.108909] Dynamic subtest vcs1: SUCCESS (13.160s)
[492.113526] Subtest duration: SUCCESS (92.088s)
[492.256107] [120/133] (542s left) gem_gpgpu_fill (basic)
[492.339193] Starting subtest: basic
[492.340121] Starting dynamic subtest: smem
[492.370533] Dynamic subtest smem: SUCCESS (0.031s)
[492.384653] Starting dynamic subtest: lmem0
[492.385494] Dynamic subtest lmem0: SUCCESS (0.012s)
[492.386414] Subtest basic: SUCCESS (0.045s)
[492.596611] [121/133] (542s left) perf (gen12-group-concurrent-oa-buffer-read)
[492.847583] Starting subtest: gen12-group-concurrent-oa-buffer-read
[502.892879] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.045s)
[502.955084] [122/133] (532s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[503.145128] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[503.204454] [123/133] (532s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[503.394227] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (0.000s)
[503.453793] [124/133] (531s left) kms_content_protection (dp-mst-type-1)
[503.708337] Starting subtest: dp-mst-type-1
[503.710232] Subtest dp-mst-type-1: SKIP (0.000s)
[503.923805] [125/133] (531s left) kms_pm_lpsp (screens-disabled)
[505.117228] Starting subtest: screens-disabled
[505.118934] Subtest screens-disabled: SKIP (0.000s)
[505.274616] [126/133] (530s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[505.468218] Starting subtest: plane-lut1d-pre-ctm3x4
[505.493369] Starting dynamic subtest: pipe-A-DP-3
[505.875067] Dynamic subtest pipe-A-DP-3: SUCCESS (0.383s)
[506.078633] Starting dynamic subtest: pipe-B-DP-3
[506.413580] Dynamic subtest pipe-B-DP-3: SUCCESS (0.348s)
[506.595124] Starting dynamic subtest: pipe-C-DP-3
[506.930116] Dynamic subtest pipe-C-DP-3: SUCCESS (0.348s)
[507.148454] Starting dynamic subtest: pipe-D-DP-3
[507.484572] Dynamic subtest pipe-D-DP-3: SUCCESS (0.348s)
[507.560548] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (2.092s)
[507.879074] [127/133] (527s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[508.069963] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[508.123154] [128/133] (527s left) kms_vblank (wait-idle-hang)
[508.315284] Starting subtest: wait-idle-hang
[508.316203] Starting dynamic subtest: pipe-A-DP-3
[534.604934] Dynamic subtest pipe-A-DP-3: SUCCESS (26.289s)
[534.620237] Starting dynamic subtest: pipe-D-DP-3
[559.548219] Dynamic subtest pipe-D-DP-3: SUCCESS (24.938s)
[559.549162] Subtest wait-idle-hang: SUCCESS (51.234s)
[559.853999] [129/133] (475s left) gem_mmap_gtt (flink-race)
[559.936175] Subtest flink-race: SKIP (0.000s)
[560.026899] [130/133] (475s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[560.226754] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[560.228401] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[560.420207] [131/133] (475s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[560.698496] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[560.855768] [132/133] (475s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[561.042406] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[561.044153] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[561.163471] [133/133] (474s left) kms_addfb_basic (basic)
[561.244785] Starting subtest: basic
[561.245627] Subtest basic: SUCCESS (0.000s)
[561.509799] Closing watchdogs
results: parsing output: 0/ for test: kms_pipe_crc_basic
results: parsing output: 1/ for test: i915_module_load
results: parsing output: 2/ for test: gem_eio
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: kms_addfb_basic
results: parsing output: 5/ for test: kms_getfb
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: syncobj_wait
results: parsing output: 8/ for test: kms_atomic_interruptible
results: parsing output: 9/ for test: gem_exec_reloc
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_pxp
results: parsing output: 12/ for test: gem_exec_balancer
results: parsing output: 13/ for test: gem_exec_whisper
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_psr
results: parsing output: 18/ for test: gem_close_race
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: kms_cursor_crc
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: gem_sync
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: gem_flink_basic
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_chamelium_hpd
results: parsing output: 27/ for test: gem_exec_fence
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: gem_exec_schedule
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_plane_scaling
results: parsing output: 35/ for test: gem_userptr_blits
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: gem_eio
results: parsing output: 38/ for test: syncobj_wait
results: parsing output: 39/ for test: gem_exec_parallel
results: parsing output: 40/ for test: gem_ccs
results: parsing output: 41/ for test: gem_exec_fence
results: parsing output: 42/ for test: kms_psr
results: parsing output: 43/ for test: syncobj_wait
results: parsing output: 44/ for test: kms_flip
results: parsing output: 45/ for test: kms_cursor_legacy
results: parsing output: 46/ for test: i915_query
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_cursor_legacy
results: parsing output: 49/ for test: gen9_exec_parse
results: parsing output: 50/ for test: kms_addfb_basic
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: gem_linear_blits
results: parsing output: 53/ for test: gem_create
results: parsing output: 54/ for test: syncobj_wait
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_ccs
results: parsing output: 57/ for test: gem_exec_balancer
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_addfb_basic
results: parsing output: 60/ for test: perf
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: api_intel_bb
results: parsing output: 63/ for test: kms_atomic
results: parsing output: 64/ for test: kms_pm_rpm
results: parsing output: 65/ for test: gem_ctx_persistence
results: parsing output: 66/ for test: kms_plane_scaling
results: parsing output: 67/ for test: api_intel_allocator
results: parsing output: 68/ for test: gem_pread
results: parsing output: 69/ for test: gem_exec_schedule
results: parsing output: 70/ for test: gem_ctx_persistence
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: gem_mmap_gtt
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: gem_userptr_blits
results: parsing output: 75/ for test: gem_ctx_param
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: core_setmaster
results: parsing output: 79/ for test: kms_plane
results: parsing output: 80/ for test: kms_flip_scaled_crc
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: gem_render_copy
results: parsing output: 83/ for test: perf_pmu
results: parsing output: 84/ for test: kms_draw_crc
results: parsing output: 85/ for test: kms_plane
results: parsing output: 86/ for test: kms_joiner
results: parsing output: 87/ for test: kms_flip_scaled_crc
results: parsing output: 88/ for test: gem_ctx_shared
results: parsing output: 89/ for test: vgem_basic
results: parsing output: 90/ for test: gem_spin_batch
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: kms_cursor_crc
results: parsing output: 93/ for test: gem_exec_reloc
results: parsing output: 94/ for test: syncobj_wait
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_ctx_param
results: parsing output: 97/ for test: kms_chamelium_color
results: parsing output: 98/ for test: sriov_basic
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_cursor_edge_walk
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_debugfs
results: parsing output: 103/ for test: kms_flip
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: syncobj_wait
results: parsing output: 106/ for test: kms_flip
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: kms_lease
results: parsing output: 109/ for test: kms_selftest
results: parsing output: 110/ for test: gen7_exec_parse
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: gem_exec_schedule
results: parsing output: 113/ for test: syncobj_eventfd
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: i915_pm_rpm
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: sysfs_timeslice_duration
results: parsing output: 119/ for test: gem_gpgpu_fill
results: parsing output: 120/ for test: perf
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: kms_psr2_sf
results: parsing output: 123/ for test: kms_content_protection
results: parsing output: 124/ for test: kms_pm_lpsp
results: parsing output: 125/ for test: kms_color_pipeline
results: parsing output: 126/ for test: kms_psr2_sf
results: parsing output: 127/ for test: kms_vblank
results: parsing output: 128/ for test: gem_mmap_gtt
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_chamelium_edid
results: parsing output: 131/ for test: kms_flip_scaled_crc
results: parsing output: 132/ for test: kms_addfb_basic
Done.