[62.739678] Initializing watchdogs [62.739783] /dev/watchdog0 [62.755710] [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] [62.760050] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [62.762242] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [62.765528] [001/132] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt) [62.891662] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt [62.896201] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [62.982507] [002/132] (960s left) gem_exec_flush (basic-batch-kernel-default-wb) [63.038693] Starting subtest: basic-batch-kernel-default-wb [70.140335] Subtest basic-batch-kernel-default-wb: SUCCESS (7.064s) [70.330497] [003/132] (953s left) kms_atomic (plane-invalid-params-fence) [70.427209] Starting subtest: plane-invalid-params-fence [70.429442] Starting dynamic subtest: pipe-A-eDP-1 [70.850748] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.421s) [70.852662] Subtest plane-invalid-params-fence: SUCCESS (0.422s) [71.657936] [004/132] (951s left) kms_rmfb (close-fd) [71.743662] Starting subtest: close-fd [71.745742] Starting dynamic subtest: pipe-A-eDP-1 [71.849836] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.109s) [71.861884] Starting dynamic subtest: pipe-B-eDP-1 [73.029046] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.172s) [73.038492] Starting dynamic subtest: pipe-C-eDP-1 [74.250859] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.219s) [74.260064] Starting dynamic subtest: pipe-D-eDP-1 [75.382219] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.128s) [75.384143] Subtest close-fd: SUCCESS (3.633s) [76.600344] [005/132] (946s left) kms_dp_linktrain_fallback (dsc-fallback) [76.695621] Starting subtest: dsc-fallback [76.702076] Subtest dsc-fallback: SKIP (0.000s) [76.767259] [006/132] (946s left) syncobj_timeline (single-wait-signaled) [76.818646] Starting subtest: single-wait-signaled [76.820823] Subtest single-wait-signaled: SUCCESS (0.000s) [76.906143] [007/132] (946s left) kms_psr (psr-primary-page-flip) [76.988469] Starting subtest: psr-primary-page-flip [76.991021] Starting dynamic subtest: eDP-1 [78.712380] Dynamic subtest eDP-1: SUCCESS (1.723s) [78.714767] Subtest psr-primary-page-flip: SUCCESS (1.723s) [79.574664] [008/132] (943s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions) [79.704258] Starting subtest: flip-vs-cursor-atomic-transitions [87.611587] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.903s) [88.419095] [009/132] (935s left) gem_exec_fence (basic-busy-all) [88.481672] Starting subtest: basic-busy-all [88.570032] Subtest basic-busy-all: SUCCESS (0.090s) [90.401499] [FACT gem_exec_fence (basic-busy-all)] new: kernel.kmod_is_loaded.vgem: true [90.404629] [010/132] (933s left) kms_cursor_crc (cursor-sliding-32x32) [90.574592] Starting subtest: cursor-sliding-32x32 [90.623777] Subtest cursor-sliding-32x32: SKIP (0.044s) [90.885977] [011/132] (932s left) gem_exec_schedule (implicit-read-write) [90.959494] Starting subtest: implicit-read-write [90.961399] Starting dynamic subtest: rcs0 [91.064744] Dynamic subtest rcs0: SUCCESS (0.115s) [91.075669] Starting dynamic subtest: vcs0 [91.148268] Dynamic subtest vcs0: SUCCESS (0.082s) [91.159278] Starting dynamic subtest: vcs1 [91.234170] Dynamic subtest vcs1: SUCCESS (0.087s) [91.244090] Starting dynamic subtest: vecs0 [91.313892] Dynamic subtest vecs0: SUCCESS (0.079s) [91.324757] Starting dynamic subtest: ccs0 [91.402857] Dynamic subtest ccs0: SUCCESS (0.088s) [91.405398] Subtest implicit-read-write: SUCCESS (0.453s) [92.427355] [012/132] (931s left) vgem_basic (setversion) [92.480161] Starting subtest: setversion [92.484094] Subtest setversion: SUCCESS (0.000s) [92.539993] [013/132] (931s left) gem_exec_schedule (implicit-write-read) [92.608940] Starting subtest: implicit-write-read [92.610851] Starting dynamic subtest: rcs0 [92.713276] Dynamic subtest rcs0: SUCCESS (0.111s) [92.725129] Starting dynamic subtest: vcs0 [92.801509] Dynamic subtest vcs0: SUCCESS (0.088s) [92.812729] Starting dynamic subtest: vcs1 [92.882764] Dynamic subtest vcs1: SUCCESS (0.081s) [92.892620] Starting dynamic subtest: vecs0 [92.961966] Dynamic subtest vecs0: SUCCESS (0.079s) [92.973049] Starting dynamic subtest: ccs0 [93.057691] Dynamic subtest ccs0: SUCCESS (0.096s) [93.059944] Subtest implicit-write-read: SUCCESS (0.456s) [94.400447] [014/132] (929s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip) [94.500858] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip [94.505031] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s) [94.597690] [015/132] (929s left) kms_pm_dc (dc3co-vpb-simulation) [95.697746] Starting subtest: dc3co-vpb-simulation [105.058132] Subtest dc3co-vpb-simulation: SKIP (9.354s) [105.164411] [016/132] (918s left) core_getclient (basic) [105.224106] Starting subtest: basic [105.226421] Subtest basic: SUCCESS (0.000s) [105.315944] [017/132] (918s left) gem_exec_schedule (promotion) [105.382670] Starting subtest: promotion [105.384951] Starting dynamic subtest: rcs0 [105.482065] Dynamic subtest rcs0: SUCCESS (0.105s) [105.492260] Starting dynamic subtest: vcs0 [105.568618] Dynamic subtest vcs0: SUCCESS (0.086s) [105.578790] Starting dynamic subtest: vcs1 [105.650947] Dynamic subtest vcs1: SUCCESS (0.082s) [105.660752] Starting dynamic subtest: vecs0 [105.736017] Dynamic subtest vecs0: SUCCESS (0.085s) [105.746741] Starting dynamic subtest: ccs0 [105.822308] Dynamic subtest ccs0: SUCCESS (0.085s) [105.824851] Subtest promotion: SUCCESS (0.446s) [107.458969] [018/132] (916s left) kms_big_fb (y-tiled-16bpp-rotate-90) [107.557556] Starting subtest: y-tiled-16bpp-rotate-90 [107.561658] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s) [107.650442] [019/132] (916s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt) [107.751576] Starting subtest: fbc-rgb101010-draw-mmap-gtt [107.755646] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s) [107.861414] [020/132] (916s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled) [107.910919] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled [108.019747] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.108s) [108.098064] [021/132] (915s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers) [108.182798] Starting subtest: plane-upscale-factor-0-25-with-modifiers [108.185120] Starting dynamic subtest: pipe-A [108.519668] Dynamic subtest pipe-A: SUCCESS (0.338s) [108.529708] Starting dynamic subtest: pipe-B [109.922612] Dynamic subtest pipe-B: SUCCESS (1.403s) [109.932489] Starting dynamic subtest: pipe-C [111.352813] Dynamic subtest pipe-C: SUCCESS (1.429s) [111.361572] Starting dynamic subtest: pipe-D [112.781998] Dynamic subtest pipe-D: SUCCESS (1.428s) [112.784240] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.601s) [113.972363] [022/132] (910s left) kms_frontbuffer_tracking (fbcpsr-2p-rte) [114.072197] Starting subtest: fbcpsr-2p-rte [114.076145] Subtest fbcpsr-2p-rte: SKIP (0.000s) [114.175501] [023/132] (909s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs) [114.262250] Starting subtest: missing-ccs-buffer-y-tiled-ccs [114.264543] Starting dynamic subtest: pipe-A-eDP-1 [114.287610] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [114.297532] Starting dynamic subtest: pipe-B-eDP-1 [114.319085] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [114.326999] Starting dynamic subtest: pipe-C-eDP-1 [114.349351] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [114.357630] Starting dynamic subtest: pipe-D-eDP-1 [114.380938] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [114.385082] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.003s) [116.531709] [024/132] (907s left) kms_color (ctm-blue-to-red) [116.618083] Starting subtest: ctm-blue-to-red [116.619990] Starting dynamic subtest: pipe-A-eDP-1 [117.327678] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.710s) [117.336886] Starting dynamic subtest: pipe-B-eDP-1 [118.751893] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.423s) [118.760037] Starting dynamic subtest: pipe-C-eDP-1 [120.132652] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.381s) [120.142357] Starting dynamic subtest: pipe-D-eDP-1 [121.459571] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.325s) [121.461685] Subtest ctm-blue-to-red: SUCCESS (4.841s) [122.278755] [025/132] (901s left) kms_joiner (invalid-modeset-ultra-joiner) [122.376337] Starting subtest: invalid-modeset-ultra-joiner [122.380453] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s) [122.467589] [026/132] (901s left) syncobj_basic (bad-pad-fd-to-handle) [122.518797] Starting subtest: bad-pad-fd-to-handle [122.521059] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s) [122.620058] [027/132] (901s left) gem_pwrite (basic-exhaustion) [122.679391] Subtest basic-exhaustion: SKIP (0.000s) [122.743686] [028/132] (901s left) gem_lmem_swapping (parallel-random-verify) [122.790788] Subtest parallel-random-verify: SKIP (0.000s) [122.830545] [029/132] (901s left) kms_psr (fbc-psr-sprite-mmap-cpu) [122.925437] Starting subtest: fbc-psr-sprite-mmap-cpu [122.927754] Starting dynamic subtest: eDP-1 [122.932290] Dynamic subtest eDP-1: SKIP (0.000s) [122.936793] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.001s) [122.996269] [030/132] (901s left) gem_ctx_isolation (preservation-s3) [123.057566] Starting subtest: preservation-S3 [123.060051] Starting dynamic subtest: rcs0 [139.792111] Dynamic subtest rcs0: SUCCESS (2.630s) [139.803607] Starting dynamic subtest: bcs0 [156.774867] Dynamic subtest bcs0: SUCCESS (1.704s) [156.786323] Starting dynamic subtest: vcs0 [173.789697] Dynamic subtest vcs0: SUCCESS (3.424s) [173.799406] Starting dynamic subtest: vcs1 [191.775555] Dynamic subtest vcs1: SUCCESS (4.945s) [191.787169] Starting dynamic subtest: vecs0 [209.782027] Dynamic subtest vecs0: SUCCESS (5.062s) [209.791947] Starting dynamic subtest: ccs0 [227.790061] Dynamic subtest ccs0: SUCCESS (3.133s) [227.792419] Subtest preservation-S3: SUCCESS (20.901s) [238.026471] [031/132] (796s left) kms_content_protection (uevent) [238.168800] Starting subtest: uevent [238.173426] Subtest uevent: SKIP (0.000s) [238.308059] [032/132] (796s left) gem_ringfill (legacy-basic) [244.183761] Starting subtest: legacy-basic [244.186719] Starting dynamic subtest: default [244.231135] Dynamic subtest default: SUCCESS (0.046s) [244.242770] Starting dynamic subtest: render [244.274561] Dynamic subtest render: SUCCESS (0.041s) [244.284681] Starting dynamic subtest: bsd [244.317598] Dynamic subtest bsd: SUCCESS (0.041s) [244.327932] Starting dynamic subtest: bsd1 [244.359545] Dynamic subtest bsd1: SUCCESS (0.039s) [244.369972] Starting dynamic subtest: bsd2 [244.401679] Dynamic subtest bsd2: SUCCESS (0.039s) [244.417523] Starting dynamic subtest: blt [244.445437] Dynamic subtest blt: SUCCESS (0.041s) [244.455849] Starting dynamic subtest: vebox [244.487476] Dynamic subtest vebox: SUCCESS (0.039s) [244.489767] Subtest legacy-basic: SUCCESS (0.301s) [244.567739] [033/132] (790s left) prime_mmap (test_aperture_limit) [244.615040] Starting subtest: test_aperture_limit [244.617399] Starting dynamic subtest: test_aperture_limit-smem [244.626328] Dynamic subtest test_aperture_limit-smem: SKIP (0.009s) [244.631079] Subtest test_aperture_limit: SKIP (0.009s) [244.701441] [034/132] (789s left) prime_self_import (export-vs-gem_close-race) [244.737122] Starting subtest: export-vs-gem_close-race [249.818403] Subtest export-vs-gem_close-race: SUCCESS (5.026s) [249.906828] [035/132] (784s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs) [250.014282] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs [250.018833] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s) [251.142259] [036/132] (783s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite) [251.241746] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite [255.854411] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.593s) [256.976761] [037/132] (777s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible) [257.082085] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible [257.094597] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s) [257.169576] [038/132] (777s left) i915_query (hwconfig_table) [257.222497] Starting subtest: hwconfig_table [257.526312] Subtest hwconfig_table: SUCCESS (0.001s) [257.566289] [039/132] (777s left) syncobj_timeline (multi-wait-available-signaled) [257.614773] Starting subtest: multi-wait-available-signaled [257.617182] Subtest multi-wait-available-signaled: SUCCESS (0.000s) [257.715242] [040/132] (777s left) syncobj_wait (reset-multiple-signaled) [257.781662] Starting subtest: reset-multiple-signaled [257.783676] Subtest reset-multiple-signaled: SUCCESS (0.000s) [257.879531] [041/132] (777s left) prime_self_import (basic-with_two_bos) [257.913833] Starting subtest: basic-with_two_bos [257.943530] Subtest basic-with_two_bos: SUCCESS (0.031s) [258.060159] [042/132] (776s left) kms_addfb_basic (unused-modifier) [258.117031] Starting subtest: unused-modifier [258.118910] Subtest unused-modifier: SUCCESS (0.000s) [258.245835] [043/132] (776s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render) [258.349320] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render [265.198971] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.838s) [265.313598] [044/132] (769s left) kms_lease (invalid-create-leases) [265.403791] Starting subtest: invalid-create-leases [265.408210] Subtest invalid-create-leases: SUCCESS (0.005s) [265.511366] [045/132] (769s left) kms_feature_discovery (psr2) [265.590240] Starting subtest: psr2 [265.592443] Subtest psr2: SUCCESS (0.000s) [265.668570] [046/132] (769s left) gem_mmap_offset (partial-unmap) [265.715740] Starting subtest: partial-unmap [265.718100] Starting dynamic subtest: smem0 [266.210837] Dynamic subtest smem0: SUCCESS (0.496s) [266.213965] Subtest partial-unmap: SUCCESS (0.496s) [266.335504] [047/132] (768s left) gem_wait (busy) [266.411019] Starting subtest: busy [266.413322] Starting dynamic subtest: all-engines [268.179905] Dynamic subtest all-engines: SUCCESS (1.769s) [268.193342] Starting dynamic subtest: rcs0 [268.723918] Dynamic subtest rcs0: SUCCESS (0.542s) [268.738549] Starting dynamic subtest: bcs0 [269.265278] Dynamic subtest bcs0: SUCCESS (0.540s) [269.277051] Starting dynamic subtest: vcs0 [271.188310] Dynamic subtest vcs0: SUCCESS (1.920s) [271.200125] Starting dynamic subtest: vcs1 [273.108700] Dynamic subtest vcs1: SUCCESS (1.919s) [273.119367] Starting dynamic subtest: vecs0 [275.156820] Dynamic subtest vecs0: SUCCESS (2.046s) [275.168302] Starting dynamic subtest: ccs0 [275.699068] Dynamic subtest ccs0: SUCCESS (0.541s) [275.701811] Subtest busy: SUCCESS (9.286s) [275.909212] [048/132] (759s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic) [276.011307] Starting subtest: async-flip-with-page-flip-events-tiled-atomic [276.396438] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs [279.196337] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.799s) [279.208706] Starting dynamic subtest: pipe-A-eDP-1-4 [281.371288] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.173s) [281.382133] Starting dynamic subtest: pipe-A-eDP-1-4 [283.380843] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s) [283.390170] Starting dynamic subtest: pipe-A-eDP-1-x [285.560071] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.178s) [285.939211] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs [288.726452] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.794s) [288.738652] Starting dynamic subtest: pipe-B-eDP-1-4 [290.913014] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.186s) [290.922671] Starting dynamic subtest: pipe-B-eDP-1-4 [292.922993] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.008s) [292.939431] Starting dynamic subtest: pipe-B-eDP-1-x [295.114808] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.190s) [295.492936] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs [298.257323] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.772s) [298.269442] Starting dynamic subtest: pipe-C-eDP-1-4 [300.433198] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s) [300.445176] Starting dynamic subtest: pipe-C-eDP-1-4 [302.443795] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s) [302.455544] Starting dynamic subtest: pipe-C-eDP-1-x [304.622554] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s) [304.988692] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs [307.797058] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.815s) [307.808345] Starting dynamic subtest: pipe-D-eDP-1-4 [309.971805] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s) [309.981370] Starting dynamic subtest: pipe-D-eDP-1-4 [311.982725] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s) [311.992718] Starting dynamic subtest: pipe-D-eDP-1-x [314.173961] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.189s) [314.176409] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.151s) [315.399832] [049/132] (719s left) kms_cursor_crc (cursor-onscreen-64x21) [315.589424] Starting subtest: cursor-onscreen-64x21 [315.638198] Subtest cursor-onscreen-64x21: SKIP (0.044s) [315.878170] [050/132] (719s left) gem_media_vme [315.991648] [051/132] (719s left) gem_bad_reloc (negative-reloc-lut) [316.040133] Subtest negative-reloc-lut: SKIP (0.000s) [316.113515] [052/132] (719s left) gem_eio (wait-1us) [316.328043] Starting subtest: wait-1us [316.668229] Subtest wait-1us: SUCCESS (0.341s) [316.799364] [053/132] (718s left) kms_flip (blocking-wf_vblank) [316.895596] Starting subtest: blocking-wf_vblank [316.897556] Starting dynamic subtest: A-eDP1 [325.833251] Dynamic subtest A-eDP1: SUCCESS (8.932s) [325.844994] Starting dynamic subtest: B-eDP1 [334.760796] Dynamic subtest B-eDP1: SUCCESS (8.922s) [334.773319] Starting dynamic subtest: C-eDP1 [343.686806] Dynamic subtest C-eDP1: SUCCESS (8.927s) [343.696398] Starting dynamic subtest: D-eDP1 [352.613606] Dynamic subtest D-eDP1: SUCCESS (8.927s) [352.618897] Subtest blocking-wf_vblank: SUCCESS (35.720s) [353.859526] [054/132] (681s left) kms_atomic_interruptible (universal-setplane-primary) [353.949153] Starting subtest: universal-setplane-primary [353.951473] Starting dynamic subtest: pipe-A-eDP-1 [361.372927] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.422s) [361.374811] Subtest universal-setplane-primary: SUCCESS (7.424s) [362.221765] [055/132] (673s left) kms_chamelium_edid (dp-edid-read) [362.602679] Subtest dp-edid-read: SKIP (0.000s) [363.418710] [056/132] (672s left) kms_chamelium_audio (dp-audio-edid) [363.807225] Subtest dp-audio-edid: SKIP (0.000s) [364.652777] [057/132] (670s left) gem_exec_big (single) [364.710200] Starting subtest: single [369.391352] Subtest single: SUCCESS (4.679s) [369.658629] [058/132] (665s left) kms_psr (pr-primary-mmap-gtt) [369.798591] Starting subtest: pr-primary-mmap-gtt [369.803032] Subtest pr-primary-mmap-gtt: SKIP (0.000s) [369.874238] [059/132] (665s left) kms_plane (pixel-format-y-tiled-ccs-modifier) [369.958646] Starting subtest: pixel-format-y-tiled-ccs-modifier [369.962593] Subtest pixel-format-y-tiled-ccs-modifier: SKIP (0.000s) [370.036086] [060/132] (665s left) perf_pmu (busy-double-start) [370.081515] Starting subtest: busy-double-start [370.083798] Starting dynamic subtest: rcs0 [373.726771] Dynamic subtest rcs0: FAIL (3.590s) [373.738444] Starting dynamic subtest: bcs0 [377.242390] Dynamic subtest bcs0: SUCCESS (3.569s) [377.254781] Starting dynamic subtest: vcs0 [381.650185] Dynamic subtest vcs0: SUCCESS (4.405s) [381.662515] Starting dynamic subtest: vcs1 [385.682487] Dynamic subtest vcs1: SUCCESS (4.029s) [385.694639] Starting dynamic subtest: vecs0 [389.650150] Dynamic subtest vecs0: SUCCESS (3.965s) [389.663021] Starting dynamic subtest: ccs0 [393.286618] Dynamic subtest ccs0: FAIL (3.564s) [393.288623] Subtest busy-double-start: FAIL (23.132s) [393.332242] [061/132] (642s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu) [393.437881] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu [393.442159] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [393.556981] [062/132] (642s left) kms_big_fb (linear-addfb) [393.655348] Starting subtest: linear-addfb [393.657650] Subtest linear-addfb: SUCCESS (0.000s) [393.748214] [063/132] (642s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt) [393.845227] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt [401.369543] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.526s) [401.507441] [064/132] (634s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area) [401.618051] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area [401.622146] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s) [401.688780] [065/132] (634s left) perf (gen12-oa-tlb-invalidate) [401.847525] Starting subtest: gen12-oa-tlb-invalidate [401.849755] Starting dynamic subtest: 0-rcs0 [411.888863] Dynamic subtest 0-rcs0: SUCCESS (10.038s) [411.899742] Starting dynamic subtest: 1-vcs1 [421.940594] Dynamic subtest 1-vcs1: SUCCESS (10.047s) [421.943238] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.088s) [421.982747] [066/132] (613s left) kms_psr (psr2-primary-page-flip) [422.085718] Starting subtest: psr2-primary-page-flip [422.088013] Starting dynamic subtest: eDP-1 [423.782914] Dynamic subtest eDP-1: SUCCESS (1.696s) [423.785167] Subtest psr2-primary-page-flip: SUCCESS (1.697s) [424.687256] [067/132] (611s left) i915_drm_fdinfo (context-close-stress) [424.734739] Starting subtest: context-close-stress [435.481483] Subtest context-close-stress: SUCCESS (10.745s) [435.560802] [068/132] (600s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip) [435.797863] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip [435.802296] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [435.889454] [069/132] (600s left) syncobj_wait (signal) [435.951311] Starting subtest: signal [435.953634] Subtest signal: SUCCESS (0.000s) [436.059946] [070/132] (600s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [436.181567] Starting subtest: basic-flip-after-cursor-varying-size [437.156405] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.974s) [438.010614] [071/132] (598s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area) [438.113065] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area [438.115212] Starting dynamic subtest: pipe-A-eDP-1 [438.209789] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s) [438.222252] Starting dynamic subtest: pipe-B-eDP-1 [439.387184] Dynamic subtest pipe-B-eDP-1: SKIP (1.174s) [439.392081] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.277s) [440.572291] [072/132] (595s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [440.680970] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip [441.505686] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.826s) [441.660173] [073/132] (594s left) kms_addfb_basic (basic) [441.725517] Starting subtest: basic [441.727508] Subtest basic: SUCCESS (0.000s) [441.856537] [074/132] (594s left) kms_cursor_crc (cursor-sliding-256x256) [442.107376] Starting subtest: cursor-sliding-256x256 [442.112335] Starting dynamic subtest: pipe-A-eDP-1 [445.345924] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.232s) [445.376320] Starting dynamic subtest: pipe-D-eDP-1 [449.274196] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.906s) [449.276636] Subtest cursor-sliding-256x256: SUCCESS (7.164s) [450.153029] [075/132] (586s left) kms_fbcon_fbt (fbc-suspend) [450.215367] Starting subtest: fbc-suspend [499.849427] Subtest fbc-suspend: SUCCESS (19.678s) [501.224128] [076/132] (535s left) kms_fbcon_fbt (fbc) [501.293384] Starting subtest: fbc [507.687987] Subtest fbc: SUCCESS (6.351s) [508.816058] [077/132] (527s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render) [508.911082] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render [508.915834] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [509.006667] [078/132] (527s left) gem_render_copy (linear) [509.063445] Starting subtest: linear [509.066182] Starting dynamic subtest: smem [509.102456] Dynamic subtest smem: SUCCESS (0.040s) [509.105452] Subtest linear: SUCCESS (0.041s) [509.321951] [079/132] (527s left) gem_exec_await (wide-contexts) [509.553354] Starting subtest: wide-contexts [532.739077] Subtest wide-contexts: SUCCESS (23.090s) [532.945779] [080/132] (503s left) gem_exec_balancer (individual) [533.062809] Starting subtest: individual [534.954996] Subtest individual: SUCCESS (1.889s) [535.273051] [081/132] (501s left) kms_flip (plain-flip-interruptible) [535.372505] Starting subtest: plain-flip-interruptible [535.375185] Starting dynamic subtest: A-eDP1 [537.028188] Dynamic subtest A-eDP1: SUCCESS (1.652s) [537.041309] Starting dynamic subtest: B-eDP1 [538.661554] Dynamic subtest B-eDP1: SUCCESS (1.630s) [538.676190] Starting dynamic subtest: C-eDP1 [540.283231] Dynamic subtest C-eDP1: SUCCESS (1.619s) [540.294732] Starting dynamic subtest: D-eDP1 [541.921302] Dynamic subtest D-eDP1: SUCCESS (1.638s) [541.927052] Subtest plain-flip-interruptible: SUCCESS (6.553s) [543.079816] [082/132] (493s left) i915_pm_rpm (system-suspend-devices) [545.115449] Starting subtest: system-suspend-devices [552.786427] Subtest system-suspend-devices: SUCCESS (7.675s) [559.214878] [083/132] (483s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling) [559.319260] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling [559.324348] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.000s) [559.393991] [084/132] (483s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling) [559.483075] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling [559.485601] Starting dynamic subtest: pipe-A-default-mode [562.228614] Dynamic subtest pipe-A-default-mode: SUCCESS (2.744s) [562.231343] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.746s) [563.068162] [085/132] (479s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping) [563.173280] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping [563.178105] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s) [563.249978] [086/132] (479s left) gem_exec_reloc (basic-gtt-wc) [563.305229] Subtest basic-gtt-wc: SKIP (0.000s) [563.376887] [087/132] (479s left) device_reset (cold-reset-bound) [563.427870] Starting subtest: cold-reset-bound [563.433129] Subtest cold-reset-bound: SKIP (0.000s) [563.504338] [088/132] (479s left) i915_pm_freq_api (freq-reset) [563.572710] Starting subtest: freq-reset [563.575312] Starting dynamic subtest: gt0 [563.766249] Dynamic subtest gt0: SUCCESS (0.191s) [563.777252] Starting dynamic subtest: gt1 [563.935343] Dynamic subtest gt1: SUCCESS (0.169s) [563.938032] Subtest freq-reset: SUCCESS (0.362s) [564.025562] [089/132] (478s left) gem_ctx_sseu (invalid-sseu) [564.087185] Subtest invalid-sseu: SKIP (0.000s) [564.158633] [090/132] (478s left) gem_exec_whisper (basic-forked-all) [564.219327] Starting subtest: basic-forked-all [578.446618] Subtest basic-forked-all: SUCCESS (14.222s) [578.637183] [091/132] (464s left) kms_sequence (queue-idle) [578.733159] Starting subtest: queue-idle [578.735742] Starting dynamic subtest: pipe-A-eDP-1 [580.538995] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.806s) [580.554145] Starting dynamic subtest: pipe-B-eDP-1 [583.044572] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.504s) [583.056233] Starting dynamic subtest: pipe-C-eDP-1 [585.479246] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.431s) [585.491456] Starting dynamic subtest: pipe-D-eDP-1 [587.902222] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.420s) [587.904652] Subtest queue-idle: SUCCESS (9.166s) [588.716129] [092/132] (454s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite) [588.810002] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite [588.815211] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [588.908813] [093/132] (454s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation) [589.001334] Starting subtest: plane-scaler-with-clipping-clamping-rotation [589.004077] Starting dynamic subtest: pipe-A [589.239831] Dynamic subtest pipe-A: SUCCESS (0.241s) [589.252207] Starting dynamic subtest: pipe-B [590.516833] Dynamic subtest pipe-B: SUCCESS (1.276s) [590.530452] Starting dynamic subtest: pipe-C [591.862833] Dynamic subtest pipe-C: SUCCESS (1.345s) [591.877098] Starting dynamic subtest: pipe-D [593.189145] Dynamic subtest pipe-D: SUCCESS (1.325s) [593.191868] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.191s) [594.377098] [094/132] (448s left) prime_vgem (wait) [594.448628] Starting subtest: wait [594.451440] Starting dynamic subtest: rcs0 [594.501744] Dynamic subtest rcs0: SUCCESS (0.053s) [594.516701] Starting dynamic subtest: bcs0 [594.546375] Dynamic subtest bcs0: SUCCESS (0.043s) [594.560598] Starting dynamic subtest: vcs0 [594.593333] Dynamic subtest vcs0: SUCCESS (0.046s) [594.604595] Starting dynamic subtest: vcs1 [594.638249] Dynamic subtest vcs1: SUCCESS (0.044s) [594.649470] Starting dynamic subtest: vecs0 [594.684509] Dynamic subtest vecs0: SUCCESS (0.045s) [594.695937] Starting dynamic subtest: ccs0 [594.731709] Dynamic subtest ccs0: SUCCESS (0.046s) [594.734156] Subtest wait: SUCCESS (0.284s) [594.855358] [095/132] (448s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled) [594.927494] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled [594.930013] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s) [595.017007] [096/132] (448s left) sw_sync (sync_merge_invalid) [595.056159] Starting subtest: sync_merge_invalid [595.079662] Subtest sync_merge_invalid: SUCCESS (0.028s) [595.153692] [097/132] (448s left) kms_pipe_crc_basic (read-crc) [595.246391] Starting subtest: read-crc [595.249206] Starting dynamic subtest: pipe-A-eDP-1 [595.950103] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.703s) [595.962738] Starting dynamic subtest: pipe-B-eDP-1 [597.332890] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.381s) [597.345379] Starting dynamic subtest: pipe-C-eDP-1 [598.634035] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.300s) [598.646380] Starting dynamic subtest: pipe-D-eDP-1 [599.962594] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.328s) [599.965270] Subtest read-crc: SUCCESS (4.719s) [600.794030] [098/132] (442s left) gem_pxp (reject-modify-context-protection-on) [600.918133] Starting subtest: reject-modify-context-protection-on [600.921297] Subtest reject-modify-context-protection-on: SUCCESS (0.002s) [601.027730] [099/132] (442s left) kms_psr (fbc-pr-cursor-plane-move) [601.123237] Starting subtest: fbc-pr-cursor-plane-move [601.128209] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s) [601.197019] [100/132] (442s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt) [601.294107] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt [601.298849] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [601.389732] [101/132] (442s left) gem_exec_fence (submit-chain) [601.559145] Starting subtest: submit-chain [601.579486] Subtest submit-chain: SUCCESS (0.020s) [602.996967] [102/132] (440s left) kms_setmode (clone-exclusive-crtc) [603.056435] Starting subtest: clone-exclusive-crtc [603.064304] Subtest clone-exclusive-crtc: SKIP (0.000s) [603.164945] [103/132] (440s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt) [603.257284] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt [610.157338] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.902s) [610.307818] [104/132] (433s left) syncobj_timeline (etime-multi-wait-for-submit-submitted) [610.377218] Starting subtest: etime-multi-wait-for-submit-submitted [610.481753] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.105s) [610.576474] [105/132] (433s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled) [610.637875] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled [610.744967] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.108s) [610.825651] [106/132] (432s left) kms_flip (dpms-off-confusion-interruptible) [610.917167] Starting subtest: dpms-off-confusion-interruptible [610.919835] Starting dynamic subtest: A-eDP1 [619.535232] Dynamic subtest A-eDP1: SUCCESS (8.615s) [619.547432] Starting dynamic subtest: B-eDP1 [628.164363] Dynamic subtest B-eDP1: SUCCESS (8.626s) [628.178051] Starting dynamic subtest: C-eDP1 [636.792232] Dynamic subtest C-eDP1: SUCCESS (8.623s) [636.803828] Starting dynamic subtest: D-eDP1 [645.429428] Dynamic subtest D-eDP1: SUCCESS (8.634s) [645.435355] Subtest dpms-off-confusion-interruptible: SUCCESS (34.510s) [646.603864] [107/132] (397s left) syncobj_wait (wait-any-complex) [646.672242] Starting subtest: wait-any-complex [646.735995] Subtest wait-any-complex: SUCCESS (0.063s) [646.816876] [108/132] (397s left) kms_pm_rpm (i2c) [649.044371] Starting subtest: i2c [654.072171] Subtest i2c: SUCCESS (5.028s) [654.163337] [109/132] (389s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render) [654.259102] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render [658.714600] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.458s) [659.869775] [110/132] (384s left) syncobj_wait (single-wait-for-submit-submitted) [659.918028] Starting subtest: single-wait-for-submit-submitted [660.025483] Subtest single-wait-for-submit-submitted: SUCCESS (0.107s) [660.107820] [111/132] (383s left) gem_fence_thrash (bo-write-verify-x) [660.143915] Starting subtest: bo-write-verify-x [660.162265] Subtest bo-write-verify-x: SKIP (0.017s) [660.222323] [112/132] (383s left) gem_ctx_persistence (process) [660.274240] Starting subtest: process [660.435891] Subtest process: SUCCESS (0.164s) [660.516341] [113/132] (383s left) sysfs_timeslice_duration (invalid) [660.567476] Starting subtest: invalid [660.570384] Starting dynamic subtest: vecs0 [660.573030] Dynamic subtest vecs0: SUCCESS (0.000s) [660.584716] Starting dynamic subtest: ccs0 [660.587308] Dynamic subtest ccs0: SUCCESS (0.001s) [660.598716] Starting dynamic subtest: vcs0 [660.601439] Dynamic subtest vcs0: SUCCESS (0.000s) [660.612444] Starting dynamic subtest: bcs0 [660.614745] Dynamic subtest bcs0: SUCCESS (0.000s) [660.625472] Starting dynamic subtest: rcs0 [660.628020] Dynamic subtest rcs0: SUCCESS (0.000s) [660.639072] Starting dynamic subtest: vcs1 [660.641697] Dynamic subtest vcs1: SUCCESS (0.000s) [660.644357] Subtest invalid: SUCCESS (0.007s) [660.687010] [114/132] (383s left) kms_psr (fbc-pr-sprite-plane-move) [660.777016] Starting subtest: fbc-pr-sprite-plane-move [660.782056] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s) [660.853677] [115/132] (383s left) prime_vgem (fence-flip-hang) [660.918087] Subtest fence-flip-hang: SKIP (0.000s) [661.037132] [116/132] (383s left) gem_mmap_gtt (medium-copy) [661.088441] Subtest medium-copy: SKIP (0.000s) [661.151578] [117/132] (383s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip) [661.254058] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip [661.258156] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s) [661.339366] [118/132] (382s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [661.434502] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu [661.438678] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [661.535367] [119/132] (382s left) kms_big_fb (4-tiled-32bpp-rotate-90) [661.634801] Starting subtest: 4-tiled-32bpp-rotate-90 [661.654389] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.019s) [661.765159] [120/132] (382s left) gen9_exec_parse (cmd-crossing-page) [661.820157] Subtest cmd-crossing-page: SKIP (0.000s) [661.894440] [121/132] (382s left) gem_exec_params (sol-reset-not-gen7) [661.953298] Starting subtest: sol-reset-not-gen7 [661.959123] Subtest sol-reset-not-gen7: SUCCESS (0.003s) [662.082839] [122/132] (382s left) kms_hdr (static-swap) [662.177125] Starting subtest: static-swap [662.184091] Subtest static-swap: SKIP (0.000s) [662.253837] [123/132] (382s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode) [662.628491] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s) [663.482005] [124/132] (381s left) kms_frontbuffer_tracking (fbc-stridechange) [663.574949] Starting subtest: fbc-stridechange [666.890968] Subtest fbc-stridechange: SUCCESS (3.317s) [668.023289] [125/132] (376s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite) [668.114292] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite [675.111233] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.997s) [675.224419] [126/132] (369s left) gem_ctx_engines (invalid-engines) [675.280751] Starting subtest: invalid-engines [675.290249] Subtest invalid-engines: SUCCESS (0.010s) [675.520693] [127/132] (369s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc) [675.606511] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc [675.609451] Starting dynamic subtest: pipe-A-eDP-1 [691.954679] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.785s) [691.968330] Starting dynamic subtest: pipe-B-eDP-1 [709.936923] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.849s) [709.948527] Starting dynamic subtest: pipe-C-eDP-1 [727.908688] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.815s) [727.924596] Starting dynamic subtest: pipe-D-eDP-1 [745.908862] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.751s) [745.911181] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (10.205s) [756.172342] [128/132] (297s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs) [756.275813] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs [756.280305] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s) [757.440665] [129/132] (296s left) api_intel_allocator (reopen) [757.494392] Starting subtest: reopen [757.496699] Subtest reopen: SUCCESS (0.004s) [757.629353] [130/132] (296s left) kms_vblank (ts-continuation-idle) [757.710763] Starting subtest: ts-continuation-idle [757.712618] Starting dynamic subtest: pipe-A-eDP-1 [758.121433] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.400s) [758.137727] Starting dynamic subtest: pipe-D-eDP-1 [759.272088] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.123s) [759.274300] Subtest ts-continuation-idle: SUCCESS (1.527s) [760.159346] [131/132] (293s left) gem_spin_batch (engines) [760.227978] Starting subtest: engines [760.230307] Starting dynamic subtest: rcs0 [763.572985] Dynamic subtest rcs0: SUCCESS (3.289s) [763.586124] Starting dynamic subtest: bcs0 [766.913237] Dynamic subtest bcs0: SUCCESS (3.304s) [766.924606] Starting dynamic subtest: vcs0 [770.253516] Dynamic subtest vcs0: SUCCESS (3.317s) [770.266750] Starting dynamic subtest: vcs1 [773.592946] Dynamic subtest vcs1: SUCCESS (3.322s) [773.606219] Starting dynamic subtest: vecs0 [776.932860] Dynamic subtest vecs0: SUCCESS (3.327s) [776.946340] Starting dynamic subtest: ccs0 [780.269038] Dynamic subtest ccs0: SUCCESS (3.326s) [780.271573] Subtest engines: SUCCESS (19.902s) [780.504124] [132/132] (273s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc) [780.605457] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc [784.607139] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (3.999s) [785.828365] Closing watchdogs results: parsing output: 0/ for test: kms_frontbuffer_tracking results: parsing output: 1/ for test: gem_exec_flush results: parsing output: 2/ for test: kms_atomic results: parsing output: 3/ for test: kms_rmfb results: parsing output: 4/ for test: kms_dp_linktrain_fallback results: parsing output: 5/ for test: syncobj_timeline results: parsing output: 6/ for test: kms_psr results: parsing output: 7/ for test: kms_cursor_legacy results: parsing output: 8/ for test: gem_exec_fence results: parsing output: 9/ for test: kms_cursor_crc results: parsing output: 10/ for test: gem_exec_schedule results: parsing output: 11/ for test: vgem_basic results: parsing output: 12/ for test: gem_exec_schedule results: parsing output: 13/ for test: kms_big_fb results: parsing output: 14/ for test: kms_pm_dc results: parsing output: 15/ for test: core_getclient results: parsing output: 16/ for test: gem_exec_schedule results: parsing output: 17/ for test: kms_big_fb results: parsing output: 18/ for test: kms_frontbuffer_tracking results: parsing output: 19/ for test: syncobj_wait results: parsing output: 20/ for test: kms_plane_scaling results: parsing output: 21/ for test: kms_frontbuffer_tracking results: parsing output: 22/ for test: kms_ccs results: parsing output: 23/ for test: kms_color results: parsing output: 24/ for test: kms_joiner results: parsing output: 25/ for test: syncobj_basic results: parsing output: 26/ for test: gem_pwrite results: parsing output: 27/ for test: gem_lmem_swapping results: parsing output: 28/ for test: kms_psr results: parsing output: 29/ for test: gem_ctx_isolation results: parsing output: 30/ for test: kms_content_protection results: parsing output: 31/ for test: gem_ringfill results: parsing output: 32/ for test: prime_mmap results: parsing output: 33/ for test: prime_self_import results: parsing output: 34/ for test: kms_ccs results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: kms_flip results: parsing output: 37/ for test: i915_query results: parsing output: 38/ for test: syncobj_timeline results: parsing output: 39/ for test: syncobj_wait results: parsing output: 40/ for test: prime_self_import results: parsing output: 41/ for test: kms_addfb_basic results: parsing output: 42/ for test: kms_frontbuffer_tracking results: parsing output: 43/ for test: kms_lease results: parsing output: 44/ for test: kms_feature_discovery results: parsing output: 45/ for test: gem_mmap_offset results: parsing output: 46/ for test: gem_wait results: parsing output: 47/ for test: kms_async_flips results: parsing output: 48/ for test: kms_cursor_crc results: parsing output: 49/ for test: gem_media_vme results: parsing output: 50/ for test: gem_bad_reloc results: parsing output: 51/ for test: gem_eio results: parsing output: 52/ for test: kms_flip results: parsing output: 53/ for test: kms_atomic_interruptible results: parsing output: 54/ for test: kms_chamelium_edid results: parsing output: 55/ for test: kms_chamelium_audio results: parsing output: 56/ for test: gem_exec_big results: parsing output: 57/ for test: kms_psr results: parsing output: 58/ for test: kms_plane results: parsing output: 59/ for test: perf_pmu results: parsing output: 60/ for test: kms_frontbuffer_tracking results: parsing output: 61/ for test: kms_big_fb results: parsing output: 62/ for test: kms_frontbuffer_tracking results: parsing output: 63/ for test: kms_psr2_sf results: parsing output: 64/ for test: perf results: parsing output: 65/ for test: kms_psr results: parsing output: 66/ for test: i915_drm_fdinfo results: parsing output: 67/ for test: kms_big_fb results: parsing output: 68/ for test: syncobj_wait results: parsing output: 69/ for test: kms_cursor_legacy results: parsing output: 70/ for test: kms_psr2_sf results: parsing output: 71/ for test: kms_big_fb results: parsing output: 72/ for test: kms_addfb_basic results: parsing output: 73/ for test: kms_cursor_crc results: parsing output: 74/ for test: kms_fbcon_fbt results: parsing output: 75/ for test: kms_fbcon_fbt results: parsing output: 76/ for test: kms_frontbuffer_tracking results: parsing output: 77/ for test: gem_render_copy results: parsing output: 78/ for test: gem_exec_await results: parsing output: 79/ for test: gem_exec_balancer results: parsing output: 80/ for test: kms_flip results: parsing output: 81/ for test: i915_pm_rpm results: parsing output: 82/ for test: kms_flip_scaled_crc results: parsing output: 83/ for test: kms_flip_scaled_crc results: parsing output: 84/ for test: kms_plane results: parsing output: 85/ for test: gem_exec_reloc results: parsing output: 86/ for test: device_reset results: parsing output: 87/ for test: i915_pm_freq_api results: parsing output: 88/ for test: gem_ctx_sseu results: parsing output: 89/ for test: gem_exec_whisper results: parsing output: 90/ for test: kms_sequence results: parsing output: 91/ for test: kms_frontbuffer_tracking results: parsing output: 92/ for test: kms_plane_scaling results: parsing output: 93/ for test: prime_vgem results: parsing output: 94/ for test: syncobj_timeline results: parsing output: 95/ for test: sw_sync results: parsing output: 96/ for test: kms_pipe_crc_basic results: parsing output: 97/ for test: gem_pxp results: parsing output: 98/ for test: kms_psr results: parsing output: 99/ for test: kms_frontbuffer_tracking results: parsing output: 100/ for test: gem_exec_fence results: parsing output: 101/ for test: kms_setmode results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: syncobj_timeline results: parsing output: 104/ for test: syncobj_timeline results: parsing output: 105/ for test: kms_flip results: parsing output: 106/ for test: syncobj_wait results: parsing output: 107/ for test: kms_pm_rpm results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: syncobj_wait results: parsing output: 110/ for test: gem_fence_thrash results: parsing output: 111/ for test: gem_ctx_persistence results: parsing output: 112/ for test: sysfs_timeslice_duration results: parsing output: 113/ for test: kms_psr results: parsing output: 114/ for test: prime_vgem results: parsing output: 115/ for test: gem_mmap_gtt results: parsing output: 116/ for test: kms_big_fb results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: kms_big_fb results: parsing output: 119/ for test: gen9_exec_parse results: parsing output: 120/ for test: gem_exec_params results: parsing output: 121/ for test: kms_hdr results: parsing output: 122/ for test: kms_chamelium_hpd results: parsing output: 123/ for test: kms_frontbuffer_tracking results: parsing output: 124/ for test: kms_frontbuffer_tracking results: parsing output: 125/ for test: gem_ctx_engines results: parsing output: 126/ for test: kms_ccs results: parsing output: 127/ for test: kms_ccs results: parsing output: 128/ for test: api_intel_allocator results: parsing output: 129/ for test: kms_vblank results: parsing output: 130/ for test: gem_spin_batch results: parsing output: 131/ for test: kms_frontbuffer_tracking Done.