[64.036280] Initializing watchdogs
[64.036329]   /dev/watchdog0
[64.052219] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[64.056883] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[64.059582] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[64.061630] [001/156] (960s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[64.117360] Starting subtest: multi-wait-for-submit-available-signaled
[64.118670] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.001s)
[64.209349] [002/156] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[64.301773] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[64.304093] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[64.393147] [003/156] (960s left) gem_exec_reloc (basic-gtt)
[64.457412] Subtest basic-gtt: SKIP (0.000s)
[64.521842] [004/156] (960s left) kms_chamelium_hpd (dp-hpd)
[64.908436] Subtest dp-hpd: SKIP (0.000s)
[65.734265] [005/156] (958s left) kms_atomic (plane-overlay-legacy)
[65.832511] Starting subtest: plane-overlay-legacy
[65.833665] Starting dynamic subtest: pipe-A-eDP-1
[66.275140] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.443s)
[66.275960] Subtest plane-overlay-legacy: SUCCESS (0.444s)
[67.102102] [006/156] (957s left) kms_big_fb (linear-8bpp-rotate-0)
[67.201339] Starting subtest: linear-8bpp-rotate-0
[68.481051] Subtest linear-8bpp-rotate-0: SUCCESS (1.280s)
[68.596404] [007/156] (956s left) kms_color (ctm-max)
[68.682195] Starting subtest: ctm-max
[68.683084] Starting dynamic subtest: pipe-A-eDP-1
[69.406397] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.724s)
[69.413345] Starting dynamic subtest: pipe-B-eDP-1
[70.861797] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.455s)
[70.868372] Starting dynamic subtest: pipe-C-eDP-1
[72.219036] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.357s)
[72.226195] Starting dynamic subtest: pipe-D-eDP-1
[73.555335] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.337s)
[73.556212] Subtest ctm-max: SUCCESS (4.874s)
[74.368772] [008/156] (950s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-render)
[74.474518] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-render
[74.476279] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[74.566348] [009/156] (950s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[74.658460] Starting subtest: fbc-rgb565-draw-mmap-wc
[78.979605] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (4.323s)
[80.117563] [010/156] (944s left) i915_query (query-regions-garbage-items)
[80.168224] Starting subtest: query-regions-garbage-items
[80.169369] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[80.292662] [011/156] (944s left) i915_pm_rpm (system-suspend-execbuf)
[82.524962] Starting subtest: system-suspend-execbuf
[141.982031] Subtest system-suspend-execbuf: SUCCESS (43.977s)
[142.371742] [012/156] (882s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-pwrite)
[142.466823] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-pwrite
[142.468607] Subtest psrhdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[142.565629] [013/156] (882s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[142.667748] Starting subtest: yf-tiled-16bpp-rotate-0
[142.669503] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[142.764234] [014/156] (882s left) gem_ctx_sseu (invalid-args)
[142.811133] Subtest invalid-args: SKIP (0.000s)
[142.883907] [015/156] (882s left) gem_exec_fence (basic-busy-all)
[142.938435] Starting subtest: basic-busy-all
[143.032679] Subtest basic-busy-all: SUCCESS (0.094s)
[144.860739] [FACT gem_exec_fence (basic-busy-all)] new: kernel.kmod_is_loaded.vgem: true
[144.862588] [016/156] (880s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[144.924153] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[144.926071] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[145.111670] [017/156] (879s left) i915_module_load (reload-no-display)
[145.143129] Starting subtest: reload-no-display
[149.506237] Subtest reload-no-display: SUCCESS (4.355s)
[149.528699] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[149.529428] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[149.531216] [018/156] (875s left) kms_force_connector_basic (force-edid)
[151.110322] Starting subtest: force-edid
[151.476205] Subtest force-edid: SUCCESS (0.366s)
[151.638697] [FACT kms_force_connector_basic (force-edid)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[151.640105] [FACT kms_force_connector_basic (force-edid)] new: kernel.kmod_is_loaded.i915: true
[151.642229] [019/156] (873s left) kms_psr (fbc-pr-primary-blt)
[151.732716] Starting subtest: fbc-pr-primary-blt
[151.734674] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[151.799809] [020/156] (873s left) gem_exec_balancer (hang)
[152.068166] Starting subtest: hang
[153.791012] Subtest hang: SUCCESS (1.732s)
[153.929120] [021/156] (871s left) gem_softpin (evict-single-offset)
[153.983066] Starting subtest: evict-single-offset
[177.824046] Subtest evict-single-offset: SUCCESS (23.832s)
[177.894659] [022/156] (847s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k)
[178.341195] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s)
[179.139018] [023/156] (846s left) gem_ctx_isolation (nonpriv)
[179.190680] Starting subtest: nonpriv
[179.191680] Starting dynamic subtest: rcs0
[179.448984] Dynamic subtest rcs0: SUCCESS (0.258s)
[179.462425] Starting dynamic subtest: bcs0
[179.699433] Dynamic subtest bcs0: SUCCESS (0.250s)
[179.709747] Starting dynamic subtest: vcs0
[179.939744] Dynamic subtest vcs0: SUCCESS (0.240s)
[179.951288] Starting dynamic subtest: vcs1
[181.041912] Dynamic subtest vcs1: SUCCESS (1.101s)
[181.051938] Starting dynamic subtest: vecs0
[183.028562] Dynamic subtest vecs0: SUCCESS (1.986s)
[183.039035] Starting dynamic subtest: ccs0
[185.064274] Dynamic subtest ccs0: SUCCESS (2.035s)
[185.065405] Subtest nonpriv: SUCCESS (5.874s)
[185.282455] [024/156] (840s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[185.367110] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[185.397980] Starting dynamic subtest: pipe-A-plane-0
[185.695861] Dynamic subtest pipe-A-plane-0: SUCCESS (0.300s)
[185.704055] Starting dynamic subtest: pipe-A-plane-3
[185.929303] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[185.940026] Starting dynamic subtest: pipe-A-plane-5
[185.941948] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[187.027238] Starting dynamic subtest: pipe-B-plane-0
[187.318013] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[187.327138] Starting dynamic subtest: pipe-B-plane-3
[187.551056] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[187.559107] Starting dynamic subtest: pipe-B-plane-5
[187.560903] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[187.859636] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SUCCESS (2.492s)
[188.663511] [025/156] (836s left) prime_vgem (basic-read)
[188.735479] Starting subtest: basic-read
[188.754401] Subtest basic-read: SKIP (0.018s)
[188.872888] [026/156] (836s left) kms_vblank (wait-forked-hang)
[188.955346] Starting subtest: wait-forked-hang
[188.956328] Starting dynamic subtest: pipe-A-eDP-1
[215.583104] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.625s)
[215.594865] Starting dynamic subtest: pipe-D-eDP-1
[240.600608] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.013s)
[240.601848] Subtest wait-forked-hang: SUCCESS (51.641s)
[241.457314] [027/156] (783s left) kms_content_protection (content-type-change)
[241.587123] Starting subtest: content-type-change
[241.589376] Subtest content-type-change: SKIP (0.000s)
[241.711551] [028/156] (783s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[241.754203] Starting subtest: legacy-engines-hostile-preempt
[241.755124] Starting dynamic subtest: render
[241.820185] Dynamic subtest render: SUCCESS (0.067s)
[241.832404] Starting dynamic subtest: bsd1
[243.782311] Dynamic subtest bsd1: SUCCESS (1.950s)
[243.793318] Starting dynamic subtest: bsd2
[245.766410] Dynamic subtest bsd2: SUCCESS (1.981s)
[245.776848] Starting dynamic subtest: blt
[245.819478] Dynamic subtest blt: SUCCESS (0.060s)
[245.829488] Starting dynamic subtest: vebox
[247.813390] Dynamic subtest vebox: SUCCESS (1.982s)
[247.814645] Subtest legacy-engines-hostile-preempt: SUCCESS (6.050s)
[247.932546] [029/156] (777s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[248.032053] Starting subtest: sprite-rotation-90-pos-100-0
[248.033589] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[248.107349] [030/156] (777s left) gem_mmap_wc (fault-concurrent)
[248.159250] Subtest fault-concurrent: SKIP (0.000s)
[248.224902] [031/156] (777s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[248.307187] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[248.308863] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[249.460805] [032/156] (776s left) gem_exec_reloc (basic-softpin)
[249.516346] Subtest basic-softpin: SKIP (0.000s)
[249.578854] [033/156] (776s left) gem_media_vme
[249.692351] [034/156] (775s left) gem_ctx_param (get-priority-new-ctx)
[249.741490] Starting subtest: get-priority-new-ctx
[249.742436] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[249.859496] [035/156] (775s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[249.971533] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[249.973360] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[250.072785] [036/156] (775s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[250.155500] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[250.156500] Starting dynamic subtest: pipe-A-eDP-1
[250.165428] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[250.174571] Starting dynamic subtest: pipe-B-eDP-1
[250.183400] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[250.191790] Starting dynamic subtest: pipe-C-eDP-1
[250.199879] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[250.208107] Starting dynamic subtest: pipe-D-eDP-1
[250.216573] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[250.218289] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s)
[252.389774] [037/156] (773s left) kms_plane (pixel-format-4-tiled-modifier)
[252.475881] Starting subtest: pixel-format-4-tiled-modifier
[252.503013] Starting dynamic subtest: pipe-A-plane-0
[252.902867] Dynamic subtest pipe-A-plane-0: SUCCESS (0.400s)
[252.912005] Starting dynamic subtest: pipe-A-plane-3
[253.225156] Dynamic subtest pipe-A-plane-3: SUCCESS (0.322s)
[253.233440] Starting dynamic subtest: pipe-A-plane-5
[253.235200] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[254.330819] Starting dynamic subtest: pipe-B-plane-0
[254.721558] Dynamic subtest pipe-B-plane-0: SUCCESS (0.400s)
[254.730764] Starting dynamic subtest: pipe-B-plane-3
[255.055041] Dynamic subtest pipe-B-plane-3: SUCCESS (0.333s)
[255.064978] Starting dynamic subtest: pipe-B-plane-5
[255.067257] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[255.375881] Subtest pixel-format-4-tiled-modifier: SUCCESS (2.900s)
[256.263244] [038/156] (769s left) gem_sync (basic-many-each)
[256.337289] Starting subtest: basic-many-each
[258.629155] Subtest basic-many-each: SUCCESS (2.285s)
[258.811537] [039/156] (767s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-indfb-pgflip-blt)
[258.912898] Starting subtest: fbchdr-2p-primscrn-indfb-pgflip-blt
[258.914629] Subtest fbchdr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[259.014560] [040/156] (766s left) gem_mmap_offset (bad-extensions)
[259.058490] Starting subtest: bad-extensions
[259.059528] Subtest bad-extensions: SUCCESS (0.000s)
[259.145291] [041/156] (766s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[259.244828] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[259.246593] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[259.361913] [042/156] (766s left) gem_exec_nop (basic-sequential)
[259.428857] Starting subtest: basic-sequential
[274.297269] Subtest basic-sequential: SUCCESS (14.870s)
[274.507046] [043/156] (751s left) kms_frontbuffer_tracking (hdr-shrfb-scaledprimary)
[274.608773] Starting subtest: hdr-shrfb-scaledprimary
[274.610598] Subtest hdr-shrfb-scaledprimary: SKIP (0.000s)
[274.703072] [044/156] (751s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt)
[274.789090] Starting subtest: fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt
[274.790810] Subtest fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[274.884246] [045/156] (751s left) kms_psr (fbc-psr2-cursor-plane-move)
[274.981469] Starting subtest: fbc-psr2-cursor-plane-move
[274.982387] Starting dynamic subtest: eDP-1
[274.984312] Dynamic subtest eDP-1: SKIP (0.000s)
[274.985890] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s)
[275.049538] [046/156] (751s left) perf_pmu (busy-start)
[275.086451] Starting subtest: busy-start
[275.087406] Starting dynamic subtest: rcs0
[277.640161] Dynamic subtest rcs0: SUCCESS (2.553s)
[277.650984] Starting dynamic subtest: bcs0
[280.202103] Dynamic subtest bcs0: SUCCESS (2.549s)
[280.212034] Starting dynamic subtest: vcs0
[283.805262] Dynamic subtest vcs0: SUCCESS (3.605s)
[283.815793] Starting dynamic subtest: vcs1
[287.837396] Dynamic subtest vcs1: SUCCESS (4.030s)
[287.846775] Starting dynamic subtest: vecs0
[291.805764] Dynamic subtest vecs0: SUCCESS (3.966s)
[291.816169] Starting dynamic subtest: ccs0
[294.359034] Dynamic subtest ccs0: SUCCESS (2.549s)
[294.359921] Subtest busy-start: SUCCESS (19.262s)
[294.446951] [047/156] (731s left) i915_drm_fdinfo (idle)
[294.488510] Starting subtest: idle
[294.489517] Starting dynamic subtest: rcs0
[295.035689] Dynamic subtest rcs0: SUCCESS (0.546s)
[295.046483] Starting dynamic subtest: bcs0
[295.573861] Dynamic subtest bcs0: SUCCESS (0.527s)
[295.584205] Starting dynamic subtest: vcs0
[296.079351] Dynamic subtest vcs0: SUCCESS (0.503s)
[296.089815] Starting dynamic subtest: vcs1
[296.585342] Dynamic subtest vcs1: SUCCESS (0.504s)
[296.596158] Starting dynamic subtest: vecs0
[297.090559] Dynamic subtest vecs0: SUCCESS (0.503s)
[297.101464] Starting dynamic subtest: ccs0
[297.596246] Dynamic subtest ccs0: SUCCESS (0.504s)
[297.597542] Subtest idle: SUCCESS (3.099s)
[297.660426] [048/156] (728s left) kms_async_flips (crc-atomic)
[297.755807] Starting subtest: crc-atomic
[298.141422] Starting dynamic subtest: pipe-A-eDP-1
[301.055598] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.914s)
[301.434123] Starting dynamic subtest: pipe-B-eDP-1
[304.341716] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.919s)
[304.713642] Starting dynamic subtest: pipe-C-eDP-1
[307.634069] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.929s)
[308.011013] Starting dynamic subtest: pipe-D-eDP-1
[310.931910] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.931s)
[310.932939] Subtest crc-atomic: SUCCESS (13.177s)
[312.166933] [049/156] (714s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[312.262286] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[312.263195] Starting dynamic subtest: pipe-A
[312.613357] Dynamic subtest pipe-A: SUCCESS (0.351s)
[312.623154] Starting dynamic subtest: pipe-B
[314.013864] Dynamic subtest pipe-B: SUCCESS (1.400s)
[314.023229] Starting dynamic subtest: pipe-C
[315.427365] Dynamic subtest pipe-C: SUCCESS (1.413s)
[315.444526] Starting dynamic subtest: pipe-D
[316.846197] Dynamic subtest pipe-D: SUCCESS (1.417s)
[316.846981] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.585s)
[318.058595] [050/156] (708s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[318.163083] Starting subtest: psr-shrfb-scaledprimary
[324.172803] Subtest psr-shrfb-scaledprimary: SUCCESS (6.010s)
[324.282066] [051/156] (701s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[324.364675] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[324.366715] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[325.465166] [052/156] (700s left) prime_busy (hang)
[325.526085] Starting subtest: hang
[325.526942] Starting dynamic subtest: rcs0
[351.346244] Dynamic subtest rcs0: SUCCESS (25.817s)
[351.356340] Starting dynamic subtest: bcs0
[358.434872] Dynamic subtest bcs0: SUCCESS (7.088s)
[358.445472] Starting dynamic subtest: vcs0
[365.476631] Dynamic subtest vcs0: SUCCESS (7.038s)
[365.487636] Starting dynamic subtest: vcs1
[372.452805] Dynamic subtest vcs1: SUCCESS (6.975s)
[372.468161] Starting dynamic subtest: vecs0
[379.488526] Dynamic subtest vecs0: SUCCESS (7.037s)
[379.499138] Starting dynamic subtest: ccs0
[393.327670] Dynamic subtest ccs0: SUCCESS (13.837s)
[393.328927] Subtest hang: SUCCESS (67.799s)
[393.461414] [053/156] (632s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[393.554321] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[393.556003] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[393.646432] [054/156] (632s left) drm_read (short-buffer-wakeup)
[393.811366] Starting subtest: short-buffer-wakeup
[426.037449] Subtest short-buffer-wakeup: SUCCESS (32.216s)
[426.146210] [055/156] (600s left) kms_frontbuffer_tracking (fbc-tiling-y)
[426.234605] Starting subtest: fbc-tiling-y
[426.236433] Subtest fbc-tiling-y: SKIP (0.000s)
[426.327711] [056/156] (600s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[426.430306] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[426.432679] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[426.528585] [057/156] (599s left) kms_feature_discovery (psr2)
[426.611673] Starting subtest: psr2
[426.612587] Subtest psr2: SUCCESS (0.000s)
[426.708788] [058/156] (599s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[426.794840] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-mmap-wc
[426.796531] Subtest hdr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[426.891773] [059/156] (599s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[426.989056] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[426.990917] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[427.082805] [060/156] (599s left) kms_psr (fbc-psr-primary-blt)
[427.165494] Starting subtest: fbc-psr-primary-blt
[427.166335] Starting dynamic subtest: eDP-1
[427.167930] Dynamic subtest eDP-1: SKIP (0.000s)
[427.169733] Subtest fbc-psr-primary-blt: SKIP (0.001s)
[427.235217] [061/156] (599s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[427.365551] Starting subtest: verify-pxp-key-change-after-suspend-resume
[435.335816] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.971s)
[444.516003] [062/156] (591s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[444.646963] Starting subtest: flip-vs-cursor-atomic-transitions
[452.716387] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (8.069s)
[453.540294] [063/156] (582s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-mmap-cpu)
[453.629137] Starting subtest: psrhdr-rgb565-draw-mmap-cpu
[453.630791] Subtest psrhdr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[453.725786] [064/156] (582s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-shrfb-plflip-blt)
[453.812298] Starting subtest: fbcpsrhdr-2p-scndscrn-shrfb-plflip-blt
[453.814153] Subtest fbcpsrhdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[453.902034] [065/156] (581s left) gem_exec_flush (basic-wb-rw-before-default)
[453.959233] Starting subtest: basic-wb-rw-before-default
[459.421221] Subtest basic-wb-rw-before-default: SUCCESS (5.461s)
[459.604515] [066/156] (576s left) syncobj_timeline (wait-all-interrupted)
[459.654474] Starting subtest: wait-all-interrupted
[459.761827] Subtest wait-all-interrupted: SUCCESS (0.106s)
[459.853316] [067/156] (576s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[459.948709] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-mmap-wc
[459.950437] Subtest hdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[460.044837] [068/156] (575s left) kms_flip (flip-vs-expired-vblank-interruptible)
[460.148060] Starting subtest: flip-vs-expired-vblank-interruptible
[460.150889] Starting dynamic subtest: A-eDP1
[468.843398] Dynamic subtest A-eDP1: SUCCESS (8.665s)
[468.856621] Starting dynamic subtest: B-eDP1
[477.541567] Dynamic subtest B-eDP1: SUCCESS (8.696s)
[477.552171] Starting dynamic subtest: C-eDP1
[486.234993] Dynamic subtest C-eDP1: SUCCESS (8.678s)
[486.246502] Starting dynamic subtest: D-eDP1
[494.851041] Dynamic subtest D-eDP1: SUCCESS (8.615s)
[494.852142] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.666s)
[496.033371] [069/156] (539s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[496.120318] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[496.122546] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[496.202493] [070/156] (539s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-onoff)
[496.293547] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-onoff
[496.295277] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[496.390565] [071/156] (539s left) kms_frontbuffer_tracking (fbchdr-modesetfrombusy)
[496.486570] Starting subtest: fbchdr-modesetfrombusy
[496.488125] Subtest fbchdr-modesetfrombusy: SKIP (0.000s)
[496.585733] [072/156] (539s left) gem_exec_reloc (basic-gtt-read-noreloc)
[496.635467] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[496.699884] [073/156] (539s left) sysfs_heartbeat_interval (mixed)
[496.761660] Starting subtest: mixed
[496.762654] Starting dynamic subtest: vecs0
[501.956190] Dynamic subtest vecs0: SUCCESS (5.193s)
[501.973388] Starting dynamic subtest: ccs0
[507.149254] Dynamic subtest ccs0: SUCCESS (5.191s)
[507.166827] Starting dynamic subtest: vcs0
[512.347308] Dynamic subtest vcs0: SUCCESS (5.197s)
[512.361019] Starting dynamic subtest: bcs0
[517.553650] Dynamic subtest bcs0: SUCCESS (5.204s)
[517.567741] Starting dynamic subtest: rcs0
[522.763677] Dynamic subtest rcs0: SUCCESS (5.207s)
[522.776422] Starting dynamic subtest: vcs1
[527.964738] Dynamic subtest vcs1: SUCCESS (5.199s)
[527.967210] Subtest mixed: SUCCESS (31.203s)
[528.040340] [074/156] (508s left) syncobj_wait (single-wait-for-submit-signaled)
[528.082918] Starting subtest: single-wait-for-submit-signaled
[528.083986] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[528.179121] [075/156] (508s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-wc)
[528.270274] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-wc
[528.272015] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[528.376774] [076/156] (507s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[528.432492] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[528.538472] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.104s)
[528.610205] [077/156] (507s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[528.707934] Starting subtest: fbc-psr2-cursor-plane-update-sf
[528.708843] Starting dynamic subtest: pipe-A-eDP-1
[528.787725] Dynamic subtest pipe-A-eDP-1: SKIP (0.078s)
[528.797319] Starting dynamic subtest: pipe-B-eDP-1
[529.899036] Dynamic subtest pipe-B-eDP-1: SKIP (1.111s)
[529.900690] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.191s)
[531.126966] [078/156] (505s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[531.227686] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[531.229367] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[531.342551] [079/156] (505s left) gem_exec_reloc (basic-write-cpu-noreloc)
[531.387907] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[531.452057] [080/156] (504s left) kms_frontbuffer_tracking (hdr-rgb565-draw-pwrite)
[531.538492] Starting subtest: hdr-rgb565-draw-pwrite
[531.540122] Subtest hdr-rgb565-draw-pwrite: SKIP (0.000s)
[531.619431] [081/156] (504s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[531.672816] Subtest writes-after-reads-snoop: SKIP (0.000s)
[531.740820] [082/156] (504s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[531.836151] Starting subtest: 4-tiled-8bpp-rotate-90
[531.857840] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.022s)
[531.971713] [083/156] (504s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-blt)
[532.068343] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-blt
[532.069892] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[532.163868] [084/156] (504s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[532.264913] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[532.276723] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.011s)
[532.356914] [085/156] (504s left) gem_exec_schedule (preempt)
[532.417029] Starting subtest: preempt
[532.418047] Starting dynamic subtest: rcs0
[532.441622] Dynamic subtest rcs0: SUCCESS (0.024s)
[532.452346] Starting dynamic subtest: bcs0
[532.462067] Dynamic subtest bcs0: SUCCESS (0.020s)
[532.471168] Starting dynamic subtest: vcs0
[532.481546] Dynamic subtest vcs0: SUCCESS (0.019s)
[532.490916] Starting dynamic subtest: vcs1
[532.502187] Dynamic subtest vcs1: SUCCESS (0.020s)
[532.513895] Starting dynamic subtest: vecs0
[532.522423] Dynamic subtest vecs0: SUCCESS (0.019s)
[532.533118] Starting dynamic subtest: ccs0
[532.542453] Dynamic subtest ccs0: SUCCESS (0.019s)
[532.543376] Subtest preempt: SUCCESS (0.126s)
[533.851236] [086/156] (502s left) gem_userptr_blits (userfault)
[533.905926] Starting subtest: userfault
[533.910606] Subtest userfault: SUCCESS (0.006s)
[534.055854] [087/156] (502s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[534.178433] Starting subtest: cursorB-vs-flipB-atomic
[534.180226] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[534.330408] [088/156] (502s left) kms_pipe_stress (stress-xrgb8888-4tiled)
[534.419502] Starting subtest: stress-xrgb8888-4tiled
[540.438481] Subtest stress-xrgb8888-4tiled: SUCCESS (6.019s)
[540.491969] [089/156] (496s left) kms_psr (psr-cursor-blt)
[540.580220] Starting subtest: psr-cursor-blt
[540.581019] Starting dynamic subtest: eDP-1
[542.303632] Dynamic subtest eDP-1: SUCCESS (1.723s)
[542.304595] Subtest psr-cursor-blt: SUCCESS (1.724s)
[543.129610] [090/156] (493s left) gem_create (create-invalid-size)
[543.174889] Starting subtest: create-invalid-size
[543.175766] Subtest create-invalid-size: SUCCESS (0.000s)
[543.356619] [091/156] (493s left) kms_cursor_crc (cursor-random-128x128)
[543.566903] Starting subtest: cursor-random-128x128
[543.570900] Starting dynamic subtest: pipe-A-eDP-1
[546.925635] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.355s)
[546.958484] Starting dynamic subtest: pipe-D-eDP-1
[550.907346] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.958s)
[550.908487] Subtest cursor-random-128x128: SUCCESS (7.340s)
[551.731155] [092/156] (485s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[551.832739] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[551.835588] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[551.935981] [093/156] (484s left) gem_exec_schedule (thriceslice)
[551.992595] Starting subtest: thriceslice
[551.993681] Starting dynamic subtest: rcs0
[552.026253] Dynamic subtest rcs0: SUCCESS (0.034s)
[552.040622] Starting dynamic subtest: bcs0
[552.055364] Dynamic subtest bcs0: SUCCESS (0.029s)
[552.064311] Starting dynamic subtest: vcs0
[552.083873] Dynamic subtest vcs0: SUCCESS (0.028s)
[552.093263] Starting dynamic subtest: vcs1
[552.113856] Dynamic subtest vcs1: SUCCESS (0.029s)
[552.123376] Starting dynamic subtest: vecs0
[552.144135] Dynamic subtest vecs0: SUCCESS (0.029s)
[552.152978] Starting dynamic subtest: ccs0
[552.196265] Dynamic subtest ccs0: SUCCESS (0.051s)
[552.197623] Subtest thriceslice: SUCCESS (0.206s)
[552.492758] [094/156] (484s left) kms_cursor_crc (cursor-random-64x21)
[552.680624] Starting subtest: cursor-random-64x21
[552.730660] Subtest cursor-random-64x21: SKIP (0.048s)
[552.957184] [095/156] (483s left) gem_userptr_blits (invalid-null-pointer)
[553.010487] Starting subtest: invalid-null-pointer
[553.011522] Subtest invalid-null-pointer: SUCCESS (0.001s)
[553.117746] [096/156] (483s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[553.200536] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[553.202880] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[554.327530] [097/156] (482s left) kms_psr (pr-sprite-plane-onoff)
[554.426358] Starting subtest: pr-sprite-plane-onoff
[554.428237] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[554.497398] [098/156] (482s left) vgem_basic (dmabuf-export)
[554.542464] Starting subtest: dmabuf-export
[554.585562] Subtest dmabuf-export: SUCCESS (0.045s)
[554.672884] [099/156] (482s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[554.731081] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[554.799349] [100/156] (482s left) kms_lease (setcrtc-implicit-plane)
[554.881531] Starting subtest: setcrtc-implicit-plane
[554.882419] Starting dynamic subtest: pipe-A-eDP-1
[555.350517] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.469s)
[555.362085] Starting dynamic subtest: pipe-B-eDP-1
[556.540862] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.188s)
[556.552102] Starting dynamic subtest: pipe-C-eDP-1
[557.723579] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.181s)
[557.735238] Starting dynamic subtest: pipe-D-eDP-1
[558.820478] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.094s)
[558.821531] Subtest setcrtc-implicit-plane: SUCCESS (3.940s)
[559.634104] [101/156] (477s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[559.721347] Starting subtest: psr-dirtyfb-ioctl
[559.722496] Starting dynamic subtest: A-eDP-1
[563.698580] Dynamic subtest A-eDP-1: SUCCESS (3.977s)
[563.699376] Subtest psr-dirtyfb-ioctl: SUCCESS (3.978s)
[564.531401] [102/156] (472s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-pwrite)
[564.623610] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-pwrite
[564.625360] Subtest fbchdr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[564.727815] [103/156] (472s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[564.820337] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[564.822112] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[564.924338] [104/156] (472s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[565.014189] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[565.015695] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[565.112152] [105/156] (472s left) syncobj_timeline (multi-wait-available-submitted)
[565.166668] Starting subtest: multi-wait-available-submitted
[565.167530] Subtest multi-wait-available-submitted: SUCCESS (0.000s)
[565.257017] [106/156] (472s left) gem_exec_params (dr1-dirt)
[565.314481] Starting subtest: DR1-dirt
[565.315571] Subtest DR1-dirt: SUCCESS (0.000s)
[565.424851] [107/156] (471s left) kms_plane_scaling (planes-upscale-20x20)
[565.505509] Starting subtest: planes-upscale-20x20
[565.506420] Starting dynamic subtest: pipe-A
[565.566821] Dynamic subtest pipe-A: SUCCESS (0.062s)
[565.578838] Starting dynamic subtest: pipe-B
[566.728012] Dynamic subtest pipe-B: SUCCESS (1.160s)
[566.741491] Starting dynamic subtest: pipe-C
[567.923402] Dynamic subtest pipe-C: SUCCESS (1.194s)
[567.934334] Starting dynamic subtest: pipe-D
[569.328154] Dynamic subtest pipe-D: SUCCESS (1.404s)
[569.329125] Subtest planes-upscale-20x20: SUCCESS (3.824s)
[570.540132] [108/156] (466s left) gem_flink_basic (bad-flink)
[570.588224] Starting subtest: bad-flink
[570.589242] Subtest bad-flink: SUCCESS (0.000s)
[570.683025] [109/156] (466s left) kms_flip (flip-vs-wf_vblank-interruptible)
[570.784198] Starting subtest: flip-vs-wf_vblank-interruptible
[570.786586] Starting dynamic subtest: A-eDP1
[572.748470] Dynamic subtest A-eDP1: SUCCESS (1.962s)
[572.765079] Starting dynamic subtest: B-eDP1
[574.652241] Dynamic subtest B-eDP1: SUCCESS (1.901s)
[574.666839] Starting dynamic subtest: C-eDP1
[576.532522] Dynamic subtest C-eDP1: SUCCESS (1.878s)
[576.544578] Starting dynamic subtest: D-eDP1
[578.434014] Dynamic subtest D-eDP1: SUCCESS (1.899s)
[578.435145] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.651s)
[579.641467] [110/156] (457s left) kms_frontbuffer_tracking (hdr-1p-primscrn-shrfb-pgflip-blt)
[579.738116] Starting subtest: hdr-1p-primscrn-shrfb-pgflip-blt
[579.740012] Subtest hdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[579.829813] [111/156] (457s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[579.884183] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[579.885024] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[579.969224] [112/156] (457s left) kms_pm_dc (dc5-dpms-negative)
[581.055146] Starting subtest: dc5-dpms-negative
[581.056705] Subtest dc5-dpms-negative: SKIP (0.000s)
[581.124065] [113/156] (456s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[581.213430] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[581.215317] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[581.324732] [114/156] (456s left) gem_fenced_exec_thrash (2-spare-fences)
[581.372854] Subtest 2-spare-fences: SKIP (0.000s)
[581.431808] [115/156] (456s left) gem_exec_whisper (basic-sync-all)
[581.490974] Starting subtest: basic-sync-all
[587.929751] Subtest basic-sync-all: SUCCESS (6.437s)
[588.111894] [116/156] (449s left) kms_frontbuffer_tracking (fbchdr-2p-rte)
[588.215177] Starting subtest: fbchdr-2p-rte
[588.217294] Subtest fbchdr-2p-rte: SKIP (0.000s)
[588.298882] [117/156] (449s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[588.391009] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[588.393218] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[588.475181] [118/156] (449s left) gem_basic (multigpu-create-close)
[588.528922] Starting subtest: multigpu-create-close
[588.532124] Subtest multigpu-create-close: SKIP (0.000s)
[588.650056] [119/156] (449s left) gem_pread (bench)
[588.700939] Subtest bench: SKIP (0.000s)
[588.756192] [120/156] (449s left) kms_vblank (query-forked-busy-hang)
[588.839901] Starting subtest: query-forked-busy-hang
[588.841085] Starting dynamic subtest: pipe-A-eDP-1
[602.646006] Dynamic subtest pipe-A-eDP-1: SUCCESS (13.806s)
[602.659430] Starting dynamic subtest: pipe-D-eDP-1
[627.554219] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.905s)
[627.555540] Subtest query-forked-busy-hang: SUCCESS (38.715s)
[628.424447] [121/156] (409s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[628.528972] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[628.530817] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[628.620811] [122/156] (409s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[628.900678] Starting subtest: parallel-dmabuf-import-out-fence
[630.218543] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.319s)
[630.308900] [123/156] (407s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[630.407297] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[630.409044] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s)
[630.477434] [124/156] (407s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[630.596026] Starting subtest: basic-flip-before-cursor-varying-size
[631.529652] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.933s)
[632.417933] [125/156] (405s left) gem_exec_whisper (basic-queues-all)
[632.473736] Starting subtest: basic-queues-all
[643.774560] Subtest basic-queues-all: SUCCESS (11.289s)
[643.949328] [126/156] (394s left) gem_softpin (overlap)
[644.014114] Starting subtest: overlap
[645.046627] Subtest overlap: SUCCESS (1.022s)
[645.146798] [127/156] (392s left) kms_frontbuffer_tracking (psrhdr-suspend)
[645.241107] Starting subtest: psrhdr-suspend
[645.242661] Subtest psrhdr-suspend: SKIP (0.000s)
[645.339164] [128/156] (392s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[645.428757] Starting subtest: fbcpsr-indfb-scaledprimary
[651.182655] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.754s)
[651.301670] [129/156] (386s left) syncobj_timeline (host-signal-points)
[651.358541] Starting subtest: host-signal-points
[651.361680] Subtest host-signal-points: SUCCESS (0.005s)
[651.454914] [130/156] (386s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[651.559246] Starting subtest: y-tiled-32bpp-rotate-90
[651.561127] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[651.651361] [131/156] (386s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[651.739978] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[658.518017] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.780s)
[658.670736] [132/156] (379s left) kms_selftest (drm_damage_helper)
[658.713810] Starting subtest: drm_damage_helper
[658.767627] Starting dynamic subtest: drm_test_damage_iter_no_damage
[658.868659] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.101s)
[658.881561] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[658.956578] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.085s)
[658.967189] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[659.053606] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.096s)
[659.065910] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[659.166751] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.110s)
[659.176937] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[659.268521] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.101s)
[659.279128] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[659.356433] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.088s)
[659.367943] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[659.438638] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.080s)
[659.450177] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[659.527742] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.088s)
[659.539561] Starting dynamic subtest: drm_test_damage_iter_single_damage
[659.617741] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.087s)
[659.628198] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[659.706466] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.087s)
[659.715891] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[659.805733] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.098s)
[659.816653] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[659.897576] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.090s)
[659.908868] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[659.981409] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.083s)
[659.991393] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[660.069568] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.087s)
[660.078886] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[660.161126] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.090s)
[660.170450] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[660.247018] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.084s)
[660.257206] Starting dynamic subtest: drm_test_damage_iter_damage
[660.332166] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.083s)
[660.344507] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[660.416061] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.082s)
[660.426695] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[660.513591] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.096s)
[660.522740] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[660.641044] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.122s)
[660.650374] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[660.735147] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.100s)
[660.738075] Subtest drm_damage_helper: SUCCESS (2.024s)
[660.879675] [133/156] (377s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[660.977357] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[660.979707] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[661.077347] [134/156] (377s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-blt)
[661.169739] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-blt
[661.171369] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[661.267551] [135/156] (377s left) gem_ctx_engines (execute-one)
[661.324383] Starting subtest: execute-one
[663.650876] Subtest execute-one: SUCCESS (2.326s)
[663.877861] [136/156] (374s left) gen9_exec_parse (bb-start-out)
[663.935902] Subtest bb-start-out: SKIP (0.000s)
[664.004909] [137/156] (374s left) api_intel_allocator (fork-simple-stress-signal)
[664.054427] Starting subtest: fork-simple-stress-signal
[669.505281] Subtest fork-simple-stress-signal: SUCCESS (5.405s)
[669.589826] [138/156] (368s left) gem_exec_params (mmapped)
[669.649528] Starting subtest: mmapped
[669.652726] Subtest mmapped: SUCCESS (0.005s)
[669.792556] [139/156] (368s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-render)
[669.898653] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-render
[669.900318] Subtest psrhdr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[670.041514] [140/156] (368s left) kms_chamelium_color (ctm-limited-range)
[670.131095] Subtest ctm-limited-range: SKIP (0.000s)
[670.178101] [141/156] (368s left) api_intel_bb (intel-bb-blit-x)
[670.231558] Starting subtest: intel-bb-blit-x
[673.702867] Subtest intel-bb-blit-x: SUCCESS (3.460s)
[673.792643] [142/156] (364s left) kms_invalid_mode (zero-hdisplay)
[673.886081] Starting subtest: zero-hdisplay
[673.887098] Starting dynamic subtest: pipe-A-eDP-1
[674.181201] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.295s)
[674.190884] Starting dynamic subtest: pipe-B-eDP-1
[674.191816] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[674.200832] Starting dynamic subtest: pipe-C-eDP-1
[674.201739] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[674.212893] Starting dynamic subtest: pipe-D-eDP-1
[674.213877] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[674.214788] Subtest zero-hdisplay: SUCCESS (0.301s)
[675.022472] [143/156] (363s left) i915_query (query-topology-kernel-writes)
[675.067308] Starting subtest: query-topology-kernel-writes
[675.068374] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[675.160156] [144/156] (363s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[675.269196] Starting subtest: 2x-flip-vs-cursor-legacy
[675.272046] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[675.412322] [145/156] (363s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[675.496325] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[675.497235] Starting dynamic subtest: pipe-A-default-mode
[678.190323] Dynamic subtest pipe-A-default-mode: SUCCESS (2.692s)
[678.191371] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.693s)
[679.048433] [146/156] (359s left) kms_prime (basic-modeset-hybrid)
[679.131111] Subtest basic-modeset-hybrid: SKIP (0.000s)
[679.237794] [147/156] (359s left) kms_frontbuffer_tracking (hdr-1p-primscrn-indfb-msflip-blt)
[679.335938] Starting subtest: hdr-1p-primscrn-indfb-msflip-blt
[679.337805] Subtest hdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[679.427773] [148/156] (359s left) kms_busy (extended-modeset-hang-oldfb)
[679.522280] Starting subtest: extended-modeset-hang-oldfb
[679.523110] Starting dynamic subtest: pipe-A
[691.447592] Dynamic subtest pipe-A: SUCCESS (11.924s)
[691.459539] Starting dynamic subtest: pipe-D
[703.969339] Dynamic subtest pipe-D: SUCCESS (12.520s)
[703.970316] Subtest extended-modeset-hang-oldfb: SUCCESS (24.448s)
[704.817842] [149/156] (334s left) kms_atomic_transition (plane-all-transition-fencing)
[704.908465] Starting subtest: plane-all-transition-fencing
[704.909345] Starting dynamic subtest: pipe-A-eDP-1
[707.407227] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.498s)
[707.725627] Starting dynamic subtest: pipe-B-eDP-1
[710.922877] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.206s)
[711.218223] Subtest plane-all-transition-fencing: SUCCESS (6.310s)
[712.021578] [150/156] (326s left) gem_exec_fence (syncobj-timeline-chain-engines)
[712.602428] Starting subtest: syncobj-timeline-chain-engines
[712.721887] Subtest syncobj-timeline-chain-engines: SUCCESS (0.119s)
[713.909663] [151/156] (325s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc)
[714.001912] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc
[714.003619] Subtest fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[714.101478] [152/156] (324s left) perf_pmu (busy-double-start)
[714.140947] Starting subtest: busy-double-start
[714.141932] Starting dynamic subtest: rcs0
[717.746107] Dynamic subtest rcs0: FAIL (3.586s)
[717.756080] Starting dynamic subtest: bcs0
[721.303847] Dynamic subtest bcs0: SUCCESS (3.575s)
[721.318573] Starting dynamic subtest: vcs0
[725.334904] Dynamic subtest vcs0: SUCCESS (4.027s)
[725.345103] Starting dynamic subtest: vcs1
[729.304230] Dynamic subtest vcs1: SUCCESS (3.967s)
[729.317853] Starting dynamic subtest: vecs0
[733.354786] Dynamic subtest vecs0: SUCCESS (4.048s)
[733.372423] Starting dynamic subtest: ccs0
[736.957443] Dynamic subtest ccs0: FAIL (3.568s)
[736.958564] Subtest busy-double-start: FAIL (22.785s)
[737.022384] [153/156] (302s left) gem_exec_reloc (basic-wc-gtt-active)
[737.072568] Subtest basic-wc-gtt-active: SKIP (0.000s)
[737.143441] [154/156] (302s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[737.232470] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[737.233327] Starting dynamic subtest: pipe-A-eDP-1
[748.219952] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.987s)
[748.231700] Starting dynamic subtest: pipe-B-eDP-1
[759.899173] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.676s)
[759.900012] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (22.666s)
[760.721129] [155/156] (278s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[760.817310] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[767.291016] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.474s)
[767.412670] [156/156] (271s left) kms_cursor_edge_walk (128x128-right-edge)
[767.513386] Starting subtest: 128x128-right-edge
[767.514219] Starting dynamic subtest: pipe-A-eDP-1
[770.963941] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.449s)
[770.973722] Starting dynamic subtest: pipe-D-eDP-1
[774.158832] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.194s)
[774.159693] Subtest 128x128-right-edge: SUCCESS (6.645s)
[775.008376] Closing watchdogs
results: parsing output: 0/ for test: syncobj_timeline
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: gem_exec_reloc
results: parsing output: 3/ for test: kms_chamelium_hpd
results: parsing output: 4/ for test: kms_atomic
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: kms_color
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: i915_query
results: parsing output: 10/ for test: i915_pm_rpm
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: gem_ctx_sseu
results: parsing output: 14/ for test: gem_exec_fence
results: parsing output: 15/ for test: gem_render_copy
results: parsing output: 16/ for test: i915_module_load
results: parsing output: 17/ for test: kms_force_connector_basic
results: parsing output: 18/ for test: kms_psr
results: parsing output: 19/ for test: gem_exec_balancer
results: parsing output: 20/ for test: gem_softpin
results: parsing output: 21/ for test: kms_chamelium_edid
results: parsing output: 22/ for test: gem_ctx_isolation
results: parsing output: 23/ for test: kms_plane
results: parsing output: 24/ for test: prime_vgem
results: parsing output: 25/ for test: kms_vblank
results: parsing output: 26/ for test: kms_content_protection
results: parsing output: 27/ for test: gem_ctx_persistence
results: parsing output: 28/ for test: kms_rotation_crc
results: parsing output: 29/ for test: gem_mmap_wc
results: parsing output: 30/ for test: kms_ccs
results: parsing output: 31/ for test: gem_exec_reloc
results: parsing output: 32/ for test: gem_media_vme
results: parsing output: 33/ for test: gem_ctx_param
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_ccs
results: parsing output: 36/ for test: kms_plane
results: parsing output: 37/ for test: gem_sync
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_mmap_offset
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gem_exec_nop
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_psr
results: parsing output: 45/ for test: perf_pmu
results: parsing output: 46/ for test: i915_drm_fdinfo
results: parsing output: 47/ for test: kms_async_flips
results: parsing output: 48/ for test: kms_plane_scaling
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_ccs
results: parsing output: 51/ for test: prime_busy
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: drm_read
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_feature_discovery
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: gem_pxp
results: parsing output: 61/ for test: kms_cursor_legacy
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: gem_exec_flush
results: parsing output: 65/ for test: syncobj_timeline
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_flip
results: parsing output: 68/ for test: kms_flip_scaled_crc
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_exec_reloc
results: parsing output: 72/ for test: sysfs_heartbeat_interval
results: parsing output: 73/ for test: syncobj_wait
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: kms_psr2_sf
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_exec_reloc
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: gem_partial_pwrite_pread
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_flip
results: parsing output: 84/ for test: gem_exec_schedule
results: parsing output: 85/ for test: gem_userptr_blits
results: parsing output: 86/ for test: kms_cursor_legacy
results: parsing output: 87/ for test: kms_pipe_stress
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: gem_create
results: parsing output: 90/ for test: kms_cursor_crc
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: gem_exec_schedule
results: parsing output: 93/ for test: kms_cursor_crc
results: parsing output: 94/ for test: gem_userptr_blits
results: parsing output: 95/ for test: kms_ccs
results: parsing output: 96/ for test: kms_psr
results: parsing output: 97/ for test: vgem_basic
results: parsing output: 98/ for test: gem_exec_reloc
results: parsing output: 99/ for test: kms_lease
results: parsing output: 100/ for test: kms_dirtyfb
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: gem_exec_params
results: parsing output: 106/ for test: kms_plane_scaling
results: parsing output: 107/ for test: gem_flink_basic
results: parsing output: 108/ for test: kms_flip
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: syncobj_wait
results: parsing output: 111/ for test: kms_pm_dc
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_fenced_exec_thrash
results: parsing output: 114/ for test: gem_exec_whisper
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: gem_basic
results: parsing output: 118/ for test: gem_pread
results: parsing output: 119/ for test: kms_vblank
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: gem_exec_balancer
results: parsing output: 122/ for test: kms_flip_scaled_crc
results: parsing output: 123/ for test: kms_cursor_legacy
results: parsing output: 124/ for test: gem_exec_whisper
results: parsing output: 125/ for test: gem_softpin
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: syncobj_timeline
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_selftest
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: kms_frontbuffer_tracking
results: parsing output: 134/ for test: gem_ctx_engines
results: parsing output: 135/ for test: gen9_exec_parse
results: parsing output: 136/ for test: api_intel_allocator
results: parsing output: 137/ for test: gem_exec_params
results: parsing output: 138/ for test: kms_frontbuffer_tracking
results: parsing output: 139/ for test: kms_chamelium_color
results: parsing output: 140/ for test: api_intel_bb
results: parsing output: 141/ for test: kms_invalid_mode
results: parsing output: 142/ for test: i915_query
results: parsing output: 143/ for test: kms_cursor_legacy
results: parsing output: 144/ for test: kms_flip_scaled_crc
results: parsing output: 145/ for test: kms_prime
results: parsing output: 146/ for test: kms_frontbuffer_tracking
results: parsing output: 147/ for test: kms_busy
results: parsing output: 148/ for test: kms_atomic_transition
results: parsing output: 149/ for test: gem_exec_fence
results: parsing output: 150/ for test: kms_frontbuffer_tracking
results: parsing output: 151/ for test: perf_pmu
results: parsing output: 152/ for test: gem_exec_reloc
results: parsing output: 153/ for test: kms_psr2_sf
results: parsing output: 154/ for test: kms_frontbuffer_tracking
results: parsing output: 155/ for test: kms_cursor_edge_walk
Done.