[58.854999] Initializing watchdogs [58.855063] /dev/watchdog0 [58.869941] [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] [58.874553] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.876940] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.880336] [001/133] (960s left) syncobj_wait (single-wait-all-for-submit-unsubmitted) [58.963777] Starting subtest: single-wait-all-for-submit-unsubmitted [59.067667] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.103s) [59.142414] [002/133] (960s left) gem_render_copy (y-tiled-to-vebox-y-tiled) [59.206294] Starting subtest: y-tiled-to-vebox-y-tiled [59.211099] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s) [59.405049] [003/133] (960s left) gem_userptr_blits (invalid-mmap-offset-unsync) [59.475979] Subtest invalid-mmap-offset-unsync: SKIP (0.000s) [59.597101] [004/133] (959s left) kms_plane_multiple (tiling-y) [59.708496] Starting subtest: tiling-y [59.713046] Subtest tiling-y: SKIP (0.000s) [59.779947] [005/133] (959s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset) [59.876654] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset [59.888872] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.013s) [59.966959] [006/133] (959s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt) [60.069268] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt [60.073440] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [60.187760] [007/133] (959s left) syncobj_timeline (multi-wait-available-signaled) [60.245913] Starting subtest: multi-wait-available-signaled [60.248286] Subtest multi-wait-available-signaled: SUCCESS (0.001s) [60.325024] [008/133] (959s left) perf (sysctl-defaults) [60.384527] Starting subtest: sysctl-defaults [60.386768] Subtest sysctl-defaults: SUCCESS (0.000s) [60.467220] [009/133] (959s left) i915_drm_fdinfo (context-close-stress) [60.510170] Starting subtest: context-close-stress [71.256457] Subtest context-close-stress: SUCCESS (10.744s) [71.327845] [010/133] (948s left) syncobj_basic (bad-destroy) [71.552087] Starting subtest: bad-destroy [71.554572] Subtest bad-destroy: SUCCESS (0.000s) [71.656953] [011/133] (948s left) kms_plane (pixel-format-4-tiled-modifier) [71.746962] Starting subtest: pixel-format-4-tiled-modifier [71.785568] Starting dynamic subtest: pipe-A-plane-0 [72.430477] Dynamic subtest pipe-A-plane-0: SUCCESS (0.645s) [72.440253] Starting dynamic subtest: pipe-A-plane-3 [72.885138] Dynamic subtest pipe-A-plane-3: SUCCESS (0.455s) [72.893942] Starting dynamic subtest: pipe-A-plane-5 [72.897466] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [74.230354] Starting dynamic subtest: pipe-B-plane-0 [74.891678] Dynamic subtest pipe-B-plane-0: SUCCESS (0.666s) [74.904512] Starting dynamic subtest: pipe-B-plane-3 [75.289272] Dynamic subtest pipe-B-plane-3: SUCCESS (0.400s) [75.297820] Starting dynamic subtest: pipe-B-plane-5 [75.301388] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [75.604738] Subtest pixel-format-4-tiled-modifier: SUCCESS (3.857s) [76.393788] [012/133] (943s left) kms_big_fb (yf-tiled-32bpp-rotate-180) [76.508706] Starting subtest: yf-tiled-32bpp-rotate-180 [76.513147] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s) [76.591814] [013/133] (943s left) gem_lmem_swapping (heavy-verify-random) [76.639564] Subtest heavy-verify-random: SKIP (0.000s) [76.680685] [014/133] (943s left) gem_render_copy (linear-to-vebox-y-tiled) [76.741406] Starting subtest: linear-to-vebox-y-tiled [76.745830] Subtest linear-to-vebox-y-tiled: SKIP (0.000s) [76.922023] [015/133] (943s left) kms_cursor_legacy (cursora-vs-flipa-toggle) [77.043576] Starting subtest: cursorA-vs-flipA-toggle [88.202726] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.156s) [89.035786] [016/133] (930s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling) [89.138872] Starting subtest: planes-downscale-factor-0-75-unity-scaling [89.141236] Starting dynamic subtest: pipe-A [89.202043] Dynamic subtest pipe-A: SUCCESS (0.065s) [89.210224] Starting dynamic subtest: pipe-B [90.349292] Dynamic subtest pipe-B: SUCCESS (1.146s) [90.357328] Starting dynamic subtest: pipe-C [91.448431] Dynamic subtest pipe-C: SUCCESS (1.098s) [91.456494] Starting dynamic subtest: pipe-D [92.588972] Dynamic subtest pipe-D: SUCCESS (1.140s) [92.591448] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.453s) [93.734062] [017/133] (926s left) kms_pm_backlight (brightness-with-dpms) [93.836636] Starting subtest: brightness-with-dpms [93.885469] Starting dynamic subtest: eDP-1 [96.323438] Dynamic subtest eDP-1: SUCCESS (2.436s) [96.325934] Subtest brightness-with-dpms: SUCCESS (2.488s) [97.202408] [018/133] (922s left) sw_sync (alloc_fence) [97.238853] Starting subtest: alloc_fence [97.241282] Subtest alloc_fence: SUCCESS (0.000s) [97.288838] [019/133] (922s left) gem_exec_fence (basic-busy-all) [97.359955] Starting subtest: basic-busy-all [97.459664] Subtest basic-busy-all: SUCCESS (0.101s) [98.986544] [FACT gem_exec_fence (basic-busy-all)] new: kernel.kmod_is_loaded.vgem: true [98.991032] [020/133] (921s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible) [99.094338] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible [99.106761] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s) [99.196661] [021/133] (920s left) gem_exec_fence (keep-in-fence) [99.374396] Starting subtest: keep-in-fence [99.376810] Starting dynamic subtest: rcs0 [99.428667] Dynamic subtest rcs0: SUCCESS (0.054s) [99.439096] Starting dynamic subtest: bcs0 [99.481731] Dynamic subtest bcs0: SUCCESS (0.053s) [99.491679] Starting dynamic subtest: vcs0 [100.887622] Dynamic subtest vcs0: SUCCESS (1.403s) [100.896962] Starting dynamic subtest: vcs1 [102.934183] Dynamic subtest vcs1: SUCCESS (2.045s) [102.945383] Starting dynamic subtest: vecs0 [104.919710] Dynamic subtest vecs0: SUCCESS (1.984s) [104.930734] Starting dynamic subtest: ccs0 [105.150829] Dynamic subtest ccs0: SUCCESS (0.231s) [105.153770] Subtest keep-in-fence: SUCCESS (5.776s) [106.985847] [022/133] (913s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area) [107.097757] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area [107.102254] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s) [107.166690] [023/133] (913s left) prime_vgem (busy) [107.237420] Starting subtest: busy [107.239701] Starting dynamic subtest: rcs0 [107.269219] Dynamic subtest rcs0: SUCCESS (0.032s) [107.277199] Starting dynamic subtest: bcs0 [107.324418] Dynamic subtest bcs0: SUCCESS (0.055s) [107.332521] Starting dynamic subtest: vcs0 [107.371510] Dynamic subtest vcs0: SUCCESS (0.046s) [107.379660] Starting dynamic subtest: vcs1 [107.418147] Dynamic subtest vcs1: SUCCESS (0.046s) [107.426355] Starting dynamic subtest: vecs0 [107.466569] Dynamic subtest vecs0: SUCCESS (0.048s) [107.474598] Starting dynamic subtest: ccs0 [107.512367] Dynamic subtest ccs0: SUCCESS (0.045s) [107.514609] Subtest busy: SUCCESS (0.275s) [107.652628] [024/133] (912s left) syncobj_timeline (single-wait-for-submit-available-submitted) [107.711570] Starting subtest: single-wait-for-submit-available-submitted [107.714080] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s) [107.820853] [025/133] (912s left) kms_sequence (get-forked-busy) [107.904098] Starting subtest: get-forked-busy [107.906465] Starting dynamic subtest: pipe-A-eDP-1 [109.823850] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.922s) [109.834270] Starting dynamic subtest: pipe-B-eDP-1 [112.391981] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.566s) [112.400659] Starting dynamic subtest: pipe-C-eDP-1 [115.043896] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.651s) [115.052602] Starting dynamic subtest: pipe-D-eDP-1 [117.644856] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.600s) [117.647293] Subtest get-forked-busy: SUCCESS (9.743s) [118.454295] [026/133] (901s left) gem_exec_suspend (basic-s3-devices) [118.512708] Starting subtest: basic-S3-devices [118.515107] Starting dynamic subtest: smem [129.880084] Dynamic subtest smem: SUCCESS (11.364s) [129.882978] Subtest basic-S3-devices: SUCCESS (11.366s) [130.066740] [027/133] (890s left) kms_flip (plain-flip-ts-check) [130.169159] Starting subtest: plain-flip-ts-check [130.171587] Starting dynamic subtest: A-eDP1 [139.043680] Dynamic subtest A-eDP1: SUCCESS (8.875s) [139.057589] Starting dynamic subtest: B-eDP1 [147.879776] Dynamic subtest B-eDP1: SUCCESS (8.835s) [147.889099] Starting dynamic subtest: C-eDP1 [156.702634] Dynamic subtest C-eDP1: SUCCESS (8.821s) [156.713723] Starting dynamic subtest: D-eDP1 [165.532865] Dynamic subtest D-eDP1: SUCCESS (8.828s) [165.538371] Subtest plain-flip-ts-check: SUCCESS (35.370s) [166.714253] [028/133] (853s left) gem_ctx_persistence (process) [166.772676] Starting subtest: process [166.963649] Subtest process: SUCCESS (0.191s) [167.043217] [029/133] (853s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [167.157302] Starting subtest: basic-busy-flip-before-cursor-legacy [167.161711] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [167.317757] [030/133] (853s left) perf (non-sampling-read-error) [167.428065] Starting subtest: non-sampling-read-error [167.439825] Subtest non-sampling-read-error: SUCCESS (0.010s) [167.477240] [031/133] (853s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff) [167.567367] Starting subtest: psr-1p-primscrn-spr-indfb-onoff [174.646153] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.083s) [174.777596] [032/133] (845s left) gem_spin_batch (resubmit-all) [174.833764] Starting subtest: resubmit-all [174.836029] Starting dynamic subtest: rcs0 [174.843425] Dynamic subtest rcs0: SUCCESS (0.012s) [174.854208] Starting dynamic subtest: bcs0 [174.856607] Dynamic subtest bcs0: SUCCESS (0.002s) [174.865329] Starting dynamic subtest: vcs0 [174.867236] Dynamic subtest vcs0: SUCCESS (0.002s) [174.875369] Starting dynamic subtest: vcs1 [174.877272] Dynamic subtest vcs1: SUCCESS (0.002s) [174.885341] Starting dynamic subtest: vecs0 [174.887266] Dynamic subtest vecs0: SUCCESS (0.002s) [174.895581] Starting dynamic subtest: ccs0 [174.897507] Dynamic subtest ccs0: SUCCESS (0.002s) [174.899402] Subtest resubmit-all: SUCCESS (0.025s) [176.972911] [033/133] (843s left) gem_exec_schedule (preempt-queue-contexts) [177.057784] Subtest preempt-queue-contexts: SKIP (0.000s) [177.347913] [034/133] (843s left) gem_render_copy (y-tiled-ccs-to-y-tiled) [177.407647] Starting subtest: y-tiled-ccs-to-y-tiled [177.412098] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s) [177.592238] [035/133] (843s left) gem_exec_balancer (nohangcheck) [177.865488] Starting subtest: nohangcheck [178.850706] Subtest nohangcheck: SUCCESS (0.986s) [178.977601] [036/133] (841s left) kms_frontbuffer_tracking (fbcpsr-slowdraw) [179.083471] Starting subtest: fbcpsr-slowdraw [204.279229] Subtest fbcpsr-slowdraw: SUCCESS (25.197s) [204.426859] [037/133] (816s left) gem_exec_schedule (preempt-self) [204.500629] Starting subtest: preempt-self [204.502888] Starting dynamic subtest: rcs0 [204.513125] Dynamic subtest rcs0: SUCCESS (0.022s) [204.523944] Starting dynamic subtest: bcs0 [204.530041] Dynamic subtest bcs0: SUCCESS (0.016s) [204.540428] Starting dynamic subtest: vcs0 [204.549678] Dynamic subtest vcs0: SUCCESS (0.019s) [204.558515] Starting dynamic subtest: vcs1 [204.570684] Dynamic subtest vcs1: SUCCESS (0.021s) [204.579618] Starting dynamic subtest: vecs0 [204.590290] Dynamic subtest vecs0: SUCCESS (0.019s) [204.599220] Starting dynamic subtest: ccs0 [204.608119] Dynamic subtest ccs0: SUCCESS (0.017s) [204.610353] Subtest preempt-self: SUCCESS (0.117s) [206.015329] [038/133] (814s left) kms_cursor_crc (cursor-rapid-movement-max-size) [206.318443] Starting subtest: cursor-rapid-movement-max-size [206.325778] Subtest cursor-rapid-movement-max-size: SKIP (0.000s) [206.464350] [039/133] (814s left) kms_rotation_crc (primary-x-tiled-reflect-x-180) [206.571093] Starting subtest: primary-x-tiled-reflect-x-180 [213.442202] Subtest primary-x-tiled-reflect-x-180: SUCCESS (6.874s) [214.640365] [040/133] (806s left) syncobj_timeline (invalid-signal-illegal-point) [214.699310] Starting subtest: invalid-signal-illegal-point [214.701647] Subtest invalid-signal-illegal-point: SUCCESS (0.000s) [214.790754] [041/133] (806s left) gen9_exec_parse (allowed-all) [214.843696] Subtest allowed-all: SKIP (0.000s) [214.910936] [042/133] (806s left) kms_content_protection (lic-type-1) [215.047971] Starting subtest: lic-type-1 [215.052423] Subtest lic-type-1: SKIP (0.000s) [215.165693] [043/133] (805s left) kms_async_flips (test-cursor) [215.255791] Starting subtest: test-cursor [215.630544] Starting dynamic subtest: pipe-A-eDP-1 [216.425925] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.796s) [216.811524] Starting dynamic subtest: pipe-B-eDP-1 [217.556852] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.753s) [217.933623] Starting dynamic subtest: pipe-C-eDP-1 [218.692746] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.766s) [219.057554] Starting dynamic subtest: pipe-D-eDP-1 [219.826322] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.776s) [219.828681] Subtest test-cursor: SUCCESS (4.571s) [220.989518] [044/133] (800s left) vgem_basic (bad-fence) [221.031892] Starting subtest: bad-fence [221.033892] Subtest bad-fence: SUCCESS (0.000s) [221.104284] [045/133] (800s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy) [221.177258] Starting subtest: map-fixed-invalidate-overlap-busy [221.181446] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s) [221.295466] [046/133] (799s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled) [221.358814] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled [221.467217] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.106s) [221.543381] [047/133] (799s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted) [221.596172] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted [221.598570] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s) [221.714883] [048/133] (799s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted) [221.775358] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted [221.883233] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.106s) [221.959520] [049/133] (799s left) kms_chamelium_audio (dp-audio) [222.358282] Subtest dp-audio: SKIP (0.000s) [223.204895] [050/133] (798s left) syncobj_wait (wait-any-complex) [223.260144] Starting subtest: wait-any-complex [223.322410] Subtest wait-any-complex: SUCCESS (0.062s) [223.400689] [051/133] (797s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs) [223.502696] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs [223.504850] Starting dynamic subtest: pipe-A-eDP-1 [223.527321] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [223.538250] Starting dynamic subtest: pipe-B-eDP-1 [223.559270] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [223.568185] Starting dynamic subtest: pipe-C-eDP-1 [223.589216] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [223.600866] Starting dynamic subtest: pipe-D-eDP-1 [223.623418] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [223.627628] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.006s) [225.781870] [052/133] (795s left) gem_userptr_blits (create-destroy-unsync) [225.851480] Subtest create-destroy-unsync: SKIP (0.000s) [225.981994] [053/133] (795s left) gem_render_copy (linear) [226.050211] Starting subtest: linear [226.052394] Starting dynamic subtest: smem [226.088792] Dynamic subtest smem: SUCCESS (0.041s) [226.091098] Subtest linear: SUCCESS (0.042s) [226.313091] [054/133] (795s left) gem_mmap_gtt (basic-write) [226.367497] Subtest basic-write: SKIP (0.000s) [226.430397] [055/133] (795s left) sw_sync (sync_multi_consumer_producer) [226.471273] Starting subtest: sync_multi_consumer_producer [226.775912] Subtest sync_multi_consumer_producer: SUCCESS (0.304s) [226.846016] [056/133] (794s left) kms_chamelium_edid (dp-edid-resolution-list) [227.236360] Subtest dp-edid-resolution-list: SKIP (0.000s) [228.006161] [057/133] (793s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted) [228.066676] Starting subtest: etime-multi-wait-all-available-unsubmitted [228.170357] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.103s) [228.253033] [058/133] (793s left) gem_ccs (ctrl-surf-copy-new-ctx) [228.313595] Starting subtest: ctrl-surf-copy-new-ctx [228.318377] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s) [228.421663] [059/133] (793s left) kms_busy (extended-modeset-hang-oldfb) [228.511257] Starting subtest: extended-modeset-hang-oldfb [228.513651] Starting dynamic subtest: pipe-A [240.111066] Dynamic subtest pipe-A: SUCCESS (11.600s) [240.120726] Starting dynamic subtest: pipe-D [252.375516] Dynamic subtest pipe-D: SUCCESS (12.259s) [252.378140] Subtest extended-modeset-hang-oldfb: SUCCESS (23.864s) [253.183479] [060/133] (768s left) gem_exec_reloc (basic-wc) [253.253325] Subtest basic-wc: SKIP (0.000s) [253.330978] [061/133] (768s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0) [253.442336] Starting subtest: linear-max-hw-stride-64bpp-rotate-0 [254.465947] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.023s) [254.571130] [062/133] (767s left) kms_plane_alpha_blend (alpha-basic) [254.663831] Starting subtest: alpha-basic [254.948307] Starting dynamic subtest: pipe-A-eDP-1 [256.874313] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.923s) [256.904903] Starting dynamic subtest: pipe-D-eDP-1 [259.549634] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.653s) [259.551804] Subtest alpha-basic: SUCCESS (4.888s) [260.435773] [063/133] (761s left) perf (gen12-group-exclusive-stream-sample-oa) [260.539229] Starting subtest: gen12-group-exclusive-stream-sample-oa [260.560039] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.020s) [260.611545] [064/133] (761s left) gem_exec_gttfill (engines) [260.677708] Starting subtest: engines [260.680110] Starting dynamic subtest: rcs0 [283.646063] Dynamic subtest rcs0: SUCCESS (22.966s) [283.658309] Starting dynamic subtest: bcs0 [306.919711] Dynamic subtest bcs0: SUCCESS (23.270s) [306.929793] Starting dynamic subtest: vcs0 [330.225753] Dynamic subtest vcs0: SUCCESS (23.302s) [330.238029] Starting dynamic subtest: vcs1 [353.528757] Dynamic subtest vcs1: SUCCESS (23.300s) [353.538207] Starting dynamic subtest: vecs0 [376.825054] Dynamic subtest vecs0: SUCCESS (23.293s) [376.836147] Starting dynamic subtest: ccs0 [400.111459] Dynamic subtest ccs0: SUCCESS (23.283s) [400.114043] Subtest engines: SUCCESS (139.430s) [400.305589] [065/133] (621s left) gem_mmap (pf-nonblock) [400.404726] Subtest pf-nonblock: SKIP (0.000s) [400.476552] [066/133] (621s left) kms_addfb_basic (addfb25-bad-modifier) [400.577028] Starting subtest: addfb25-bad-modifier [400.578903] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [400.688172] [067/133] (621s left) kms_vblank (ts-continuation-dpms-suspend) [400.779554] Starting subtest: ts-continuation-dpms-suspend [400.781673] Starting dynamic subtest: pipe-A-eDP-1 [417.896590] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.848s) [417.911323] Starting dynamic subtest: pipe-D-eDP-1 [435.888854] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.472s) [435.891909] Subtest ts-continuation-dpms-suspend: SUCCESS (4.323s) [436.694104] [068/133] (585s left) perf_pmu (frequency) [436.743873] Starting subtest: frequency [436.749904] Starting dynamic subtest: gt0 [438.889958] Dynamic subtest gt0: SUCCESS (2.115s) [438.904949] Starting dynamic subtest: idle-gt0 [439.398397] Dynamic subtest idle-gt0: SUCCESS (0.504s) [439.411237] Starting dynamic subtest: gt1 [443.647046] Dynamic subtest gt1: SUCCESS (4.215s) [443.659521] Starting dynamic subtest: idle-gt1 [444.153421] Dynamic subtest idle-gt1: SUCCESS (0.504s) [444.156335] Subtest frequency: SUCCESS (7.355s) [444.254914] [069/133] (577s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render) [444.369786] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render [448.765033] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.386s) [449.973461] [070/133] (572s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt) [450.073774] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt [457.436881] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.354s) [457.562012] [071/133] (564s left) i915_query (query-regions-unallocated) [457.623956] Starting subtest: query-regions-unallocated [457.626816] Subtest query-regions-unallocated: SUCCESS (0.000s) [457.722577] [072/133] (564s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary) [457.829387] Starting subtest: fbcpsr-indfb-scaledprimary [463.591287] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.761s) [463.708466] [073/133] (558s left) gem_compute (compute-square) [463.759412] Starting subtest: compute-square [463.762459] Subtest compute-square: SUCCESS (0.006s) [463.895758] [074/133] (558s left) gem_mmap_gtt (cpuset-medium-copy-odd) [463.955928] Subtest cpuset-medium-copy-odd: SKIP (0.000s) [464.019313] [075/133] (558s left) syncobj_wait (single-wait-all-for-submit-signaled) [464.082951] Starting subtest: single-wait-all-for-submit-signaled [464.085916] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [464.166397] [076/133] (558s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc) [464.257701] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc [464.260494] Starting dynamic subtest: pipe-A-eDP-1 [464.284125] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [464.295773] Starting dynamic subtest: pipe-B-eDP-1 [464.318050] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [464.327655] Starting dynamic subtest: pipe-C-eDP-1 [464.349935] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [464.362036] Starting dynamic subtest: pipe-D-eDP-1 [464.385517] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [464.387760] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s) [466.513505] [077/133] (556s left) kms_flip (flip-vs-suspend-interruptible) [466.609825] Starting subtest: flip-vs-suspend-interruptible [466.612417] Starting dynamic subtest: A-eDP1 [515.356747] Dynamic subtest A-eDP1: SUCCESS (4.585s) [515.372810] Starting dynamic subtest: B-eDP1 [564.354398] Dynamic subtest B-eDP1: SUCCESS (4.439s) [564.366036] Starting dynamic subtest: C-eDP1 [613.343180] Dynamic subtest C-eDP1: SUCCESS (4.432s) [613.354696] Starting dynamic subtest: D-eDP1 [662.355270] Dynamic subtest D-eDP1: SUCCESS (4.558s) [662.361694] Subtest flip-vs-suspend-interruptible: SUCCESS (18.024s) [663.556413] [078/133] (359s left) gem_exec_flush (basic-wb-pro-default) [663.626505] Starting subtest: basic-wb-pro-default [669.098328] Subtest basic-wb-pro-default: SUCCESS (5.458s) [669.289611] [079/133] (353s left) kms_addfb_basic (unused-offsets) [669.349428] Starting subtest: unused-offsets [669.352265] Subtest unused-offsets: SUCCESS (0.000s) [669.512175] [080/133] (353s left) dmabuf_sync_file (export-basic) [669.552164] Starting subtest: export-basic [669.554207] Subtest export-basic: SUCCESS (0.001s) [669.606278] [081/133] (353s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [669.705568] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt [669.710480] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [669.806255] [082/133] (352s left) gem_exec_balancer (parallel-contexts) [670.065862] Starting subtest: parallel-contexts [672.831815] Subtest parallel-contexts: SUCCESS (2.761s) [673.454177] [083/133] (349s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw) [673.554539] Starting subtest: fbcpsr-2p-pri-indfb-multidraw [673.559975] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s) [673.668968] [084/133] (349s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf) [673.762111] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf [673.764938] Starting dynamic subtest: pipe-A-eDP-1 [673.860297] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s) [673.871970] Starting dynamic subtest: pipe-B-eDP-1 [675.039415] Dynamic subtest pipe-B-eDP-1: SKIP (1.175s) [675.044528] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.277s) [676.225128] [085/133] (346s left) kms_psr (fbc-pr-primary-blt) [676.332076] Starting subtest: fbc-pr-primary-blt [676.337085] Subtest fbc-pr-primary-blt: SKIP (0.000s) [676.407110] [086/133] (346s left) kms_big_fb (linear-64bpp-rotate-0) [676.512582] Starting subtest: linear-64bpp-rotate-0 [678.093824] Subtest linear-64bpp-rotate-0: SUCCESS (1.579s) [678.286944] [087/133] (344s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip) [678.390693] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip [678.396425] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s) [678.495515] [088/133] (344s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite) [678.602490] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite [678.607300] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [678.706089] [089/133] (344s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [678.794840] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip [679.430700] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.637s) [679.580731] [090/133] (343s left) kms_psr (fbc-psr2-cursor-render) [679.677512] Starting subtest: fbc-psr2-cursor-render [679.680427] Starting dynamic subtest: eDP-1 [679.685676] Dynamic subtest eDP-1: SKIP (0.000s) [679.691210] Subtest fbc-psr2-cursor-render: SKIP (0.001s) [679.750084] [091/133] (343s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt) [679.849111] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt [679.854518] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [679.949213] [092/133] (343s left) i915_pm_rpm (system-suspend-execbuf) [681.482094] Starting subtest: system-suspend-execbuf [739.251544] Subtest system-suspend-execbuf: SUCCESS (42.886s) [739.629461] [093/133] (283s left) syncobj_wait (wait-all-interrupted) [739.683050] Starting subtest: wait-all-interrupted [739.784532] Subtest wait-all-interrupted: SUCCESS (0.102s) [739.865146] [094/133] (283s left) kms_flip (2x-flip-vs-panning-interruptible) [739.975620] Starting subtest: 2x-flip-vs-panning-interruptible [739.987145] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s) [740.072125] [095/133] (283s left) kms_getfb (getfb-reject-nv12) [740.167979] Starting subtest: getfb-reject-nv12 [740.170411] Subtest getfb-reject-nv12: SUCCESS (0.001s) [740.261742] [096/133] (283s left) perf_pmu (init-wait) [740.306524] Starting subtest: init-wait [740.309081] Starting dynamic subtest: rcs0 [740.311355] Dynamic subtest rcs0: SUCCESS (0.001s) [740.321658] Starting dynamic subtest: bcs0 [740.324006] Dynamic subtest bcs0: SUCCESS (0.001s) [740.333770] Starting dynamic subtest: vcs0 [740.336128] Dynamic subtest vcs0: SUCCESS (0.001s) [740.346067] Starting dynamic subtest: vcs1 [740.348206] Dynamic subtest vcs1: SUCCESS (0.001s) [740.357786] Starting dynamic subtest: vecs0 [740.360375] Dynamic subtest vecs0: SUCCESS (0.001s) [740.370289] Starting dynamic subtest: ccs0 [740.372534] Dynamic subtest ccs0: SUCCESS (0.001s) [740.374957] Subtest init-wait: SUCCESS (0.009s) [740.417225] [097/133] (283s left) kms_flip (2x-absolute-wf_vblank-interruptible) [740.516026] Starting subtest: 2x-absolute-wf_vblank-interruptible [740.528353] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.011s) [740.607503] [098/133] (282s left) kms_psr (psr-cursor-plane-move) [740.714224] Starting subtest: psr-cursor-plane-move [740.716706] Starting dynamic subtest: eDP-1 [742.415437] Dynamic subtest eDP-1: SUCCESS (1.701s) [742.417445] Subtest psr-cursor-plane-move: SUCCESS (1.702s) [743.284270] [099/133] (280s left) gem_exec_whisper (basic-contexts) [743.348456] Starting subtest: basic-contexts [748.730810] Subtest basic-contexts: SUCCESS (5.381s) [748.922161] [100/133] (274s left) kms_addfb_basic (basic-y-tiled-legacy) [748.975602] Starting subtest: basic-y-tiled-legacy [748.981093] Subtest basic-y-tiled-legacy: SKIP (0.000s) [749.127172] [101/133] (274s left) gem_ctx_persistence (engines-mixed) [749.192403] Starting subtest: engines-mixed [749.195146] Starting dynamic subtest: rcs0 [749.270556] Dynamic subtest rcs0: SUCCESS (0.078s) [749.284162] Starting dynamic subtest: bcs0 [749.334769] Dynamic subtest bcs0: SUCCESS (0.062s) [749.347909] Starting dynamic subtest: vcs0 [749.385432] Dynamic subtest vcs0: SUCCESS (0.049s) [749.398956] Starting dynamic subtest: vcs1 [749.439910] Dynamic subtest vcs1: SUCCESS (0.053s) [749.453740] Starting dynamic subtest: vecs0 [749.494847] Dynamic subtest vecs0: SUCCESS (0.052s) [749.507749] Starting dynamic subtest: ccs0 [749.558180] Dynamic subtest ccs0: SUCCESS (0.060s) [749.561154] Subtest engines-mixed: SUCCESS (0.367s) [749.657867] [102/133] (274s left) kms_atomic_transition (plane-all-transition) [749.745509] Starting subtest: plane-all-transition [749.748032] Starting dynamic subtest: pipe-A-eDP-1 [752.240241] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s) [752.560179] Starting dynamic subtest: pipe-B-eDP-1 [755.820819] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.269s) [756.122901] Subtest plane-all-transition: SUCCESS (6.377s) [756.955071] [103/133] (266s left) i915_module_load (reload) [757.001365] Starting subtest: reload [761.147038] Subtest reload: SUCCESS (4.147s) [761.188749] [104/133] (262s left) kms_cursor_crc (cursor-offscreen-max-size) [763.263166] Starting subtest: cursor-offscreen-max-size [763.271163] Subtest cursor-offscreen-max-size: SKIP (0.000s) [763.384290] [105/133] (260s left) kms_cursor_legacy (cursor-vs-flip-varying-size) [763.500308] Starting subtest: cursor-vs-flip-varying-size [794.953322] Subtest cursor-vs-flip-varying-size: SUCCESS (31.445s) [795.785465] [106/133] (228s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner) [795.891849] Starting subtest: switch-modeset-ultra-joiner-big-joiner [795.896366] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s) [795.965197] [107/133] (227s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt) [796.059361] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt [796.064191] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [796.158533] [108/133] (227s left) kms_color_pipeline (plane-lut1d-ctm3x4) [796.249768] Starting subtest: plane-lut1d-ctm3x4 [796.395853] Starting dynamic subtest: pipe-A-plane-0 [796.574003] Dynamic subtest pipe-A-plane-0: SUCCESS (0.178s) [796.586966] Starting dynamic subtest: pipe-A-plane-1 [796.740643] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s) [796.750303] Starting dynamic subtest: pipe-A-plane-2 [796.895898] Dynamic subtest pipe-A-plane-2: SUCCESS (0.155s) [798.087218] Starting dynamic subtest: pipe-B-plane-0 [798.271520] Dynamic subtest pipe-B-plane-0: SUCCESS (0.199s) [798.281609] Starting dynamic subtest: pipe-B-plane-1 [798.439314] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s) [798.449409] Starting dynamic subtest: pipe-B-plane-2 [798.616885] Dynamic subtest pipe-B-plane-2: SUCCESS (0.177s) [799.827549] Starting dynamic subtest: pipe-C-plane-0 [799.964287] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s) [799.974161] Starting dynamic subtest: pipe-C-plane-1 [800.131408] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s) [800.142145] Starting dynamic subtest: pipe-C-plane-2 [800.276307] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s) [801.455240] Starting dynamic subtest: pipe-D-plane-0 [801.591599] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s) [801.601676] Starting dynamic subtest: pipe-D-plane-1 [801.747152] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s) [801.757901] Starting dynamic subtest: pipe-D-plane-2 [801.891085] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s) [802.183969] Subtest plane-lut1d-ctm3x4: SUCCESS (5.934s) [803.012156] [109/133] (220s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [803.109836] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [803.112177] Starting dynamic subtest: pipe-A-default-mode [804.272095] Dynamic subtest pipe-A-default-mode: SKIP (1.159s) [804.277346] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.161s) [804.396840] [110/133] (219s left) gem_mmap_offset (blt-coherency) [804.442430] Starting subtest: blt-coherency [804.449789] Subtest blt-coherency: SUCCESS (0.008s) [804.572933] [111/133] (219s left) kms_ccs (bad-pixel-format-yf-tiled-ccs) [804.666050] Starting subtest: bad-pixel-format-yf-tiled-ccs [804.668687] Starting dynamic subtest: pipe-A-eDP-1 [804.694638] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [804.706266] Starting dynamic subtest: pipe-B-eDP-1 [804.731499] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [804.741167] Starting dynamic subtest: pipe-C-eDP-1 [804.765541] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [804.775460] Starting dynamic subtest: pipe-D-eDP-1 [804.802492] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [804.807359] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.004s) [806.807171] [112/133] (217s left) kms_cursor_edge_walk (256x256-right-edge) [806.901145] Starting subtest: 256x256-right-edge [806.903568] Starting dynamic subtest: pipe-A-eDP-1 [810.371935] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.470s) [810.383119] Starting dynamic subtest: pipe-D-eDP-1 [813.485382] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.115s) [813.487927] Subtest 256x256-right-edge: SUCCESS (6.587s) [814.297122] [113/133] (209s left) gem_mmap_gtt (hang) [814.361364] Subtest hang: SKIP (0.000s) [814.420985] [114/133] (209s left) kms_chamelium_hpd (dp-hpd-for-each-pipe) [814.799377] Subtest dp-hpd-for-each-pipe: SKIP (0.000s) [815.600921] [115/133] (208s left) kms_flip (basic-plain-flip) [815.702029] Starting subtest: basic-plain-flip [815.704480] Starting dynamic subtest: A-eDP1 [817.423610] Dynamic subtest A-eDP1: SUCCESS (1.724s) [817.434435] Starting dynamic subtest: B-eDP1 [819.065155] Dynamic subtest B-eDP1: SUCCESS (1.639s) [819.077369] Starting dynamic subtest: C-eDP1 [820.697986] Dynamic subtest C-eDP1: SUCCESS (1.631s) [820.709484] Starting dynamic subtest: D-eDP1 [822.319552] Dynamic subtest D-eDP1: SUCCESS (1.619s) [822.322371] Subtest basic-plain-flip: SUCCESS (6.625s) [823.490769] [116/133] (200s left) kms_psr (fbc-psr-cursor-plane-onoff) [823.584475] Starting subtest: fbc-psr-cursor-plane-onoff [823.587452] Starting dynamic subtest: eDP-1 [823.593240] Dynamic subtest eDP-1: SKIP (0.000s) [823.598483] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.001s) [823.672272] [117/133] (200s left) kms_psr (pr-cursor-plane-move) [823.774300] Starting subtest: pr-cursor-plane-move [823.779066] Subtest pr-cursor-plane-move: SKIP (0.000s) [823.850167] [118/133] (200s left) kms_psr (psr-sprite-plane-onoff) [823.948652] Starting subtest: psr-sprite-plane-onoff [823.951045] Starting dynamic subtest: eDP-1 [825.732033] Dynamic subtest eDP-1: SUCCESS (1.780s) [825.734505] Subtest psr-sprite-plane-onoff: SUCCESS (1.781s) [826.543608] [119/133] (197s left) gem_ctx_shared (q-in-order) [826.611298] Starting subtest: Q-in-order [826.614164] Starting dynamic subtest: rcs0 [826.706900] Dynamic subtest rcs0: SUCCESS (0.095s) [826.728635] Starting dynamic subtest: vcs0 [826.794649] Dynamic subtest vcs0: SUCCESS (0.087s) [826.813023] Starting dynamic subtest: vcs1 [826.879457] Dynamic subtest vcs1: SUCCESS (0.084s) [826.897304] Starting dynamic subtest: vecs0 [826.959408] Dynamic subtest vecs0: SUCCESS (0.079s) [826.978406] Starting dynamic subtest: ccs0 [827.044680] Dynamic subtest ccs0: SUCCESS (0.083s) [827.047664] Subtest Q-in-order: SUCCESS (0.434s) [828.146758] [120/133] (196s left) gem_mmap_wc (write-read-distinct) [828.205510] Subtest write-read-distinct: SKIP (0.000s) [828.262306] [121/133] (196s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc) [828.359436] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc [828.364223] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [828.464117] [122/133] (196s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu) [828.558972] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu [835.246890] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.690s) [835.377950] [123/133] (189s left) kms_dirtyfb (psr-dirtyfb-ioctl) [835.472313] Starting subtest: psr-dirtyfb-ioctl [835.474886] Starting dynamic subtest: A-eDP-1 [839.391505] Dynamic subtest A-eDP-1: SUCCESS (3.919s) [839.394453] Subtest psr-dirtyfb-ioctl: SUCCESS (3.920s) [840.273016] [124/133] (184s left) kms_pm_rpm (modeset-lpsp-stress) [842.201910] Starting subtest: modeset-lpsp-stress [859.329547] Subtest modeset-lpsp-stress: SUCCESS (17.127s) [859.441017] [125/133] (165s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render) [859.536376] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render [863.672058] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.139s) [864.812756] [126/133] (159s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers) [864.911224] Starting subtest: plane-scaler-with-clipping-clamping-modifiers [864.913944] Starting dynamic subtest: pipe-A [865.259164] Dynamic subtest pipe-A: SUCCESS (0.351s) [865.269349] Starting dynamic subtest: pipe-B [866.684569] Dynamic subtest pipe-B: SUCCESS (1.425s) [866.694856] Starting dynamic subtest: pipe-C [868.117518] Dynamic subtest pipe-C: SUCCESS (1.431s) [868.128240] Starting dynamic subtest: pipe-D [869.553236] Dynamic subtest pipe-D: SUCCESS (1.435s) [869.555944] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.645s) [870.730144] [127/133] (154s left) gem_exec_reloc (basic-wc-gtt) [870.793178] Subtest basic-wc-gtt: SKIP (0.000s) [870.852459] [128/133] (153s left) api_intel_allocator (fork-simple-stress-signal) [870.904273] Starting subtest: fork-simple-stress-signal [876.306856] Subtest fork-simple-stress-signal: SUCCESS (5.402s) [876.431248] [129/133] (148s left) kms_feature_discovery (display) [876.551407] Starting subtest: display [876.554050] Subtest display: SUCCESS (0.000s) [876.628391] [130/133] (148s left) api_intel_bb (purge-bb) [876.686306] Starting subtest: purge-bb [876.688672] Subtest purge-bb: SUCCESS (0.004s) [876.816250] [131/133] (148s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc) [876.916336] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc [876.918882] Starting dynamic subtest: pipe-A-eDP-1 [877.748111] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.824s) [877.758508] Starting dynamic subtest: pipe-B-eDP-1 [879.305864] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.553s) [879.317399] Starting dynamic subtest: pipe-C-eDP-1 [880.872074] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.566s) [880.882459] Starting dynamic subtest: pipe-D-eDP-1 [882.368747] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.494s) [882.371675] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.443s) [883.547082] [132/133] (141s left) kms_big_fb (y-tiled-32bpp-rotate-180) [883.658546] Starting subtest: y-tiled-32bpp-rotate-180 [883.663688] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s) [883.763754] [133/133] (141s left) kms_invalid_mode (bad-vsync-start) [883.863297] Starting subtest: bad-vsync-start [883.865680] Starting dynamic subtest: pipe-A-eDP-1 [884.153229] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.293s) [884.163893] Starting dynamic subtest: pipe-B-eDP-1 [884.166514] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [884.176634] Starting dynamic subtest: pipe-C-eDP-1 [884.179122] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [884.189136] Starting dynamic subtest: pipe-D-eDP-1 [884.191458] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [884.194079] Subtest bad-vsync-start: SUCCESS (0.299s) [884.980052] Closing watchdogs results: parsing output: 0/ for test: syncobj_wait results: parsing output: 1/ for test: gem_render_copy results: parsing output: 2/ for test: gem_userptr_blits results: parsing output: 3/ for test: kms_plane_multiple results: parsing output: 4/ for test: kms_flip results: parsing output: 5/ for test: kms_frontbuffer_tracking results: parsing output: 6/ for test: syncobj_timeline results: parsing output: 7/ for test: perf results: parsing output: 8/ for test: i915_drm_fdinfo results: parsing output: 9/ for test: syncobj_basic results: parsing output: 10/ for test: kms_plane results: parsing output: 11/ for test: kms_big_fb results: parsing output: 12/ for test: gem_lmem_swapping results: parsing output: 13/ for test: gem_render_copy results: parsing output: 14/ for test: kms_cursor_legacy results: parsing output: 15/ for test: kms_plane_scaling results: parsing output: 16/ for test: kms_pm_backlight results: parsing output: 17/ for test: sw_sync results: parsing output: 18/ for test: gem_exec_fence results: parsing output: 19/ for test: kms_flip results: parsing output: 20/ for test: gem_exec_fence results: parsing output: 21/ for test: kms_psr2_sf results: parsing output: 22/ for test: prime_vgem results: parsing output: 23/ for test: syncobj_timeline results: parsing output: 24/ for test: kms_sequence results: parsing output: 25/ for test: gem_exec_suspend results: parsing output: 26/ for test: kms_flip results: parsing output: 27/ for test: gem_ctx_persistence results: parsing output: 28/ for test: kms_cursor_legacy results: parsing output: 29/ for test: perf results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: gem_spin_batch results: parsing output: 32/ for test: gem_exec_schedule results: parsing output: 33/ for test: gem_render_copy results: parsing output: 34/ for test: gem_exec_balancer results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: gem_exec_schedule results: parsing output: 37/ for test: kms_cursor_crc results: parsing output: 38/ for test: kms_rotation_crc results: parsing output: 39/ for test: syncobj_timeline results: parsing output: 40/ for test: gen9_exec_parse results: parsing output: 41/ for test: kms_content_protection results: parsing output: 42/ for test: kms_async_flips results: parsing output: 43/ for test: vgem_basic results: parsing output: 44/ for test: gem_userptr_blits results: parsing output: 45/ for test: syncobj_wait results: parsing output: 46/ for test: syncobj_wait results: parsing output: 47/ for test: syncobj_timeline results: parsing output: 48/ for test: kms_chamelium_audio results: parsing output: 49/ for test: syncobj_wait results: parsing output: 50/ for test: kms_ccs results: parsing output: 51/ for test: gem_userptr_blits results: parsing output: 52/ for test: gem_render_copy results: parsing output: 53/ for test: gem_mmap_gtt results: parsing output: 54/ for test: sw_sync results: parsing output: 55/ for test: kms_chamelium_edid results: parsing output: 56/ for test: syncobj_timeline results: parsing output: 57/ for test: gem_ccs results: parsing output: 58/ for test: kms_busy results: parsing output: 59/ for test: gem_exec_reloc results: parsing output: 60/ for test: kms_big_fb results: parsing output: 61/ for test: kms_plane_alpha_blend results: parsing output: 62/ for test: perf results: parsing output: 63/ for test: gem_exec_gttfill results: parsing output: 64/ for test: gem_mmap results: parsing output: 65/ for test: kms_addfb_basic results: parsing output: 66/ for test: kms_vblank results: parsing output: 67/ for test: perf_pmu results: parsing output: 68/ for test: kms_frontbuffer_tracking results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: i915_query results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: gem_compute results: parsing output: 73/ for test: gem_mmap_gtt results: parsing output: 74/ for test: syncobj_wait results: parsing output: 75/ for test: kms_ccs results: parsing output: 76/ for test: kms_flip results: parsing output: 77/ for test: gem_exec_flush results: parsing output: 78/ for test: kms_addfb_basic results: parsing output: 79/ for test: dmabuf_sync_file results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: gem_exec_balancer results: parsing output: 82/ for test: kms_frontbuffer_tracking results: parsing output: 83/ for test: kms_psr2_sf results: parsing output: 84/ for test: kms_psr results: parsing output: 85/ for test: kms_big_fb results: parsing output: 86/ for test: kms_big_fb results: parsing output: 87/ for test: kms_frontbuffer_tracking results: parsing output: 88/ for test: kms_big_fb results: parsing output: 89/ for test: kms_psr results: parsing output: 90/ for test: kms_frontbuffer_tracking results: parsing output: 91/ for test: i915_pm_rpm results: parsing output: 92/ for test: syncobj_wait results: parsing output: 93/ for test: kms_flip results: parsing output: 94/ for test: kms_getfb results: parsing output: 95/ for test: perf_pmu results: parsing output: 96/ for test: kms_flip results: parsing output: 97/ for test: kms_psr results: parsing output: 98/ for test: gem_exec_whisper results: parsing output: 99/ for test: kms_addfb_basic results: parsing output: 100/ for test: gem_ctx_persistence results: parsing output: 101/ for test: kms_atomic_transition results: parsing output: 102/ for test: i915_module_load results: parsing output: 103/ for test: kms_cursor_crc results: parsing output: 104/ for test: kms_cursor_legacy results: parsing output: 105/ for test: kms_joiner results: parsing output: 106/ for test: kms_frontbuffer_tracking results: parsing output: 107/ for test: kms_color_pipeline results: parsing output: 108/ for test: kms_flip_scaled_crc results: parsing output: 109/ for test: gem_mmap_offset results: parsing output: 110/ for test: kms_ccs results: parsing output: 111/ for test: kms_cursor_edge_walk results: parsing output: 112/ for test: gem_mmap_gtt results: parsing output: 113/ for test: kms_chamelium_hpd results: parsing output: 114/ for test: kms_flip results: parsing output: 115/ for test: kms_psr results: parsing output: 116/ for test: kms_psr results: parsing output: 117/ for test: kms_psr results: parsing output: 118/ for test: gem_ctx_shared results: parsing output: 119/ for test: gem_mmap_wc results: parsing output: 120/ for test: kms_frontbuffer_tracking results: parsing output: 121/ for test: kms_frontbuffer_tracking results: parsing output: 122/ for test: kms_dirtyfb results: parsing output: 123/ for test: kms_pm_rpm results: parsing output: 124/ for test: kms_frontbuffer_tracking results: parsing output: 125/ for test: kms_plane_scaling results: parsing output: 126/ for test: gem_exec_reloc results: parsing output: 127/ for test: api_intel_allocator results: parsing output: 128/ for test: kms_feature_discovery results: parsing output: 129/ for test: api_intel_bb results: parsing output: 130/ for test: kms_ccs results: parsing output: 131/ for test: kms_big_fb results: parsing output: 132/ for test: kms_invalid_mode Done.