[70.290278] Initializing watchdogs
[70.290346]   /dev/watchdog0
[70.311794] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[70.323379] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[70.327214] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[70.329609] [001/156] (960s left) prime_vgem (basic-read)
[70.456748] Starting subtest: basic-read
[70.462813] Subtest basic-read: SKIP (0.007s)
[70.614041] [FACT prime_vgem (basic-read)] new: kernel.kmod_is_loaded.vgem: true
[70.615738] [002/156] (960s left) gem_ctx_isolation (clean)
[70.710711] Starting subtest: clean
[70.711604] Starting dynamic subtest: rcs0
[70.846813] Dynamic subtest rcs0: SUCCESS (0.134s)
[70.856378] Starting dynamic subtest: bcs0
[70.966827] Dynamic subtest bcs0: SUCCESS (0.118s)
[70.975558] Starting dynamic subtest: vcs0
[71.084690] Dynamic subtest vcs0: SUCCESS (0.117s)
[71.093208] Starting dynamic subtest: vcs1
[71.199543] Dynamic subtest vcs1: SUCCESS (0.113s)
[71.208262] Starting dynamic subtest: vecs0
[71.292929] Dynamic subtest vecs0: SUCCESS (0.092s)
[71.302748] Starting dynamic subtest: vecs1
[71.399333] Dynamic subtest vecs1: SUCCESS (0.104s)
[71.408050] Starting dynamic subtest: ccs0
[71.518217] Dynamic subtest ccs0: SUCCESS (0.118s)
[71.519348] Subtest clean: SUCCESS (0.799s)
[71.808373] [003/156] (959s left) sw_sync (sync_merge_same)
[71.857941] Starting subtest: sync_merge_same
[71.858877] Subtest sync_merge_same: SUCCESS (0.000s)
[71.932025] [004/156] (959s left) syncobj_timeline (wait-for-submit-delayed-submit)
[72.016473] Starting subtest: wait-for-submit-delayed-submit
[72.120622] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s)
[72.296944] [005/156] (958s left) gem_workarounds (reset-fd)
[72.400683] Starting subtest: reset-fd
[72.614817] Subtest reset-fd: SUCCESS (0.212s)
[72.840110] [006/156] (958s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-blt)
[73.043614] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-blt
[73.732862] Subtest fbchdr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (0.684s)
[73.991670] [007/156] (957s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[74.192168] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[74.193923] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[74.349437] [008/156] (956s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[74.431211] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[74.543721] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.106s)
[74.643640] [009/156] (956s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[74.854488] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[74.856258] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[75.010959] [010/156] (956s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[75.101257] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[75.204642] [011/156] (956s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[75.397776] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[75.398692] Starting dynamic subtest: pipe-A-DP-3
[75.408321] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[75.418262] Starting dynamic subtest: pipe-B-DP-3
[75.427860] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[75.437010] Starting dynamic subtest: pipe-C-DP-3
[75.446163] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[75.455565] Starting dynamic subtest: pipe-D-DP-3
[75.467530] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[75.469531] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SKIP (0.004s)
[75.919914] [012/156] (955s left) perf_pmu (rc6)
[75.996166] Starting subtest: rc6
[75.997234] Starting dynamic subtest: gt0
[82.379258] Dynamic subtest gt0: SUCCESS (6.360s)
[82.390865] Starting dynamic subtest: runtime-pm-gt0
[90.924627] Dynamic subtest runtime-pm-gt0: SUCCESS (8.533s)
[90.935108] Starting dynamic subtest: runtime-pm-long-gt0
[103.620267] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.683s)
[103.630543] Starting dynamic subtest: other-idle-gt0
[103.632415] Dynamic subtest other-idle-gt0: SKIP (0.000s)
[103.633327] Subtest rc6: SUCCESS (27.580s)
[103.826185] [013/156] (927s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-blt)
[104.029546] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-blt
[104.031227] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[104.125122] [014/156] (927s left) syncobj_timeline (multi-wait-all-available-signaled)
[104.205106] Starting subtest: multi-wait-all-available-signaled
[104.206059] Subtest multi-wait-all-available-signaled: SUCCESS (0.001s)
[104.296351] [015/156] (927s left) kms_pm_rpm (dpms-non-lpsp)
[106.051342] Starting subtest: dpms-non-lpsp
[106.306067] Subtest dpms-non-lpsp: SUCCESS (0.256s)
[106.507108] [016/156] (925s left) kms_flip (flip-vs-panning)
[106.698281] Starting subtest: flip-vs-panning
[106.702258] Starting dynamic subtest: A-DP3
[114.585912] Dynamic subtest A-DP3: SUCCESS (7.879s)
[114.631327] Starting dynamic subtest: B-DP3
[122.416968] Dynamic subtest B-DP3: SUCCESS (7.825s)
[122.460986] Starting dynamic subtest: C-DP3
[130.254309] Dynamic subtest C-DP3: SUCCESS (7.832s)
[130.271554] Starting dynamic subtest: D-DP3
[138.056990] Dynamic subtest D-DP3: SUCCESS (7.798s)
[138.064799] Subtest flip-vs-panning: SUCCESS (31.356s)
[138.398037] [017/156] (893s left) fbdev (eof)
[138.452940] Starting subtest: eof
[138.454048] Subtest eof: SUCCESS (0.000s)
[138.506212] [018/156] (893s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[138.690629] Starting subtest: compare-crc-sanitycheck-xr24
[138.691522] Starting dynamic subtest: pipe-A-DP-3
[139.262160] Dynamic subtest pipe-A-DP-3: SUCCESS (0.570s)
[139.272781] Starting dynamic subtest: pipe-B-DP-3
[139.748370] Dynamic subtest pipe-B-DP-3: SUCCESS (0.485s)
[139.759740] Starting dynamic subtest: pipe-C-DP-3
[140.207099] Dynamic subtest pipe-C-DP-3: SUCCESS (0.456s)
[140.223555] Starting dynamic subtest: pipe-D-DP-3
[140.689130] Dynamic subtest pipe-D-DP-3: SUCCESS (0.481s)
[140.690052] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.998s)
[140.921683] [019/156] (891s left) api_intel_bb (blit-noreloc-keep-cache)
[141.002033] Starting subtest: blit-noreloc-keep-cache
[141.037798] Subtest blit-noreloc-keep-cache: SUCCESS (0.037s)
[141.181706] [020/156] (890s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[141.376853] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[141.378538] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[141.445391] [021/156] (890s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-shrfb-msflip-blt)
[141.645637] Starting subtest: fbchdr-2p-scndscrn-shrfb-msflip-blt
[141.647385] Subtest fbchdr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[141.730140] [022/156] (890s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[141.929403] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[141.931117] Subtest hdr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[142.013519] [023/156] (890s left) gem_softpin (evict-active-interruptible)
[142.101396] Starting subtest: evict-active-interruptible
[142.122755] Subtest evict-active-interruptible: SUCCESS (0.021s)
[142.210349] [024/156] (890s left) gem_mmap_gtt (medium-copy-odd)
[142.294030] Subtest medium-copy-odd: SKIP (0.000s)
[142.358958] [025/156] (890s left) vgem_basic (bad-fence)
[142.414993] Starting subtest: bad-fence
[142.415916] Subtest bad-fence: SUCCESS (0.000s)
[142.461961] [026/156] (889s left) syncobj_wait (wait-any-interrupted)
[142.541148] Starting subtest: wait-any-interrupted
[142.642624] Subtest wait-any-interrupted: SUCCESS (0.101s)
[142.758512] [027/156] (889s left) kms_psr (psr-sprite-plane-move)
[142.949495] Subtest psr-sprite-plane-move: SKIP (0.000s)
[143.009152] [028/156] (889s left) kms_rotation_crc (primary-rotation-180)
[143.201497] Starting subtest: primary-rotation-180
[153.721908] Subtest primary-rotation-180: SUCCESS (10.518s)
[154.069129] [029/156] (878s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[154.261201] Starting subtest: short-flip-before-cursor-atomic-transitions
[155.307495] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (1.046s)
[155.539057] [030/156] (877s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-pwrite)
[155.732802] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-pwrite
[155.734447] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[155.809129] [031/156] (876s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[155.890972] Starting subtest: invalid-smem-bo-on-discrete
[155.892136] Subtest invalid-smem-bo-on-discrete: SUCCESS (0.000s)
[156.075652] [032/156] (876s left) kms_flip (basic-flip-vs-modeset)
[156.267321] Starting subtest: basic-flip-vs-modeset
[156.271445] Starting dynamic subtest: A-DP3
[157.174413] Dynamic subtest A-DP3: SUCCESS (0.902s)
[157.197512] Starting dynamic subtest: B-DP3
[158.083346] Dynamic subtest B-DP3: SUCCESS (0.906s)
[158.094597] Starting dynamic subtest: C-DP3
[158.798940] Dynamic subtest C-DP3: SUCCESS (0.715s)
[158.821478] Starting dynamic subtest: D-DP3
[159.697255] Dynamic subtest D-DP3: SUCCESS (0.896s)
[159.700669] Subtest basic-flip-vs-modeset: SUCCESS (3.434s)
[159.985370] [033/156] (872s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[160.182056] Starting subtest: fbc-rgb101010-draw-render
[161.114193] Subtest fbc-rgb101010-draw-render: SUCCESS (0.932s)
[161.298645] [034/156] (871s left) syncobj_wait (wait-any-complex)
[161.385760] Starting subtest: wait-any-complex
[161.441394] Subtest wait-any-complex: SUCCESS (0.063s)
[161.502092] [035/156] (871s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[161.583143] Starting subtest: multi-wait-for-submit-submitted-signaled
[161.584028] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[161.685317] [036/156] (871s left) gem_exec_fence (syncobj-timeline-export)
[162.334756] Starting subtest: syncobj-timeline-export
[162.369228] Subtest syncobj-timeline-export: SUCCESS (0.039s)
[162.653535] [037/156] (870s left) prime_vgem (shrink)
[162.751449] Starting subtest: shrink
[162.758181] Subtest shrink: SUCCESS (0.006s)
[162.850953] [038/156] (870s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[163.053588] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[163.055391] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[163.127554] [039/156] (870s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-pwrite)
[163.323757] Starting subtest: fbchdr-rgb101010-draw-pwrite
[163.786680] Subtest fbchdr-rgb101010-draw-pwrite: SUCCESS (0.463s)
[163.950820] [040/156] (869s left) syncobj_timeline (signal-point-0)
[164.032255] Starting subtest: signal-point-0
[164.033421] Subtest signal-point-0: SUCCESS (0.000s)
[164.134157] [041/156] (869s left) gem_exec_reloc (basic-write-wc-active)
[164.224260] Subtest basic-write-wc-active: SKIP (0.000s)
[164.294863] [042/156] (869s left) i915_pm_rpm (system-suspend-devices)
[166.012200] Starting subtest: system-suspend-devices
[174.064949] Subtest system-suspend-devices: SUCCESS (8.057s)
[195.442552] [043/156] (859s left) perf_pmu (most-busy-check-all)
[195.518493] Starting subtest: most-busy-check-all
[195.519448] Starting dynamic subtest: rcs0
[196.102423] Dynamic subtest rcs0: SUCCESS (0.584s)
[196.116139] Starting dynamic subtest: bcs0
[196.658626] Dynamic subtest bcs0: SUCCESS (0.555s)
[196.670916] Starting dynamic subtest: vcs0
[197.207748] Dynamic subtest vcs0: SUCCESS (0.549s)
[197.222063] Starting dynamic subtest: vcs1
[197.764297] Dynamic subtest vcs1: SUCCESS (0.555s)
[197.780054] Starting dynamic subtest: vecs0
[198.321127] Dynamic subtest vecs0: SUCCESS (0.554s)
[198.337213] Starting dynamic subtest: vecs1
[198.875409] Dynamic subtest vecs1: SUCCESS (0.552s)
[198.888149] Starting dynamic subtest: ccs0
[199.428539] Dynamic subtest ccs0: SUCCESS (0.552s)
[199.429619] Subtest most-busy-check-all: SUCCESS (3.911s)
[199.534811] [044/156] (855s left) kms_color (ctm-signed)
[199.733465] Starting subtest: ctm-signed
[199.734411] Starting dynamic subtest: pipe-A-DP-3
[201.193415] Dynamic subtest pipe-A-DP-3: SUCCESS (1.459s)
[201.217694] Starting dynamic subtest: pipe-B-DP-3
[202.395422] Dynamic subtest pipe-B-DP-3: SUCCESS (1.199s)
[202.412584] Starting dynamic subtest: pipe-C-DP-3
[203.562090] Dynamic subtest pipe-C-DP-3: SUCCESS (1.167s)
[203.576225] Starting dynamic subtest: pipe-D-DP-3
[204.752990] Dynamic subtest pipe-D-DP-3: SUCCESS (1.190s)
[204.754095] Subtest ctm-signed: SUCCESS (5.020s)
[204.986402] [045/156] (849s left) i915_drm_fdinfo (memory-info-active)
[205.059818] Starting subtest: memory-info-active
[205.060781] Starting dynamic subtest: lmem0
[208.584513] Dynamic subtest lmem0: SUCCESS (3.523s)
[208.604459] Starting dynamic subtest: smem0
[212.734616] Dynamic subtest smem0: SUCCESS (4.138s)
[212.735793] Subtest memory-info-active: SUCCESS (7.667s)
[212.793056] [046/156] (842s left) kms_flip (2x-flip-vs-wf_vblank)
[212.984105] Starting subtest: 2x-flip-vs-wf_vblank
[212.999520] Subtest 2x-flip-vs-wf_vblank: SKIP (0.015s)
[213.076370] [047/156] (841s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[213.269131] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[213.270010] Starting dynamic subtest: pipe-A-valid-mode
[215.995445] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.723s)
[215.996972] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.726s)
[216.244289] [048/156] (838s left) kms_frontbuffer_tracking (fbchdr-1p-shrfb-fliptrack-mmap-gtt)
[216.439762] Starting subtest: fbchdr-1p-shrfb-fliptrack-mmap-gtt
[216.441401] Subtest fbchdr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[216.550204] [049/156] (838s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[216.741902] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[216.742827] Starting dynamic subtest: pipe-A-DP-3
[217.338043] Dynamic subtest pipe-A-DP-3: SUCCESS (0.592s)
[217.350257] Starting dynamic subtest: pipe-B-DP-3
[218.017934] Dynamic subtest pipe-B-DP-3: SUCCESS (0.678s)
[218.030360] Starting dynamic subtest: pipe-C-DP-3
[218.715547] Dynamic subtest pipe-C-DP-3: SUCCESS (0.696s)
[218.727713] Starting dynamic subtest: pipe-D-DP-3
[219.429532] Dynamic subtest pipe-D-DP-3: SUCCESS (0.712s)
[219.430580] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SUCCESS (2.684s)
[219.690707] [050/156] (835s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-render)
[219.890273] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-render
[219.892039] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[219.974417] [051/156] (835s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[220.169193] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[220.236367] [052/156] (834s left) kms_cursor_edge_walk (256x256-left-edge)
[220.430192] Starting subtest: 256x256-left-edge
[220.431148] Starting dynamic subtest: pipe-A-DP-3
[223.918177] Dynamic subtest pipe-A-DP-3: SUCCESS (3.486s)
[223.938026] Starting dynamic subtest: pipe-D-DP-3
[227.270920] Dynamic subtest pipe-D-DP-3: SUCCESS (3.351s)
[227.271963] Subtest 256x256-left-edge: SUCCESS (6.841s)
[227.498807] [053/156] (827s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-render)
[227.697009] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-render
[227.698886] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[227.773865] [054/156] (827s left) gem_fenced_exec_thrash (2-spare-fences)
[227.863214] Subtest 2-spare-fences: SKIP (0.000s)
[227.937850] [055/156] (827s left) gem_render_copy (yf-tiled-to-vebox-linear)
[228.025874] Starting subtest: yf-tiled-to-vebox-linear
[228.028125] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[228.226454] [056/156] (827s left) gem_pxp (create-regular-buffer)
[230.837434] Starting subtest: create-regular-buffer
[230.839458] Subtest create-regular-buffer: SKIP (0.000s)
[230.890370] [057/156] (824s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[231.091453] Starting subtest: x-tiled-32bpp-rotate-180
[232.891568] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.799s)
[233.013063] [058/156] (822s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[233.212199] Starting subtest: cursorA-vs-flipB-atomic
[233.214059] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[233.274710] [059/156] (822s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-blt)
[233.479300] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-blt
[233.481164] Subtest psrhdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[233.558896] [060/156] (822s left) gen3_render_mixed_blits
[233.705449] [061/156] (822s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[233.916608] Starting subtest: y-tiled-64bpp-rotate-180
[233.918403] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[233.991087] [062/156] (821s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[234.076174] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[234.161472] [063/156] (821s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[234.356205] Subtest psr2-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[234.421602] [064/156] (821s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-shrfb-plflip-blt)
[234.618043] Starting subtest: fbcpsrhdr-2p-scndscrn-shrfb-plflip-blt
[234.619587] Subtest fbcpsrhdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[234.714460] [065/156] (821s left) kms_frontbuffer_tracking (fbcpsrhdr-slowdraw)
[234.908070] Starting subtest: fbcpsrhdr-slowdraw
[234.909830] Subtest fbcpsrhdr-slowdraw: SKIP (0.000s)
[234.991521] [066/156] (821s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[235.075245] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[235.160281] [067/156] (820s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[235.349330] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[235.350171] Starting dynamic subtest: pipe-A
[236.973708] Dynamic subtest pipe-A: SUCCESS (1.625s)
[236.999409] Starting dynamic subtest: pipe-B
[238.704556] Dynamic subtest pipe-B: SUCCESS (1.728s)
[238.719163] Starting dynamic subtest: pipe-C
[239.018221] Dynamic subtest pipe-C: SUCCESS (0.313s)
[239.049891] Starting dynamic subtest: pipe-D
[239.347546] Dynamic subtest pipe-D: SUCCESS (0.327s)
[239.348439] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (4.000s)
[239.624636] [068/156] (816s left) kms_plane_lowres (tiling-y)
[239.819433] Starting subtest: tiling-y
[239.821251] Subtest tiling-y: SKIP (0.000s)
[239.877378] [069/156] (816s left) kms_sequence (get-forked-busy)
[240.074970] Starting subtest: get-forked-busy
[240.077426] Starting dynamic subtest: pipe-A-DP-3
[242.728847] Dynamic subtest pipe-A-DP-3: SUCCESS (2.651s)
[242.757023] Starting dynamic subtest: pipe-B-DP-3
[245.341490] Dynamic subtest pipe-B-DP-3: SUCCESS (2.608s)
[245.361118] Starting dynamic subtest: pipe-C-DP-3
[247.908698] Dynamic subtest pipe-C-DP-3: SUCCESS (2.563s)
[247.964478] Starting dynamic subtest: pipe-D-DP-3
[250.532685] Dynamic subtest pipe-D-DP-3: SUCCESS (2.617s)
[250.534414] Subtest get-forked-busy: SUCCESS (10.456s)
[250.838828] [070/156] (805s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[251.035452] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[251.037201] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[251.105103] [071/156] (805s left) kms_psr (psr2-dpms)
[251.295498] Subtest psr2-dpms: SKIP (0.000s)
[251.352408] [072/156] (805s left) kms_chamelium_frames (dp-crc-fast)
[251.635272] Subtest dp-crc-fast: SKIP (0.000s)
[251.824589] [073/156] (804s left) kms_psr (psr-primary-blt)
[252.019269] Subtest psr-primary-blt: SKIP (0.000s)
[252.084091] [074/156] (804s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-indfb-plflip-blt)
[252.278425] Starting subtest: psrhdr-2p-scndscrn-indfb-plflip-blt
[252.280212] Subtest psrhdr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[252.368842] [075/156] (804s left) kms_frontbuffer_tracking (hdr-1p-primscrn-shrfb-pgflip-blt)
[252.566299] Starting subtest: hdr-1p-primscrn-shrfb-pgflip-blt
[253.350107] Subtest hdr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (0.784s)
[253.502551] [076/156] (803s left) gem_exec_whisper (basic-fds-priority)
[253.594523] Starting subtest: basic-fds-priority
[276.001860] Subtest basic-fds-priority: SUCCESS (22.404s)
[276.169294] [077/156] (780s left) kms_hdr (static-toggle-dpms)
[276.361968] Starting subtest: static-toggle-dpms
[276.364304] Starting dynamic subtest: pipe-A-DP-3-XRGB2101010
[281.714694] Dynamic subtest pipe-A-DP-3-XRGB2101010: SUCCESS (5.350s)
[281.784998] Starting dynamic subtest: pipe-A-DP-3-XRGB16161616F
[286.814973] Dynamic subtest pipe-A-DP-3-XRGB16161616F: SUCCESS (5.069s)
[286.828437] Subtest static-toggle-dpms: SUCCESS (10.465s)
[287.133483] [078/156] (769s left) prime_mmap (test_correct_cpu_write)
[287.214964] Starting subtest: test_correct_cpu_write
[287.215859] Starting dynamic subtest: test_correct_cpu_write-smem
[287.216777] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[287.229842] Starting dynamic subtest: test_correct_cpu_write-lmem0
[287.231028] Dynamic subtest test_correct_cpu_write-lmem0: SUCCESS (0.000s)
[287.232179] Subtest test_correct_cpu_write: SUCCESS (0.003s)
[287.317550] [079/156] (769s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[287.513253] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[287.515076] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[287.618092] [080/156] (769s left) gem_ctx_shared (disjoint-timelines)
[287.711255] Starting subtest: disjoint-timelines
[287.755424] Subtest disjoint-timelines: SUCCESS (0.044s)
[288.032095] [081/156] (768s left) kms_frontbuffer_tracking (hdr-rgb565-draw-mmap-wc)
[288.227049] Starting subtest: hdr-rgb565-draw-mmap-wc
[288.228684] Subtest hdr-rgb565-draw-mmap-wc: SKIP (0.000s)
[288.309595] [082/156] (768s left) gem_exec_schedule (submit-late-slice)
[288.412332] Starting subtest: submit-late-slice
[288.413270] Starting dynamic subtest: rcs0
[288.491411] Dynamic subtest rcs0: SUCCESS (0.079s)
[288.505919] Starting dynamic subtest: bcs0
[288.545688] Dynamic subtest bcs0: SUCCESS (0.053s)
[288.560387] Starting dynamic subtest: vcs0
[288.598064] Dynamic subtest vcs0: SUCCESS (0.051s)
[288.612529] Starting dynamic subtest: vcs1
[288.649518] Dynamic subtest vcs1: SUCCESS (0.050s)
[288.663722] Starting dynamic subtest: vecs0
[288.700396] Dynamic subtest vecs0: SUCCESS (0.050s)
[288.715217] Starting dynamic subtest: vecs1
[288.752047] Dynamic subtest vecs1: SUCCESS (0.050s)
[288.767006] Starting dynamic subtest: ccs0
[288.807261] Dynamic subtest ccs0: SUCCESS (0.054s)
[288.808173] Subtest submit-late-slice: SUCCESS (0.395s)
[289.194695] [083/156] (767s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[289.386471] Starting subtest: flip-vs-cursor-varying-size
[302.285175] Subtest flip-vs-cursor-varying-size: SUCCESS (12.899s)
[302.515980] [084/156] (754s left) kms_big_fb (linear-32bpp-rotate-270)
[302.721528] Starting subtest: linear-32bpp-rotate-270
[302.784373] Subtest linear-32bpp-rotate-270: SKIP (0.062s)
[302.911558] [085/156] (754s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[303.109970] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[305.334601] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (2.225s)
[305.472851] [086/156] (751s left) api_intel_bb (destroy-bb)
[305.553641] Starting subtest: destroy-bb
[305.592450] Subtest destroy-bb: SUCCESS (0.039s)
[305.685534] [087/156] (751s left) i915_query (query-topology-garbage-items)
[305.765485] Starting subtest: query-topology-garbage-items
[305.766426] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[305.835018] [088/156] (751s left) gem_exec_reloc (basic-write-gtt)
[305.922981] Subtest basic-write-gtt: SKIP (0.000s)
[306.014866] [089/156] (751s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[306.297603] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[306.489485] [090/156] (751s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[306.575893] Subtest no-spare-fences-busy: SKIP (0.000s)
[306.644128] [091/156] (751s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-pwrite)
[306.846254] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-pwrite
[306.848060] Subtest psrhdr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[306.929434] [092/156] (750s left) gem_sync (basic-store-each)
[307.023697] Starting subtest: basic-store-each
[310.044415] Subtest basic-store-each: SUCCESS (3.020s)
[310.283346] [093/156] (747s left) gem_exec_whisper (basic-sync-all)
[310.378575] Starting subtest: basic-sync-all
[315.938409] Subtest basic-sync-all: SUCCESS (5.558s)
[316.160236] [094/156] (741s left) gem_userptr_blits (nohangcheck)
[316.259807] Starting subtest: nohangcheck
[316.578872] Subtest nohangcheck: SUCCESS (0.319s)
[316.691564] [095/156] (741s left) kms_cursor_crc (cursor-offscreen-64x64)
[317.026464] Starting subtest: cursor-offscreen-64x64
[317.031505] Starting dynamic subtest: pipe-A-DP-3
[319.577408] Dynamic subtest pipe-A-DP-3: SUCCESS (2.543s)
[319.630357] Starting dynamic subtest: pipe-D-DP-3
[322.131094] Dynamic subtest pipe-D-DP-3: SUCCESS (2.512s)
[322.132193] Subtest cursor-offscreen-64x64: SUCCESS (5.104s)
[322.554788] [096/156] (735s left) kms_prop_blob (blob-multiple)
[322.636690] Starting subtest: blob-multiple
[322.671357] Subtest blob-multiple: SUCCESS (0.036s)
[322.766152] [097/156] (735s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[322.971414] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[324.111572] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (1.139s)
[324.333379] [098/156] (733s left) gem_exec_params (invalid-fence-in-submit)
[324.420476] Starting subtest: invalid-fence-in-submit
[324.425579] Subtest invalid-fence-in-submit: SUCCESS (0.003s)
[324.562343] [099/156] (733s left) gem_mmap_gtt (pf-nonblock)
[324.642235] Subtest pf-nonblock: SKIP (0.000s)
[324.710582] [100/156] (733s left) syncobj_wait (multi-wait-all-submitted)
[324.789932] Starting subtest: multi-wait-all-submitted
[324.900055] Subtest multi-wait-all-submitted: SUCCESS (0.108s)
[324.966341] [101/156] (733s left) gem_create (busy-create)
[325.050384] Starting subtest: busy-create
[325.051292] Starting dynamic subtest: lmem0
[357.336505] Dynamic subtest lmem0: SUCCESS (32.284s)
[357.352200] Starting dynamic subtest: smem0
[389.591299] Dynamic subtest smem0: SUCCESS (32.251s)
[389.592284] Subtest busy-create: SUCCESS (64.538s)
[389.792624] [102/156] (668s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[389.985222] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[390.050606] [103/156] (668s left) kms_feature_discovery (display-2x)
[390.242470] Starting subtest: display-2x
[390.244283] Subtest display-2x: SKIP (0.000s)
[390.302450] [104/156] (668s left) gem_exec_balancer (busy)
[390.394990] Starting subtest: busy
[391.326418] Subtest busy: SUCCESS (0.931s)
[391.702238] [105/156] (666s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[391.785543] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[391.893259] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.105s)
[391.954714] [106/156] (666s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[392.151324] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[392.153058] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[392.236488] [107/156] (666s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-indfb-plflip-blt)
[392.434275] Starting subtest: fbchdr-2p-primscrn-indfb-plflip-blt
[392.436055] Subtest fbchdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[392.521531] [108/156] (666s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[392.723611] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[392.725396] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[392.803226] [109/156] (666s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[393.000644] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-mmap-cpu
[393.362257] Subtest hdr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (0.361s)
[393.516469] [110/156] (665s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[393.711678] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[393.713439] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[393.788380] [111/156] (665s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[393.981012] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs
[393.983439] Starting dynamic subtest: pipe-A-DP-3
[393.992278] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[394.005801] Starting dynamic subtest: pipe-B-DP-3
[394.014413] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[394.027568] Starting dynamic subtest: pipe-C-DP-3
[394.036344] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[394.049325] Starting dynamic subtest: pipe-D-DP-3
[394.060342] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[394.062525] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.007s)
[394.464706] [112/156] (664s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[394.559513] Starting subtest: legacy-engines-hostile-preempt
[394.560429] Starting dynamic subtest: render
[394.662260] Dynamic subtest render: SUCCESS (0.102s)
[394.677419] Starting dynamic subtest: bsd1
[394.705320] Dynamic subtest bsd1: SUCCESS (0.041s)
[394.723311] Starting dynamic subtest: bsd2
[394.749451] Dynamic subtest bsd2: SUCCESS (0.042s)
[394.765709] Starting dynamic subtest: blt
[394.794375] Dynamic subtest blt: SUCCESS (0.043s)
[394.810499] Starting dynamic subtest: vebox
[394.838446] Dynamic subtest vebox: SUCCESS (0.042s)
[394.839417] Subtest legacy-engines-hostile-preempt: SUCCESS (0.280s)
[394.984227] [113/156] (664s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[395.182922] Starting subtest: fbc-modesetfrombusy
[396.669468] Subtest fbc-modesetfrombusy: SUCCESS (1.487s)
[396.802907] [114/156] (662s left) kms_atomic (plane-primary-legacy)
[396.997544] Starting subtest: plane-primary-legacy
[396.998439] Starting dynamic subtest: pipe-A-DP-3
[397.949136] Dynamic subtest pipe-A-DP-3: SUCCESS (0.951s)
[397.950256] Subtest plane-primary-legacy: SUCCESS (0.953s)
[398.180243] [115/156] (661s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-plflip-blt)
[398.375123] Starting subtest: psrhdr-2p-scndscrn-shrfb-plflip-blt
[398.376933] Subtest psrhdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[398.474806] [116/156] (660s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[398.664722] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[398.667270] Starting dynamic subtest: pipe-A-DP-3
[398.670832] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[398.683926] Starting dynamic subtest: pipe-B-DP-3
[398.687392] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[398.700225] Starting dynamic subtest: pipe-C-DP-3
[398.703886] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[398.716570] Starting dynamic subtest: pipe-D-DP-3
[398.720597] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[398.722845] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SKIP (0.007s)
[399.145042] [117/156] (660s left) gem_softpin (evict-prime)
[399.233438] Starting subtest: evict-prime
[399.234390] Starting dynamic subtest: rcs0
[400.470590] Dynamic subtest rcs0: SUCCESS (1.237s)
[400.486019] Starting dynamic subtest: bcs0
[401.658331] Dynamic subtest bcs0: SUCCESS (1.186s)
[401.675230] Starting dynamic subtest: vcs0
[402.831611] Dynamic subtest vcs0: SUCCESS (1.172s)
[402.851559] Starting dynamic subtest: vcs1
[403.985657] Dynamic subtest vcs1: SUCCESS (1.153s)
[404.001046] Starting dynamic subtest: vecs0
[405.156316] Dynamic subtest vecs0: SUCCESS (1.169s)
[405.171729] Starting dynamic subtest: vecs1
[406.328535] Dynamic subtest vecs1: SUCCESS (1.171s)
[406.344791] Starting dynamic subtest: ccs0
[407.476337] Dynamic subtest ccs0: SUCCESS (1.147s)
[407.491217] Starting dynamic subtest: all
[408.673394] Dynamic subtest all: SUCCESS (1.196s)
[408.674625] Subtest evict-prime: SUCCESS (9.440s)
[408.741812] [118/156] (650s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[408.835665] Starting subtest: map-fixed-invalidate-overlap
[408.838237] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[408.952071] [119/156] (650s left) gem_exec_capture (capture-recoverable)
[409.047439] Starting subtest: capture-recoverable
[409.051350] Subtest capture-recoverable: SUCCESS (0.004s)
[409.170218] [120/156] (650s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-indfb-msflip-blt)
[409.366292] Starting subtest: psrhdr-1p-primscrn-indfb-msflip-blt
[409.368129] Subtest psrhdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[409.449909] [121/156] (650s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[409.647244] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[409.648921] Subtest psr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[409.738227] [122/156] (649s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[409.932302] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.000s)
[409.998555] [123/156] (649s left) kms_psr (pr-cursor-mmap-cpu)
[410.189630] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[410.248415] [124/156] (649s left) gem_exec_await (wide-all)
[410.554435] Starting subtest: wide-all
[434.841399] Subtest wide-all: SUCCESS (24.286s)
[435.028474] [125/156] (624s left) kms_content_protection (dp-mst-type-1)
[435.343639] Starting subtest: dp-mst-type-1
[435.345448] Subtest dp-mst-type-1: SKIP (0.000s)
[435.443216] [126/156] (624s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-pwrite)
[435.643059] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-pwrite
[435.644800] Subtest hdr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[435.721757] [127/156] (624s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[435.918548] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[435.920279] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[436.006716] [128/156] (624s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[436.101550] Starting subtest: multi-wait-all-for-submit-submitted
[436.202633] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.101s)
[436.289075] [129/156] (623s left) gem_exec_schedule (preempt-other-chain)
[436.391157] Starting subtest: preempt-other-chain
[436.392190] Starting dynamic subtest: rcs0
[436.869450] Dynamic subtest rcs0: SUCCESS (0.477s)
[436.883442] Starting dynamic subtest: bcs0
[437.318188] Dynamic subtest bcs0: SUCCESS (0.448s)
[437.332135] Starting dynamic subtest: vcs0
[437.764869] Dynamic subtest vcs0: SUCCESS (0.446s)
[437.778705] Starting dynamic subtest: vcs1
[438.219297] Dynamic subtest vcs1: SUCCESS (0.453s)
[438.233556] Starting dynamic subtest: vecs0
[438.664309] Dynamic subtest vecs0: SUCCESS (0.444s)
[438.678648] Starting dynamic subtest: vecs1
[439.109955] Dynamic subtest vecs1: SUCCESS (0.445s)
[439.124077] Starting dynamic subtest: ccs0
[439.557518] Dynamic subtest ccs0: SUCCESS (0.446s)
[439.558569] Subtest preempt-other-chain: SUCCESS (3.167s)
[439.907954] [130/156] (620s left) perf_pmu (busy-accuracy-2)
[439.983523] Starting subtest: busy-accuracy-2
[439.984432] Starting dynamic subtest: rcs0
[443.054589] Dynamic subtest rcs0: SUCCESS (3.069s)
[443.068855] Starting dynamic subtest: bcs0
[446.126564] Dynamic subtest bcs0: SUCCESS (3.070s)
[446.140724] Starting dynamic subtest: vcs0
[449.199495] Dynamic subtest vcs0: SUCCESS (3.071s)
[449.213498] Starting dynamic subtest: vcs1
[452.270389] Dynamic subtest vcs1: SUCCESS (3.069s)
[452.284755] Starting dynamic subtest: vecs0
[455.340292] Dynamic subtest vecs0: SUCCESS (3.068s)
[455.354540] Starting dynamic subtest: vecs1
[458.405253] Dynamic subtest vecs1: SUCCESS (3.063s)
[458.421112] Starting dynamic subtest: ccs0
[461.476708] Dynamic subtest ccs0: SUCCESS (3.070s)
[461.477619] Subtest busy-accuracy-2: SUCCESS (21.491s)
[461.595105] [131/156] (598s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[461.804168] Starting subtest: 4-tiled-8bpp-rotate-270
[461.855724] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.051s)
[461.974888] [132/156] (598s left) i915_pciid
[462.164747] [133/156] (598s left) gem_eio (in-flight-1us)
[462.485499] Starting subtest: in-flight-1us
[467.596960] Subtest in-flight-1us: SUCCESS (5.112s)
[467.775958] [134/156] (592s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[467.973238] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[470.907197] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (2.934s)
[471.083398] [135/156] (589s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[471.276765] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[471.279297] Starting dynamic subtest: pipe-A-DP-3
[471.295201] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[471.309281] Starting dynamic subtest: pipe-B-DP-3
[471.317936] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[471.331599] Starting dynamic subtest: pipe-C-DP-3
[471.342359] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[471.356013] Starting dynamic subtest: pipe-D-DP-3
[471.367534] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[471.369521] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.007s)
[471.741949] [136/156] (588s left) kms_cursor_crc (cursor-sliding-256x256)
[472.166380] Starting subtest: cursor-sliding-256x256
[472.171543] Starting dynamic subtest: pipe-A-DP-3
[476.639663] Dynamic subtest pipe-A-DP-3: SUCCESS (4.467s)
[476.697462] Starting dynamic subtest: pipe-D-DP-3
[481.076110] Dynamic subtest pipe-D-DP-3: SUCCESS (4.390s)
[481.077190] Subtest cursor-sliding-256x256: SUCCESS (8.908s)
[481.406897] [137/156] (579s left) gem_linear_blits (interruptible)
[481.609614] Starting subtest: interruptible
[489.434146] Subtest interruptible: SUCCESS (7.825s)
[489.563167] [138/156] (571s left) gen9_exec_parse (batch-invalid-length)
[489.691306] Subtest batch-invalid-length: SKIP (0.000s)
[489.759275] [139/156] (571s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier)
[489.956877] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier
[489.958706] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier: SKIP (0.000s)
[490.026270] [140/156] (570s left) drm_buddy (drm_buddy)
[490.088447] Starting subtest: drm_buddy
[490.090297] Subtest drm_buddy: SKIP (0.001s)
[490.142520] [141/156] (570s left) kms_invalid_mode (bad-vsync-end)
[490.332350] Starting subtest: bad-vsync-end
[490.333292] Starting dynamic subtest: pipe-A-DP-3
[490.418168] Dynamic subtest pipe-A-DP-3: SUCCESS (0.084s)
[490.437512] Starting dynamic subtest: pipe-B-DP-3
[490.438564] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s)
[490.456578] Starting dynamic subtest: pipe-C-DP-3
[490.457534] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[490.471488] Starting dynamic subtest: pipe-D-DP-3
[490.472430] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s)
[490.473338] Subtest bad-vsync-end: SUCCESS (0.095s)
[490.635563] [142/156] (570s left) kms_plane (plane-position-covered)
[490.835393] Starting subtest: plane-position-covered
[491.267040] Starting dynamic subtest: pipe-A-plane-1
[491.698711] Dynamic subtest pipe-A-plane-1: SUCCESS (0.433s)
[491.720781] Starting dynamic subtest: pipe-A-plane-2
[492.131523] Dynamic subtest pipe-A-plane-2: SUCCESS (0.431s)
[492.150607] Starting dynamic subtest: pipe-A-plane-3
[492.597313] Dynamic subtest pipe-A-plane-3: SUCCESS (0.465s)
[492.619607] Starting dynamic subtest: pipe-A-plane-4
[493.064533] Dynamic subtest pipe-A-plane-4: SUCCESS (0.465s)
[493.080241] Starting dynamic subtest: pipe-A-plane-5
[493.087578] Dynamic subtest pipe-A-plane-5: SUCCESS (0.022s)
[493.471786] Starting dynamic subtest: pipe-B-plane-1
[493.887170] Dynamic subtest pipe-B-plane-1: SUCCESS (0.431s)
[493.902082] Starting dynamic subtest: pipe-B-plane-2
[494.295140] Dynamic subtest pipe-B-plane-2: SUCCESS (0.407s)
[494.310056] Starting dynamic subtest: pipe-B-plane-3
[494.707536] Dynamic subtest pipe-B-plane-3: SUCCESS (0.410s)
[494.723063] Starting dynamic subtest: pipe-B-plane-4
[495.149073] Dynamic subtest pipe-B-plane-4: SUCCESS (0.442s)
[495.163579] Starting dynamic subtest: pipe-B-plane-5
[495.170905] Dynamic subtest pipe-B-plane-5: SUCCESS (0.020s)
[495.171831] Subtest plane-position-covered: SUCCESS (4.336s)
[495.400904] [143/156] (565s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[495.484221] Starting subtest: single-wait-all-for-submit-unsubmitted
[495.586557] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.102s)
[495.702506] [144/156] (565s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[495.900278] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[495.902078] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[495.977350] [145/156] (565s left) perf (oa-exponents)
[496.348928] Starting subtest: oa-exponents
[496.349899] Starting dynamic subtest: 0-rcs0
[498.608377] Dynamic subtest 0-rcs0: SUCCESS (2.259s)
[498.609358] Subtest oa-exponents: SUCCESS (2.260s)
[498.682130] [146/156] (562s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[498.889412] Starting subtest: fb-8bpc-vs-panel-8bpc
[498.890320] Starting dynamic subtest: pipe-A-DP-3
[499.342424] Dynamic subtest pipe-A-DP-3: SUCCESS (0.450s)
[499.343897] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (0.454s)
[499.531528] [147/156] (561s left) kms_vrr (flip-dpms)
[499.722307] Starting subtest: flip-dpms
[499.724935] Subtest flip-dpms: SKIP (0.000s)
[499.781300] [148/156] (561s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-render)
[499.979244] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-render
[499.980995] Subtest psrhdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[500.065546] [149/156] (561s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[500.149440] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[500.250649] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.101s)
[500.317725] [150/156] (561s left) kms_plane_cursor (viewport)
[500.515293] Starting subtest: viewport
[500.517054] Starting dynamic subtest: pipe-A-DP-3-size-64
[503.780230] Dynamic subtest pipe-A-DP-3-size-64: SUCCESS (3.264s)
[503.859166] Starting dynamic subtest: pipe-A-DP-3-size-128
[507.046554] Dynamic subtest pipe-A-DP-3-size-128: SUCCESS (3.200s)
[507.132909] Starting dynamic subtest: pipe-A-DP-3-size-256
[510.379627] Dynamic subtest pipe-A-DP-3-size-256: SUCCESS (3.266s)
[510.556863] Starting dynamic subtest: pipe-B-DP-3-size-64
[513.861926] Dynamic subtest pipe-B-DP-3-size-64: SUCCESS (3.321s)
[513.956926] Starting dynamic subtest: pipe-B-DP-3-size-128
[517.147046] Dynamic subtest pipe-B-DP-3-size-128: SUCCESS (3.232s)
[517.224396] Starting dynamic subtest: pipe-B-DP-3-size-256
[520.397363] Dynamic subtest pipe-B-DP-3-size-256: SUCCESS (3.200s)
[520.529203] Starting dynamic subtest: pipe-C-DP-3-size-64
[523.849147] Dynamic subtest pipe-C-DP-3-size-64: SUCCESS (3.339s)
[523.912182] Starting dynamic subtest: pipe-C-DP-3-size-128
[527.165888] Dynamic subtest pipe-C-DP-3-size-128: SUCCESS (3.267s)
[527.230115] Starting dynamic subtest: pipe-C-DP-3-size-256
[530.448927] Dynamic subtest pipe-C-DP-3-size-256: SUCCESS (3.233s)
[530.593660] Starting dynamic subtest: pipe-D-DP-3-size-64
[533.901336] Dynamic subtest pipe-D-DP-3-size-64: SUCCESS (3.324s)
[533.986677] Starting dynamic subtest: pipe-D-DP-3-size-128
[537.169064] Dynamic subtest pipe-D-DP-3-size-128: SUCCESS (3.216s)
[537.245517] Starting dynamic subtest: pipe-D-DP-3-size-256
[540.403213] Dynamic subtest pipe-D-DP-3-size-256: SUCCESS (3.183s)
[540.514967] Subtest viewport: SUCCESS (39.996s)
[540.742211] [151/156] (520s left) syncobj_basic (bad-destroy)
[540.822422] Starting subtest: bad-destroy
[540.823385] Subtest bad-destroy: SUCCESS (0.000s)
[540.902103] [152/156] (520s left) gem_pxp (regular-baseline-src-copy-readible)
[543.520522] Starting subtest: regular-baseline-src-copy-readible
[543.522434] Subtest regular-baseline-src-copy-readible: SKIP (0.000s)
[543.588431] [153/156] (518s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[543.784250] Starting subtest: psr-2p-primscrn-spr-indfb-move
[543.785994] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[543.869989] [154/156] (517s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[544.075199] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[544.076956] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[544.175570] [155/156] (517s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc)
[544.372034] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc
[544.373808] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[544.452076] [156/156] (517s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[544.658212] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[544.660048] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[544.756086] Closing watchdogs
results: parsing output: 0/ for test: prime_vgem
results: parsing output: 1/ for test: gem_ctx_isolation
results: parsing output: 2/ for test: sw_sync
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: gem_workarounds
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_exec_reloc
results: parsing output: 10/ for test: kms_ccs
results: parsing output: 11/ for test: perf_pmu
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: syncobj_timeline
results: parsing output: 14/ for test: kms_pm_rpm
results: parsing output: 15/ for test: kms_flip
results: parsing output: 16/ for test: fbdev
results: parsing output: 17/ for test: kms_pipe_crc_basic
results: parsing output: 18/ for test: api_intel_bb
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_softpin
results: parsing output: 23/ for test: gem_mmap_gtt
results: parsing output: 24/ for test: vgem_basic
results: parsing output: 25/ for test: syncobj_wait
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: kms_rotation_crc
results: parsing output: 28/ for test: kms_cursor_legacy
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_addfb_basic
results: parsing output: 31/ for test: kms_flip
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: syncobj_wait
results: parsing output: 34/ for test: syncobj_wait
results: parsing output: 35/ for test: gem_exec_fence
results: parsing output: 36/ for test: prime_vgem
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: syncobj_timeline
results: parsing output: 40/ for test: gem_exec_reloc
results: parsing output: 41/ for test: i915_pm_rpm
results: parsing output: 42/ for test: perf_pmu
results: parsing output: 43/ for test: kms_color
results: parsing output: 44/ for test: i915_drm_fdinfo
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: kms_flip_scaled_crc
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_psr2_sf
results: parsing output: 51/ for test: kms_cursor_edge_walk
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: gem_fenced_exec_thrash
results: parsing output: 54/ for test: gem_render_copy
results: parsing output: 55/ for test: gem_pxp
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: kms_cursor_legacy
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gen3_render_mixed_blits
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: gem_mmap_gtt
results: parsing output: 62/ for test: kms_psr2_sf
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_pipe_b_c_ivb
results: parsing output: 66/ for test: kms_plane_scaling
results: parsing output: 67/ for test: kms_plane_lowres
results: parsing output: 68/ for test: kms_sequence
results: parsing output: 69/ for test: kms_flip_scaled_crc
results: parsing output: 70/ for test: kms_psr
results: parsing output: 71/ for test: kms_chamelium_frames
results: parsing output: 72/ for test: kms_psr
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: gem_exec_whisper
results: parsing output: 76/ for test: kms_hdr
results: parsing output: 77/ for test: prime_mmap
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_ctx_shared
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gem_exec_schedule
results: parsing output: 82/ for test: kms_cursor_legacy
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: api_intel_bb
results: parsing output: 86/ for test: i915_query
results: parsing output: 87/ for test: gem_exec_reloc
results: parsing output: 88/ for test: kms_chamelium_hpd
results: parsing output: 89/ for test: gem_fenced_exec_thrash
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_sync
results: parsing output: 92/ for test: gem_exec_whisper
results: parsing output: 93/ for test: gem_userptr_blits
results: parsing output: 94/ for test: kms_cursor_crc
results: parsing output: 95/ for test: kms_prop_blob
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: gem_exec_params
results: parsing output: 98/ for test: gem_mmap_gtt
results: parsing output: 99/ for test: syncobj_wait
results: parsing output: 100/ for test: gem_create
results: parsing output: 101/ for test: kms_psr2_sf
results: parsing output: 102/ for test: kms_feature_discovery
results: parsing output: 103/ for test: gem_exec_balancer
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_ccs
results: parsing output: 111/ for test: gem_ctx_persistence
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_atomic
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: gem_softpin
results: parsing output: 117/ for test: gem_userptr_blits
results: parsing output: 118/ for test: gem_exec_capture
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: kms_psr
results: parsing output: 123/ for test: gem_exec_await
results: parsing output: 124/ for test: kms_content_protection
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: syncobj_wait
results: parsing output: 128/ for test: gem_exec_schedule
results: parsing output: 129/ for test: perf_pmu
results: parsing output: 130/ for test: kms_big_fb
results: parsing output: 131/ for test: i915_pciid
results: parsing output: 132/ for test: gem_eio
results: parsing output: 133/ for test: kms_frontbuffer_tracking
results: parsing output: 134/ for test: kms_ccs
results: parsing output: 135/ for test: kms_cursor_crc
results: parsing output: 136/ for test: gem_linear_blits
results: parsing output: 137/ for test: gen9_exec_parse
results: parsing output: 138/ for test: kms_plane
results: parsing output: 139/ for test: drm_buddy
results: parsing output: 140/ for test: kms_invalid_mode
results: parsing output: 141/ for test: kms_plane
results: parsing output: 142/ for test: syncobj_wait
results: parsing output: 143/ for test: kms_frontbuffer_tracking
results: parsing output: 144/ for test: perf
results: parsing output: 145/ for test: kms_dither
results: parsing output: 146/ for test: kms_vrr
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: syncobj_wait
results: parsing output: 149/ for test: kms_plane_cursor
results: parsing output: 150/ for test: syncobj_basic
results: parsing output: 151/ for test: gem_pxp
results: parsing output: 152/ for test: kms_frontbuffer_tracking
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: kms_frontbuffer_tracking
results: parsing output: 155/ for test: kms_big_fb
Done.