[63.895037] Initializing watchdogs
[63.895110]   /dev/watchdog0
[63.914617] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[63.925474] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[63.929621] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.931895] [001/131] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[64.121541] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[64.123220] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[64.304670] [002/131] (960s left) gem_vm_create (invalid-create)
[64.385186] Starting subtest: invalid-create
[64.389934] Subtest invalid-create: SUCCESS (0.005s)
[64.554146] [003/131] (960s left) gen7_exec_parse (basic-rejected)
[64.633474] Subtest basic-rejected: SKIP (0.000s)
[64.720509] [004/131] (959s left) kms_psr (pr-no-drrs)
[64.907422] Subtest pr-no-drrs: SKIP (0.000s)
[64.954412] [005/131] (959s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[65.131583] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[65.132469] Starting dynamic subtest: pipe-A-DP-3
[65.140828] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[65.148258] Starting dynamic subtest: pipe-B-DP-3
[65.156688] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[65.163918] Starting dynamic subtest: pipe-C-DP-3
[65.172119] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[65.179290] Starting dynamic subtest: pipe-D-DP-3
[65.188014] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[65.190112] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[65.627393] [006/131] (959s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[65.704482] Starting subtest: x-tiled-to-vebox-y-tiled
[65.706399] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[65.962269] [007/131] (958s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[66.169496] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[66.171152] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[66.362475] [008/131] (958s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[66.550494] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[66.552274] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[66.721240] [009/131] (958s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[66.960144] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[66.961993] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[67.433065] [010/131] (957s left) gem_ctx_engines (execute-oneforall)
[67.614632] Starting subtest: execute-oneforall
[68.507561] Subtest execute-oneforall: SUCCESS (0.892s)
[69.190529] [011/131] (955s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[69.377425] Starting subtest: fbcpsr-tiling-y
[69.379114] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[69.567258] [012/131] (955s left) core_auth (basic-auth)
[69.637034] Starting subtest: basic-auth
[69.649404] Subtest basic-auth: SUCCESS (0.012s)
[69.844107] [013/131] (955s left) kms_hdmi_inject (inject-audio)
[70.001161] Starting subtest: inject-audio
[70.130088] Subtest inject-audio: SUCCESS (0.129s)
[70.507611] [014/131] (954s left) drm_read (short-buffer-nonblock)
[70.795982] Starting subtest: short-buffer-nonblock
[70.796910] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[71.090819] [015/131] (954s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[71.275790] Subtest psr2-overlay-plane-move-continuous-sf: SKIP (0.000s)
[71.316591] [016/131] (954s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[71.498415] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[71.500122] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[71.690372] [017/131] (953s left) gem_partial_pwrite_pread (write-snoop)
[71.768370] Subtest write-snoop: SKIP (0.000s)
[71.859350] [018/131] (953s left) gem_mmap_gtt (fault-concurrent-y)
[71.936958] Subtest fault-concurrent-Y: SKIP (0.000s)
[72.004155] [019/131] (953s left) gem_exec_balancer (full-pulse)
[72.083729] Starting subtest: full-pulse
[74.209242] Subtest full-pulse: SUCCESS (2.124s)
[74.648973] [020/131] (950s left) syncobj_basic (bad-flags-handle-to-fd)
[74.729859] Starting subtest: bad-flags-handle-to-fd
[74.730793] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[74.940531] [021/131] (950s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[75.012155] Starting subtest: etime-single-wait-all-for-submit-submitted
[75.118476] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.106s)
[75.256064] [022/131] (950s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[75.448572] Starting subtest: y-tiled-32bpp-rotate-270
[75.450319] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[75.643434] [023/131] (950s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[75.817274] Starting subtest: multiplane-rotation-cropping-top
[104.913146] Subtest multiplane-rotation-cropping-top: SUCCESS (29.084s)
[105.120730] [024/131] (920s left) kms_big_fb (x-tiled-addfb)
[105.312453] Starting subtest: x-tiled-addfb
[105.313387] Subtest x-tiled-addfb: SUCCESS (0.000s)
[105.492125] [025/131] (920s left) kms_big_fb (linear-8bpp-rotate-0)
[105.682267] Starting subtest: linear-8bpp-rotate-0
[107.262046] Subtest linear-8bpp-rotate-0: SUCCESS (1.579s)
[107.455788] [026/131] (918s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[107.530471] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[107.532506] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[107.789880] [027/131] (918s left) kms_content_protection (atomic)
[108.031995] Starting subtest: atomic
[108.060650] Starting dynamic subtest: pipe-A-DP-3
[229.236015] Dynamic subtest pipe-A-DP-3: FAIL (121.001s)
[229.236947] Subtest atomic: FAIL (121.108s)
[229.460263] [028/131] (796s left) kms_cursor_edge_walk (64x64-top-edge)
[229.639123] Starting subtest: 64x64-top-edge
[229.640012] Starting dynamic subtest: pipe-A-DP-3
[233.101957] Dynamic subtest pipe-A-DP-3: SUCCESS (3.462s)
[233.113782] Starting dynamic subtest: pipe-D-DP-3
[236.431998] Dynamic subtest pipe-D-DP-3: SUCCESS (3.328s)
[236.432977] Subtest 64x64-top-edge: SUCCESS (6.794s)
[236.734844] [029/131] (789s left) kms_dp_link_training (uhbr-mst)
[236.911304] Starting subtest: uhbr-mst
[236.913019] Subtest uhbr-mst: SKIP (0.000s)
[237.067767] [030/131] (789s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[237.250881] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[237.252502] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[237.450297] [031/131] (788s left) kms_cursor_crc (cursor-onscreen-512x170)
[237.920469] Starting subtest: cursor-onscreen-512x170
[237.923323] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[238.164814] [032/131] (788s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[238.343287] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[238.344192] Starting dynamic subtest: pipe-A-valid-mode
[239.427352] Dynamic subtest pipe-A-valid-mode: SKIP (1.083s)
[239.429444] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (1.084s)
[239.739190] [033/131] (786s left) gem_eio (wait-wedge-1us)
[240.020397] Starting subtest: wait-wedge-1us
[241.858183] Subtest wait-wedge-1us: SUCCESS (1.838s)
[242.138572] [034/131] (784s left) i915_drm_fdinfo (virtual-busy-idle)
[242.200562] Starting subtest: virtual-busy-idle
[242.202344] Subtest virtual-busy-idle: SKIP (0.000s)
[242.371387] [035/131] (784s left) syncobj_wait (single-wait-for-submit-submitted)
[242.443414] Starting subtest: single-wait-for-submit-submitted
[242.550507] Subtest single-wait-for-submit-submitted: SUCCESS (0.106s)
[242.687166] [036/131] (784s left) perf_pmu (init-busy)
[242.748552] Starting subtest: init-busy
[242.749422] Starting dynamic subtest: rcs0
[242.751384] Dynamic subtest rcs0: SUCCESS (0.002s)
[242.761162] Starting dynamic subtest: bcs0
[242.762020] Dynamic subtest bcs0: SUCCESS (0.000s)
[242.771349] Starting dynamic subtest: vcs0
[242.772253] Dynamic subtest vcs0: SUCCESS (0.000s)
[242.781846] Starting dynamic subtest: vcs1
[242.783107] Dynamic subtest vcs1: SUCCESS (0.000s)
[242.792646] Starting dynamic subtest: vecs0
[242.793726] Dynamic subtest vecs0: SUCCESS (0.000s)
[242.802910] Starting dynamic subtest: vecs1
[242.804194] Dynamic subtest vecs1: SUCCESS (0.000s)
[242.813114] Starting dynamic subtest: ccs0
[242.814185] Dynamic subtest ccs0: SUCCESS (0.001s)
[242.815403] Subtest init-busy: SUCCESS (0.010s)
[242.958088] [037/131] (783s left) gem_spin_batch (resubmit-new-all)
[243.040481] Starting subtest: resubmit-new-all
[243.041379] Starting dynamic subtest: rcs0
[243.078786] Dynamic subtest rcs0: SUCCESS (0.038s)
[243.088537] Starting dynamic subtest: bcs0
[243.089426] Dynamic subtest bcs0: SUCCESS (0.008s)
[243.099128] Starting dynamic subtest: vcs0
[243.100109] Dynamic subtest vcs0: SUCCESS (0.008s)
[243.109558] Starting dynamic subtest: vcs1
[243.110446] Dynamic subtest vcs1: SUCCESS (0.010s)
[243.119687] Starting dynamic subtest: vecs0
[243.120522] Dynamic subtest vecs0: SUCCESS (0.008s)
[243.130077] Starting dynamic subtest: vecs1
[243.130976] Dynamic subtest vecs1: SUCCESS (0.008s)
[243.140520] Starting dynamic subtest: ccs0
[243.141602] Dynamic subtest ccs0: SUCCESS (0.009s)
[243.142489] Subtest resubmit-new-all: SUCCESS (0.094s)
[243.506333] [038/131] (783s left) kms_psr (psr2-no-drrs)
[243.685319] Subtest psr2-no-drrs: SKIP (0.000s)
[243.750357] [039/131] (783s left) gem_exec_fence (syncobj-timeline-export)
[244.447924] Starting subtest: syncobj-timeline-export
[244.480934] Subtest syncobj-timeline-export: SUCCESS (0.034s)
[244.821673] [FACT gem_exec_fence (syncobj-timeline-export)] new: kernel.kmod_is_loaded.vgem: true
[244.823760] [040/131] (782s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[245.013111] Starting subtest: compare-crc-sanitycheck-xr24
[245.013988] Starting dynamic subtest: pipe-A-DP-3
[245.580246] Dynamic subtest pipe-A-DP-3: SUCCESS (0.565s)
[245.603124] Starting dynamic subtest: pipe-B-DP-3
[246.049664] Dynamic subtest pipe-B-DP-3: SUCCESS (0.466s)
[246.062075] Starting dynamic subtest: pipe-C-DP-3
[246.511107] Dynamic subtest pipe-C-DP-3: SUCCESS (0.458s)
[246.522224] Starting dynamic subtest: pipe-D-DP-3
[246.976021] Dynamic subtest pipe-D-DP-3: SUCCESS (0.463s)
[246.977016] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.963s)
[247.274474] [041/131] (779s left) kms_pm_rpm (dpms-lpsp)
[249.106549] Starting subtest: dpms-lpsp
[249.108909] Subtest dpms-lpsp: SKIP (0.001s)
[249.547147] [042/131] (777s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[249.746132] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[249.797240] [043/131] (777s left) syncobj_timeline (signal)
[249.881300] Starting subtest: signal
[249.882276] Subtest signal: SUCCESS (0.000s)
[250.089331] [044/131] (777s left) kms_invalid_mode (overflow-vrefresh)
[250.288336] Starting subtest: overflow-vrefresh
[250.289231] Starting dynamic subtest: pipe-A-DP-3
[250.363177] Dynamic subtest pipe-A-DP-3: SUCCESS (0.073s)
[250.374753] Starting dynamic subtest: pipe-B-DP-3
[250.375904] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s)
[250.386907] Starting dynamic subtest: pipe-C-DP-3
[250.388191] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[250.399033] Starting dynamic subtest: pipe-D-DP-3
[250.399991] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s)
[250.400954] Subtest overflow-vrefresh: SUCCESS (0.082s)
[250.655658] [045/131] (776s left) api_intel_allocator (reserve-simple)
[250.734356] Starting subtest: reserve-simple
[250.765293] Subtest reserve-simple: SUCCESS (0.032s)
[250.995019] [046/131] (776s left) kms_lease (lease-unleased-connector)
[251.180567] Starting subtest: lease-unleased-connector
[251.182883] Starting dynamic subtest: pipe-A-DP-3
[251.285741] Dynamic subtest pipe-A-DP-3: SUCCESS (0.104s)
[251.296987] Starting dynamic subtest: pipe-B-DP-3
[251.393527] Dynamic subtest pipe-B-DP-3: SUCCESS (0.106s)
[251.404848] Starting dynamic subtest: pipe-C-DP-3
[251.500543] Dynamic subtest pipe-C-DP-3: SUCCESS (0.104s)
[251.510161] Starting dynamic subtest: pipe-D-DP-3
[251.605530] Dynamic subtest pipe-D-DP-3: SUCCESS (0.104s)
[251.606408] Subtest lease-unleased-connector: SUCCESS (0.424s)
[251.749109] [047/131] (775s left) kms_rotation_crc (bad-tiling)
[251.934492] Starting subtest: bad-tiling
[251.936281] Subtest bad-tiling: SKIP (0.001s)
[252.095253] [048/131] (775s left) prime_vgem (shrink)
[252.198242] Starting subtest: shrink
[252.206200] Subtest shrink: SUCCESS (0.007s)
[252.409099] [049/131] (775s left) gem_workarounds (reset-context)
[252.507290] Starting subtest: reset-context
[252.773420] Subtest reset-context: SUCCESS (0.267s)
[252.975386] [050/131] (774s left) kms_prop_blob (blob-prop-lifetime)
[253.055453] Starting subtest: blob-prop-lifetime
[253.071250] Subtest blob-prop-lifetime: SUCCESS (0.017s)
[253.302704] [051/131] (774s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[253.501162] Starting subtest: 4-tiled-64bpp-rotate-180
[255.746182] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (2.244s)
[255.933041] [052/131] (772s left) kms_vblank (wait-forked-busy-hang)
[256.118528] Starting subtest: wait-forked-busy-hang
[256.120911] Starting dynamic subtest: pipe-A-DP-3
[282.573172] Dynamic subtest pipe-A-DP-3: SUCCESS (26.452s)
[282.584791] Starting dynamic subtest: pipe-D-DP-3
[307.565535] Dynamic subtest pipe-D-DP-3: SUCCESS (24.990s)
[307.566428] Subtest wait-forked-busy-hang: SUCCESS (51.447s)
[307.871384] [053/131] (720s left) gem_ccs (block-copy-compressed)
[307.962289] Starting subtest: block-copy-compressed
[307.964457] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0
[308.009914] Dynamic subtest linear-compressed-compfmt0-smem-lmem0: SUCCESS (0.047s)
[308.020164] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0
[308.106349] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.096s)
[308.117583] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0
[308.125388] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0: SUCCESS (0.018s)
[308.135307] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0
[308.232258] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.106s)
[308.243737] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0
[308.250130] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0: SUCCESS (0.017s)
[308.260009] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0
[308.350581] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.100s)
[308.362097] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0
[308.368587] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0: SUCCESS (0.017s)
[308.378515] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0
[308.473897] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.104s)
[308.474804] Subtest block-copy-compressed: SUCCESS (0.512s)
[308.686961] [054/131] (719s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[308.874414] Starting subtest: basic-flip-before-cursor-atomic
[309.913854] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.039s)
[310.261886] [055/131] (717s left) kms_flip (flip-vs-suspend-interruptible)
[310.452132] Starting subtest: flip-vs-suspend-interruptible
[310.456749] Starting dynamic subtest: A-DP3
[349.655459] Dynamic subtest A-DP3: SUCCESS (7.886s)
[349.668323] Starting dynamic subtest: B-DP3
[388.660153] Dynamic subtest B-DP3: SUCCESS (7.299s)
[388.677934] Starting dynamic subtest: C-DP3
[427.702583] Dynamic subtest C-DP3: SUCCESS (7.240s)
[427.719127] Starting dynamic subtest: D-DP3
[467.722228] Dynamic subtest D-DP3: SUCCESS (7.271s)
[467.724195] Subtest flip-vs-suspend-interruptible: SUCCESS (29.711s)
[468.073926] [056/131] (560s left) gem_lmem_swapping (parallel-random-verify-ccs)
[471.532912] Starting subtest: parallel-random-verify-ccs
[471.535009] Starting dynamic subtest: lmem0
[537.025959] Dynamic subtest lmem0: SUCCESS (65.492s)
[537.026863] Subtest parallel-random-verify-ccs: SUCCESS (65.493s)
[538.153121] [FACT gem_lmem_swapping (parallel-random-verify-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[538.154061] [FACT gem_lmem_swapping (parallel-random-verify-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[538.155942] [057/131] (490s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[539.960332] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[539.962027] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[540.172617] [FACT kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[540.175021] [FACT kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)] new: kernel.kmod_is_loaded.i915: true
[540.178220] [058/131] (488s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[540.364524] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs
[540.365389] Starting dynamic subtest: pipe-A-DP-3
[540.373990] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[540.384705] Starting dynamic subtest: pipe-B-DP-3
[540.393184] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[540.404472] Starting dynamic subtest: pipe-C-DP-3
[540.412682] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[540.422967] Starting dynamic subtest: pipe-D-DP-3
[540.433487] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[540.435481] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.007s)
[540.861075] [059/131] (487s left) i915_pm_rps (basic-api)
[540.954941] Starting subtest: basic-api
[540.956721] Subtest basic-api: SKIP (0.001s)
[541.114427] [060/131] (487s left) kms_pm_backlight (bad-brightness)
[541.307000] Subtest bad-brightness: SKIP (0.000s)
[541.371422] [061/131] (487s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[541.456330] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[541.538554] [062/131] (487s left) gem_exec_balancer (parallel-keep-in-fence)
[541.885456] Starting subtest: parallel-keep-in-fence
[544.179370] Subtest parallel-keep-in-fence: SUCCESS (2.295s)
[544.359799] [063/131] (484s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[544.553386] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[544.555139] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[544.759561] [064/131] (484s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[544.949152] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[544.950868] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[545.143013] [065/131] (483s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[545.331555] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[545.332456] Starting dynamic subtest: pipe-A-DP-3
[545.341015] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[545.351817] Starting dynamic subtest: pipe-B-DP-3
[545.360266] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[545.370895] Starting dynamic subtest: pipe-C-DP-3
[545.379127] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[545.389882] Starting dynamic subtest: pipe-D-DP-3
[545.401475] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[545.403483] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.007s)
[545.822759] [066/131] (483s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[546.010077] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[546.241642] Starting dynamic subtest: pipe-A-DP-3-4
[548.532278] Dynamic subtest pipe-A-DP-3-4: SUCCESS (2.290s)
[548.545846] Starting dynamic subtest: pipe-A-DP-3-x
[550.730773] Dynamic subtest pipe-A-DP-3-x: SUCCESS (2.197s)
[550.962010] Starting dynamic subtest: pipe-B-DP-3-4
[553.198020] Dynamic subtest pipe-B-DP-3-4: SUCCESS (2.248s)
[553.210379] Starting dynamic subtest: pipe-B-DP-3-x
[555.363402] Dynamic subtest pipe-B-DP-3-x: SUCCESS (2.164s)
[555.556370] Starting dynamic subtest: pipe-C-DP-3-4
[557.784487] Dynamic subtest pipe-C-DP-3-4: SUCCESS (2.240s)
[557.795924] Starting dynamic subtest: pipe-C-DP-3-x
[559.949533] Dynamic subtest pipe-C-DP-3-x: SUCCESS (2.164s)
[560.156731] Starting dynamic subtest: pipe-D-DP-3-4
[562.392151] Dynamic subtest pipe-D-DP-3-4: SUCCESS (2.250s)
[562.404177] Starting dynamic subtest: pipe-D-DP-3-x
[564.557571] Dynamic subtest pipe-D-DP-3-x: SUCCESS (2.164s)
[564.558426] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (18.548s)
[565.045628] [067/131] (464s left) gen3_render_mixed_blits
[565.209058] [068/131] (463s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[565.395570] Starting subtest: modeset-transition-nonblocking-fencing
[565.396500] Starting dynamic subtest: 1x-outputs
[567.990282] Dynamic subtest 1x-outputs: SUCCESS (2.594s)
[567.996094] Subtest modeset-transition-nonblocking-fencing: SUCCESS (2.597s)
[568.302825] [069/131] (460s left) vgem_basic (sysfs)
[568.368441] Starting subtest: sysfs
[568.369337] Subtest sysfs: SUCCESS (0.000s)
[568.528122] [070/131] (460s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[568.615104] Starting subtest: saturated-hostile-nopreempt
[568.616062] Starting dynamic subtest: rcs0
[568.720502] Dynamic subtest rcs0: SKIP (0.104s)
[568.733703] Starting dynamic subtest: bcs0
[568.735544] Dynamic subtest bcs0: SKIP (0.012s)
[568.747373] Starting dynamic subtest: vcs0
[568.749189] Dynamic subtest vcs0: SKIP (0.014s)
[568.760776] Starting dynamic subtest: vcs1
[568.765187] Dynamic subtest vcs1: SKIP (0.015s)
[568.776671] Starting dynamic subtest: vecs0
[568.778448] Dynamic subtest vecs0: SKIP (0.011s)
[568.789877] Starting dynamic subtest: vecs1
[568.791573] Dynamic subtest vecs1: SKIP (0.013s)
[568.803041] Starting dynamic subtest: ccs0
[568.805184] Dynamic subtest ccs0: SKIP (0.012s)
[568.807080] Subtest saturated-hostile-nopreempt: SKIP (0.189s)
[569.021262] [071/131] (460s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[569.215163] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[569.216849] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[569.417589] [072/131] (460s left) api_intel_bb (render)
[569.495681] Starting subtest: render
[569.496586] Starting dynamic subtest: render-none-512
[569.548705] Dynamic subtest render-none-512: SUCCESS (0.052s)
[569.561694] Starting dynamic subtest: render-none-1024
[569.620407] Dynamic subtest render-none-1024: SUCCESS (0.070s)
[569.633647] Starting dynamic subtest: render-x-512
[569.640612] Dynamic subtest render-x-512: SUCCESS (0.019s)
[569.653620] Starting dynamic subtest: render-x-1024
[569.715087] Dynamic subtest render-x-1024: SUCCESS (0.073s)
[569.728104] Starting dynamic subtest: render-y-512
[569.735556] Dynamic subtest render-y-512: SUCCESS (0.019s)
[569.748543] Starting dynamic subtest: render-y-1024
[569.799619] Dynamic subtest render-y-1024: SUCCESS (0.063s)
[569.800546] Subtest render: SUCCESS (0.304s)
[570.019814] [073/131] (459s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[570.260594] Starting subtest: cursor-tearing-framebuffer-change
[570.263614] Starting dynamic subtest: pipe-A-DP-3
[570.750912] Dynamic subtest pipe-A-DP-3: SUCCESS (0.487s)
[570.777178] Starting dynamic subtest: pipe-D-DP-3
[571.192267] Dynamic subtest pipe-D-DP-3: SUCCESS (0.438s)
[571.193243] Subtest cursor-tearing-framebuffer-change: SUCCESS (0.931s)
[571.822051] [074/131] (457s left) gem_ppgtt (shrink-vs-evict-pinned)
[571.914429] Starting subtest: shrink-vs-evict-pinned
[577.443486] Subtest shrink-vs-evict-pinned: SUCCESS (5.530s)
[577.559805] [075/131] (452s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[577.745532] Starting subtest: flip-vs-dpms-off-vs-modeset
[577.750238] Starting dynamic subtest: A-DP3
[578.598052] Dynamic subtest A-DP3: SUCCESS (0.844s)
[578.624344] Starting dynamic subtest: B-DP3
[579.390185] Dynamic subtest B-DP3: SUCCESS (0.788s)
[579.414938] Starting dynamic subtest: C-DP3
[580.222757] Dynamic subtest C-DP3: SUCCESS (0.831s)
[580.246768] Starting dynamic subtest: D-DP3
[580.999591] Dynamic subtest D-DP3: SUCCESS (0.773s)
[581.002609] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (3.255s)
[581.345441] [076/131] (448s left) gem_exec_reloc (basic-cpu-wc)
[581.430752] Subtest basic-cpu-wc: SKIP (0.000s)
[581.512201] [077/131] (448s left) i915_drm_fdinfo (busy-check-all)
[581.583854] Starting subtest: busy-check-all
[581.584697] Starting dynamic subtest: rcs0
[581.615369] Dynamic subtest rcs0: SKIP (0.030s)
[581.627506] Starting dynamic subtest: bcs0
[581.629667] Dynamic subtest bcs0: SKIP (0.000s)
[581.641601] Starting dynamic subtest: vcs0
[581.643716] Dynamic subtest vcs0: SKIP (0.000s)
[581.655514] Starting dynamic subtest: vcs1
[581.657903] Dynamic subtest vcs1: SKIP (0.000s)
[581.669307] Starting dynamic subtest: vecs0
[581.671598] Dynamic subtest vecs0: SKIP (0.000s)
[581.682903] Starting dynamic subtest: vecs1
[581.685223] Dynamic subtest vecs1: SKIP (0.000s)
[581.696624] Starting dynamic subtest: ccs0
[581.699248] Dynamic subtest ccs0: SKIP (0.000s)
[581.701691] Subtest busy-check-all: SKIP (0.041s)
[581.749515] [078/131] (448s left) gem_exec_whisper (basic-queues-priority)
[581.896598] Starting subtest: basic-queues-priority
[604.359677] Subtest basic-queues-priority: SUCCESS (22.461s)
[604.646342] [079/131] (425s left) sysfs_heartbeat_interval (nopreempt)
[604.730033] Starting subtest: nopreempt
[604.732529] Starting dynamic subtest: vecs0
[609.112361] Dynamic subtest vecs0: SUCCESS (4.381s)
[609.127714] Starting dynamic subtest: ccs0
[613.377466] Dynamic subtest ccs0: SUCCESS (4.264s)
[613.392862] Starting dynamic subtest: vcs0
[617.609234] Dynamic subtest vcs0: SUCCESS (4.230s)
[617.622088] Starting dynamic subtest: bcs0
[621.825851] Dynamic subtest bcs0: SUCCESS (4.215s)
[621.841356] Starting dynamic subtest: vecs1
[626.044446] Dynamic subtest vecs1: SUCCESS (4.217s)
[626.059797] Starting dynamic subtest: rcs0
[630.363177] Dynamic subtest rcs0: SUCCESS (4.317s)
[630.377148] Starting dynamic subtest: vcs1
[634.563227] Dynamic subtest vcs1: SUCCESS (4.199s)
[634.564175] Subtest nopreempt: SUCCESS (29.833s)
[634.780840] [080/131] (395s left) gem_exec_whisper (basic-forked)
[634.876949] Starting subtest: basic-forked
[642.100183] Subtest basic-forked: SUCCESS (7.222s)
[642.408056] [081/131] (387s left) prime_vgem (basic-fence-read)
[642.511387] Starting subtest: basic-fence-read
[642.524277] Subtest basic-fence-read: SKIP (0.012s)
[642.692703] [082/131] (387s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[642.885275] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[642.887039] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[643.090081] [083/131] (387s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[643.281038] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[643.282677] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[643.497526] [084/131] (386s left) gem_flink_basic (flink-lifetime)
[643.573788] Starting subtest: flink-lifetime
[643.607436] Subtest flink-lifetime: SUCCESS (0.033s)
[643.785119] [085/131] (386s left) gem_exec_reloc (basic-wc-read-active)
[643.870559] Subtest basic-wc-read-active: SKIP (0.000s)
[643.948482] [086/131] (386s left) core_setmaster (master-drop-set-shared-fd)
[644.103431] Starting subtest: master-drop-set-shared-fd
[644.135519] Subtest master-drop-set-shared-fd: SUCCESS (0.032s)
[644.187133] [087/131] (386s left) kms_flip (flip-vs-panning)
[644.370999] Starting subtest: flip-vs-panning
[644.375607] Starting dynamic subtest: A-DP3
[652.229342] Dynamic subtest A-DP3: SUCCESS (7.854s)
[652.244767] Starting dynamic subtest: B-DP3
[660.013491] Dynamic subtest B-DP3: SUCCESS (7.782s)
[660.030288] Starting dynamic subtest: C-DP3
[667.799823] Dynamic subtest C-DP3: SUCCESS (7.784s)
[667.839833] Starting dynamic subtest: D-DP3
[675.619819] Dynamic subtest D-DP3: SUCCESS (7.814s)
[675.624773] Subtest flip-vs-panning: SUCCESS (31.254s)
[676.015844] [088/131] (354s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[676.209319] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[676.211108] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[676.419456] [089/131] (354s left) sw_sync (sync_expired_merge)
[676.467446] Starting subtest: sync_expired_merge
[677.541753] Subtest sync_expired_merge: SUCCESS (1.074s)
[677.651602] [090/131] (353s left) kms_psr (fbc-psr-primary-mmap-cpu)
[677.846900] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.000s)
[677.913047] [091/131] (353s left) syncobj_timeline (single-wait-available-signaled)
[677.991546] Starting subtest: single-wait-available-signaled
[677.992629] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[678.138956] [092/131] (352s left) i915_pm_rps (thresholds-park)
[678.220933] Starting subtest: thresholds-park
[678.222705] Subtest thresholds-park: SKIP (0.000s)
[678.414038] [093/131] (352s left) kms_cursor_crc (cursor-size-change)
[678.600396] Starting subtest: cursor-size-change
[678.601293] Starting dynamic subtest: pipe-A-DP-3
[679.532861] Dynamic subtest pipe-A-DP-3: SUCCESS (0.930s)
[679.559798] Starting dynamic subtest: pipe-D-DP-3
[680.321125] Dynamic subtest pipe-D-DP-3: SUCCESS (0.785s)
[680.322077] Subtest cursor-size-change: SUCCESS (1.722s)
[680.991175] [094/131] (350s left) gem_exec_reloc (basic-write-wc)
[681.075886] Subtest basic-write-wc: SKIP (0.000s)
[681.173886] [095/131] (350s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[681.369543] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[681.371248] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[681.575872] [096/131] (349s left) kms_psr (fbc-pr-primary-mmap-gtt)
[681.761450] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[681.833936] [097/131] (349s left) gem_ctx_shared (q-promotion)
[681.926868] Starting subtest: Q-promotion
[681.927751] Starting dynamic subtest: rcs0
[682.204218] Dynamic subtest rcs0: SUCCESS (0.277s)
[682.217744] Starting dynamic subtest: bcs0
[682.392375] Dynamic subtest bcs0: SUCCESS (0.187s)
[682.405692] Starting dynamic subtest: vcs0
[682.585830] Dynamic subtest vcs0: SUCCESS (0.192s)
[682.600903] Starting dynamic subtest: vcs1
[682.780365] Dynamic subtest vcs1: SUCCESS (0.193s)
[682.793845] Starting dynamic subtest: vecs0
[682.973530] Dynamic subtest vecs0: SUCCESS (0.192s)
[682.987070] Starting dynamic subtest: vecs1
[683.167859] Dynamic subtest vecs1: SUCCESS (0.193s)
[683.181607] Starting dynamic subtest: ccs0
[683.364575] Dynamic subtest ccs0: SUCCESS (0.196s)
[683.365454] Subtest Q-promotion: SUCCESS (1.438s)
[683.695149] [098/131] (347s left) gem_exec_schedule (u-semaphore-codependency)
[683.786595] Starting subtest: u-semaphore-codependency
[683.828611] Subtest u-semaphore-codependency: SUCCESS (0.042s)
[684.307595] [099/131] (347s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[684.496058] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[684.498296] Starting dynamic subtest: pipe-A-DP-3
[684.506510] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[684.519628] Starting dynamic subtest: pipe-B-DP-3
[684.527967] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[684.540891] Starting dynamic subtest: pipe-C-DP-3
[684.549106] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[684.562332] Starting dynamic subtest: pipe-D-DP-3
[684.573254] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[684.575647] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SKIP (0.009s)
[684.960808] [100/131] (346s left) kms_atomic_transition (plane-all-transition)
[685.148401] Starting subtest: plane-all-transition
[685.149317] Starting dynamic subtest: pipe-A-DP-3
[688.946620] Dynamic subtest pipe-A-DP-3: SUCCESS (3.797s)
[689.118490] Starting dynamic subtest: pipe-B-DP-3
[693.007635] Dynamic subtest pipe-B-DP-3: SUCCESS (3.910s)
[693.112833] Subtest plane-all-transition: SUCCESS (7.965s)
[693.395526] [101/131] (338s left) gem_exec_params (invalid-ring2)
[693.483333] Starting subtest: invalid-ring2
[693.484321] Subtest invalid-ring2: SUCCESS (0.000s)
[693.650204] [102/131] (338s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[693.850507] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[696.526720] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (2.677s)
[696.770568] [103/131] (335s left) gem_render_copy (x-tiled)
[696.852087] Starting subtest: x-tiled
[696.852972] Starting dynamic subtest: smem
[696.963411] Dynamic subtest smem: SUCCESS (0.110s)
[696.976569] Starting dynamic subtest: lmem0
[698.576165] Dynamic subtest lmem0: SUCCESS (1.611s)
[698.577293] Subtest x-tiled: SUCCESS (1.724s)
[698.846439] [104/131] (333s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[699.122337] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[699.279385] [105/131] (332s left) syncobj_timeline (invalid-query-zero-handles)
[699.357491] Starting subtest: invalid-query-zero-handles
[699.358409] Subtest invalid-query-zero-handles: SUCCESS (0.000s)
[699.572662] [106/131] (332s left) kms_chamelium_frames (hdmi-crc-fast)
[699.851612] Subtest hdmi-crc-fast: SKIP (0.000s)
[700.011539] [107/131] (332s left) gem_ctx_exec (basic-invalid-context)
[700.093486] Starting subtest: basic-invalid-context
[700.098410] Subtest basic-invalid-context: SUCCESS (0.005s)
[700.318885] [108/131] (331s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[700.513571] Starting subtest: primary-x-tiled-reflect-x-180
[710.884008] Subtest primary-x-tiled-reflect-x-180: SUCCESS (10.371s)
[711.266181] [109/131] (321s left) vgem_basic (dmabuf-mmap)
[711.328465] Starting subtest: dmabuf-mmap
[711.361276] Subtest dmabuf-mmap: SUCCESS (0.033s)
[711.488163] [110/131] (320s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[711.673555] Starting subtest: cursorB-vs-flipB-atomic-transitions
[711.675311] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s)
[711.826080] [111/131] (320s left) kms_vblank (invalid)
[712.010906] Starting subtest: invalid
[712.013509] Starting dynamic subtest: pipe-A-DP-3
[712.343778] Dynamic subtest pipe-A-DP-3: SUCCESS (0.328s)
[712.345110] Subtest invalid: SUCCESS (0.332s)
[712.616585] [112/131] (319s left) kms_getfb (getfb2-handle-closed)
[712.805539] Starting subtest: getfb2-handle-closed
[712.806385] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[713.033045] [113/131] (319s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[713.219741] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[713.222268] Starting dynamic subtest: pipe-A-DP-3
[713.231388] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[713.244579] Starting dynamic subtest: pipe-B-DP-3
[713.254412] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[713.267223] Starting dynamic subtest: pipe-C-DP-3
[713.277170] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[713.290323] Starting dynamic subtest: pipe-D-DP-3
[713.301663] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[713.303578] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SKIP (0.007s)
[713.689389] [114/131] (319s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[713.874904] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[713.875761] Starting dynamic subtest: pipe-A
[715.970559] Dynamic subtest pipe-A: SUCCESS (2.095s)
[715.997643] Starting dynamic subtest: pipe-B
[718.166604] Dynamic subtest pipe-B: SUCCESS (2.194s)
[718.199418] Starting dynamic subtest: pipe-C
[718.480420] Dynamic subtest pipe-C: SUCCESS (0.311s)
[718.515936] Starting dynamic subtest: pipe-D
[718.793127] Dynamic subtest pipe-D: SUCCESS (0.310s)
[718.794237] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (4.919s)
[719.159542] [115/131] (313s left) template (b)
[719.238570] Starting subtest: B
[719.239549] Subtest B: SUCCESS (0.000s)
[719.439183] [116/131] (313s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[719.625239] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.000s)
[719.685114] [117/131] (313s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[719.888977] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[719.890660] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[720.110242] [118/131] (312s left) kms_busy (extended-modeset-hang-oldfb)
[720.301762] Starting subtest: extended-modeset-hang-oldfb
[720.304245] Starting dynamic subtest: pipe-A
[728.375582] Dynamic subtest pipe-A: SUCCESS (8.069s)
[728.405300] Starting dynamic subtest: pipe-D
[736.495840] Dynamic subtest pipe-D: SUCCESS (8.111s)
[736.497052] Subtest extended-modeset-hang-oldfb: SUCCESS (16.193s)
[736.821084] [119/131] (296s left) kms_flip (2x-flip-vs-fences)
[737.010697] Starting subtest: 2x-flip-vs-fences
[737.012415] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[737.203978] [120/131] (296s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[737.396660] Starting subtest: yf-tiled-32bpp-rotate-180
[737.398403] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[737.618200] [121/131] (295s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[737.806403] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[737.808115] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[738.021780] [122/131] (295s left) prime_mmap (test_correct)
[738.098000] Starting subtest: test_correct
[738.098913] Starting dynamic subtest: test_correct-smem
[738.145511] Dynamic subtest test_correct-smem: SUCCESS (0.047s)
[738.160215] Starting dynamic subtest: test_correct-lmem0
[738.337843] Dynamic subtest test_correct-lmem0: SUCCESS (0.191s)
[738.338755] Subtest test_correct: SUCCESS (0.240s)
[738.529895] [123/131] (294s left) kms_cursor_crc (cursor-offscreen-64x64)
[738.853036] Starting subtest: cursor-offscreen-64x64
[738.857543] Starting dynamic subtest: pipe-A-DP-3
[741.430608] Dynamic subtest pipe-A-DP-3: SUCCESS (2.572s)
[741.483189] Starting dynamic subtest: pipe-D-DP-3
[743.960780] Dynamic subtest pipe-D-DP-3: SUCCESS (2.491s)
[743.961724] Subtest cursor-offscreen-64x64: SUCCESS (5.108s)
[744.485808] [124/131] (289s left) perf (gen12-group-exclusive-stream-sample-oa)
[744.891717] Starting subtest: gen12-group-exclusive-stream-sample-oa
[744.914511] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.022s)
[744.978655] [125/131] (288s left) gem_exec_schedule (in-order)
[745.071569] Starting subtest: in-order
[745.072508] Starting dynamic subtest: rcs0
[745.369651] Dynamic subtest rcs0: SUCCESS (0.287s)
[745.383377] Starting dynamic subtest: bcs0
[745.574657] Dynamic subtest bcs0: SUCCESS (0.205s)
[745.588151] Starting dynamic subtest: vcs0
[745.785955] Dynamic subtest vcs0: SUCCESS (0.214s)
[745.799251] Starting dynamic subtest: vcs1
[745.993058] Dynamic subtest vcs1: SUCCESS (0.210s)
[746.008540] Starting dynamic subtest: vecs0
[746.202947] Dynamic subtest vecs0: SUCCESS (0.209s)
[746.217711] Starting dynamic subtest: vecs1
[746.417068] Dynamic subtest vecs1: SUCCESS (0.213s)
[746.431542] Starting dynamic subtest: ccs0
[746.654714] Dynamic subtest ccs0: SUCCESS (0.236s)
[746.655669] Subtest in-order: SUCCESS (1.584s)
[747.114450] [126/131] (286s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[747.309360] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[747.311050] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[747.519287] [127/131] (286s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[747.710240] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[747.711986] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[747.916462] [128/131] (285s left) gem_exec_schedule (fairslice)
[748.008636] Starting subtest: fairslice
[748.009592] Starting dynamic subtest: rcs0
[750.080672] Dynamic subtest rcs0: SUCCESS (2.069s)
[750.098723] Starting dynamic subtest: bcs0
[752.105780] Dynamic subtest bcs0: SUCCESS (2.021s)
[752.119438] Starting dynamic subtest: vcs0
[754.127388] Dynamic subtest vcs0: SUCCESS (2.021s)
[754.140799] Starting dynamic subtest: vcs1
[756.147388] Dynamic subtest vcs1: SUCCESS (2.019s)
[756.160915] Starting dynamic subtest: vecs0
[758.169347] Dynamic subtest vecs0: SUCCESS (2.021s)
[758.182526] Starting dynamic subtest: vecs1
[760.189338] Dynamic subtest vecs1: SUCCESS (2.019s)
[760.202951] Starting dynamic subtest: ccs0
[762.209548] Dynamic subtest ccs0: SUCCESS (2.020s)
[762.210551] Subtest fairslice: SUCCESS (14.200s)
[762.679891] [129/131] (271s left) gem_exec_parallel (basic)
[762.771476] Starting subtest: basic
[762.772395] Starting dynamic subtest: rcs0
[764.310858] Dynamic subtest rcs0: SUCCESS (1.539s)
[764.328271] Starting dynamic subtest: bcs0
[765.772608] Dynamic subtest bcs0: SUCCESS (1.460s)
[765.789822] Starting dynamic subtest: vcs0
[767.403667] Dynamic subtest vcs0: SUCCESS (1.630s)
[767.431282] Starting dynamic subtest: vcs1
[768.916308] Dynamic subtest vcs1: SUCCESS (1.511s)
[768.932678] Starting dynamic subtest: vecs0
[770.394612] Dynamic subtest vecs0: SUCCESS (1.477s)
[770.411496] Starting dynamic subtest: vecs1
[771.864753] Dynamic subtest vecs1: SUCCESS (1.469s)
[771.885654] Starting dynamic subtest: ccs0
[773.335634] Dynamic subtest ccs0: SUCCESS (1.469s)
[773.336716] Subtest basic: SUCCESS (10.565s)
[773.682168] [130/131] (260s left) kms_plane_alpha_blend (coverage-7efc)
[773.869572] Starting subtest: coverage-7efc
[774.126672] Starting dynamic subtest: pipe-A-DP-3
[774.621158] Dynamic subtest pipe-A-DP-3: SUCCESS (0.494s)
[774.658295] Starting dynamic subtest: pipe-D-DP-3
[775.316908] Dynamic subtest pipe-D-DP-3: SUCCESS (0.672s)
[775.317735] Subtest coverage-7efc: SUCCESS (1.449s)
[775.640063] [131/131] (258s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[775.726532] Starting subtest: etime-multi-wait-all-for-submit-submitted
[775.833894] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.105s)
[776.014638] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_vm_create
results: parsing output: 2/ for test: gen7_exec_parse
results: parsing output: 3/ for test: kms_psr
results: parsing output: 4/ for test: kms_ccs
results: parsing output: 5/ for test: gem_render_copy
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_ctx_engines
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: core_auth
results: parsing output: 12/ for test: kms_hdmi_inject
results: parsing output: 13/ for test: drm_read
results: parsing output: 14/ for test: kms_psr2_sf
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: gem_partial_pwrite_pread
results: parsing output: 17/ for test: gem_mmap_gtt
results: parsing output: 18/ for test: gem_exec_balancer
results: parsing output: 19/ for test: syncobj_basic
results: parsing output: 20/ for test: syncobj_timeline
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: kms_rotation_crc
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: gem_render_copy
results: parsing output: 26/ for test: kms_content_protection
results: parsing output: 27/ for test: kms_cursor_edge_walk
results: parsing output: 28/ for test: kms_dp_link_training
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_cursor_crc
results: parsing output: 31/ for test: kms_flip_scaled_crc
results: parsing output: 32/ for test: gem_eio
results: parsing output: 33/ for test: i915_drm_fdinfo
results: parsing output: 34/ for test: syncobj_wait
results: parsing output: 35/ for test: perf_pmu
results: parsing output: 36/ for test: gem_spin_batch
results: parsing output: 37/ for test: kms_psr
results: parsing output: 38/ for test: gem_exec_fence
results: parsing output: 39/ for test: kms_pipe_crc_basic
results: parsing output: 40/ for test: kms_pm_rpm
results: parsing output: 41/ for test: kms_psr2_sf
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: kms_invalid_mode
results: parsing output: 44/ for test: api_intel_allocator
results: parsing output: 45/ for test: kms_lease
results: parsing output: 46/ for test: kms_rotation_crc
results: parsing output: 47/ for test: prime_vgem
results: parsing output: 48/ for test: gem_workarounds
results: parsing output: 49/ for test: kms_prop_blob
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: kms_vblank
results: parsing output: 52/ for test: gem_ccs
results: parsing output: 53/ for test: kms_cursor_legacy
results: parsing output: 54/ for test: kms_flip
results: parsing output: 55/ for test: gem_lmem_swapping
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_ccs
results: parsing output: 58/ for test: i915_pm_rps
results: parsing output: 59/ for test: kms_pm_backlight
results: parsing output: 60/ for test: gem_fenced_exec_thrash
results: parsing output: 61/ for test: gem_exec_balancer
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_ccs
results: parsing output: 65/ for test: kms_async_flips
results: parsing output: 66/ for test: gen3_render_mixed_blits
results: parsing output: 67/ for test: kms_atomic_transition
results: parsing output: 68/ for test: vgem_basic
results: parsing output: 69/ for test: gem_ctx_persistence
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: api_intel_bb
results: parsing output: 72/ for test: kms_cursor_crc
results: parsing output: 73/ for test: gem_ppgtt
results: parsing output: 74/ for test: kms_flip
results: parsing output: 75/ for test: gem_exec_reloc
results: parsing output: 76/ for test: i915_drm_fdinfo
results: parsing output: 77/ for test: gem_exec_whisper
results: parsing output: 78/ for test: sysfs_heartbeat_interval
results: parsing output: 79/ for test: gem_exec_whisper
results: parsing output: 80/ for test: prime_vgem
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: gem_flink_basic
results: parsing output: 84/ for test: gem_exec_reloc
results: parsing output: 85/ for test: core_setmaster
results: parsing output: 86/ for test: kms_flip
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: sw_sync
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: i915_pm_rps
results: parsing output: 92/ for test: kms_cursor_crc
results: parsing output: 93/ for test: gem_exec_reloc
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: gem_ctx_shared
results: parsing output: 97/ for test: gem_exec_schedule
results: parsing output: 98/ for test: kms_ccs
results: parsing output: 99/ for test: kms_atomic_transition
results: parsing output: 100/ for test: gem_exec_params
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_render_copy
results: parsing output: 103/ for test: kms_chamelium_hpd
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: kms_chamelium_frames
results: parsing output: 106/ for test: gem_ctx_exec
results: parsing output: 107/ for test: kms_rotation_crc
results: parsing output: 108/ for test: vgem_basic
results: parsing output: 109/ for test: kms_cursor_legacy
results: parsing output: 110/ for test: kms_vblank
results: parsing output: 111/ for test: kms_getfb
results: parsing output: 112/ for test: kms_ccs
results: parsing output: 113/ for test: kms_plane_scaling
results: parsing output: 114/ for test: template
results: parsing output: 115/ for test: kms_psr
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_busy
results: parsing output: 118/ for test: kms_flip
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: prime_mmap
results: parsing output: 122/ for test: kms_cursor_crc
results: parsing output: 123/ for test: perf
results: parsing output: 124/ for test: gem_exec_schedule
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: gem_exec_schedule
results: parsing output: 128/ for test: gem_exec_parallel
results: parsing output: 129/ for test: kms_plane_alpha_blend
results: parsing output: 130/ for test: syncobj_timeline
Done.