[65.139399] Initializing watchdogs [65.139458] /dev/watchdog0 [65.154576] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:4c8a Intel Rocketlake (Gen12) RocketLake-S GT1 [UHD Graphics 750] [65.159241] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [65.161285] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [65.163387] [001/130] (960s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb) [65.272571] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s) [65.325493] [002/130] (960s left) perf_pmu (busy-idle-no-semaphores) [65.358191] Starting subtest: busy-idle-no-semaphores [65.358972] Starting dynamic subtest: rcs0 [66.034954] Dynamic subtest rcs0: SUCCESS (0.668s) [66.039947] Starting dynamic subtest: bcs0 [66.652864] Dynamic subtest bcs0: SUCCESS (0.617s) [66.663105] Starting dynamic subtest: vcs0 [67.276481] Dynamic subtest vcs0: SUCCESS (0.623s) [67.285452] Starting dynamic subtest: vecs0 [67.904679] Dynamic subtest vecs0: SUCCESS (0.636s) [67.906228] Subtest busy-idle-no-semaphores: SUCCESS (2.545s) [68.050602] [003/130] (957s left) gem_mmap_gtt (basic-read-write) [68.080269] Starting subtest: basic-read-write [68.092527] Subtest basic-read-write: SUCCESS (0.012s) [68.227220] [004/130] (957s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [68.331744] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt [68.333157] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [68.473872] [005/130] (957s left) perf_pmu (rc6-all-gts) [68.504317] Starting subtest: rc6-all-gts [68.505783] Subtest rc6-all-gts: SKIP (0.000s) [68.604205] [006/130] (957s left) kms_lease (lease-revoke) [68.707059] Starting subtest: lease-revoke [68.709093] Starting dynamic subtest: pipe-A-HDMI-A-1 [68.758896] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.050s) [68.764826] Starting dynamic subtest: pipe-B-HDMI-A-1 [68.805276] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.047s) [68.806070] Subtest lease-revoke: SUCCESS (0.098s) [68.904199] [007/130] (956s left) sriov_basic (bind-unbind-vf) [68.935375] Subtest bind-unbind-vf: SKIP (0.000s) [68.976941] [008/130] (956s left) i915_query (query-garbage) [69.008158] Starting subtest: query-garbage [69.008896] Subtest query-garbage: SUCCESS (0.000s) [69.088965] [009/130] (956s left) kms_chamelium_color (ctm-green-to-red) [69.190832] Subtest ctm-green-to-red: SKIP (0.000s) [69.223857] [010/130] (956s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt) [69.329782] Starting subtest: psr-rgb565-draw-blt [69.331197] Subtest psr-rgb565-draw-blt: SKIP (0.000s) [69.440952] [011/130] (956s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt) [69.544777] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt [73.003039] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SUCCESS (3.527s) [73.173847] [012/130] (952s left) gem_ctx_engines (independent) [73.212391] Starting subtest: independent [73.213092] Starting dynamic subtest: rcs0 [73.276145] Dynamic subtest rcs0: SUCCESS (0.067s) [73.281671] Starting dynamic subtest: bcs0 [73.339638] Dynamic subtest bcs0: SUCCESS (0.065s) [73.345345] Starting dynamic subtest: vcs0 [73.402057] Dynamic subtest vcs0: SUCCESS (0.064s) [73.407579] Starting dynamic subtest: vecs0 [73.463341] Dynamic subtest vecs0: SUCCESS (0.063s) [73.468623] Starting dynamic subtest: all-engines [73.561074] Dynamic subtest all-engines: SUCCESS (0.100s) [73.561847] Subtest independent: SUCCESS (0.360s) [73.774684] [013/130] (952s left) kms_psr (pr-sprite-blt) [73.873725] Subtest pr-sprite-blt: SKIP (0.000s) [73.913512] [014/130] (952s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5) [74.011950] Starting subtest: planes-unity-scaling-downscale-factor-0-5 [74.012736] Starting dynamic subtest: pipe-A [74.187383] Dynamic subtest pipe-A: SUCCESS (0.179s) [74.192934] Starting dynamic subtest: pipe-B [74.331629] Dynamic subtest pipe-B: SUCCESS (0.147s) [74.332947] Subtest planes-unity-scaling-downscale-factor-0-5: SUCCESS (0.327s) [74.542270] [015/130] (951s left) kms_cursor_crc (cursor-rapid-movement-32x10) [74.643545] Starting subtest: cursor-rapid-movement-32x10 [74.674164] Subtest cursor-rapid-movement-32x10: SKIP (0.030s) [74.803290] [016/130] (951s left) kms_plane_lowres (tiling-4) [74.902962] Starting subtest: tiling-4 [74.904397] Subtest tiling-4: SKIP (0.000s) [74.983719] [017/130] (951s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [75.095155] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip [75.571214] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.487s) [75.788870] [018/130] (950s left) perf (short-reads) [75.876696] Starting subtest: short-reads [75.898362] Subtest short-reads: SUCCESS (0.022s) [75.931749] [019/130] (950s left) kms_invalid_mode (bad-hsync-end) [76.032754] Starting subtest: bad-hsync-end [76.033462] Starting dynamic subtest: pipe-A-HDMI-A-1 [76.082467] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.050s) [76.087752] Starting dynamic subtest: pipe-B-HDMI-A-1 [76.088447] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s) [76.089159] Subtest bad-hsync-end: SUCCESS (0.052s) [76.258499] [020/130] (950s left) kms_pipe_crc_basic (nonblocking-crc) [76.358045] Starting subtest: nonblocking-crc [76.358817] Starting dynamic subtest: pipe-A-HDMI-A-1 [77.037477] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.690s) [77.043135] Starting dynamic subtest: pipe-B-HDMI-A-1 [77.580487] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.551s) [77.581258] Subtest nonblocking-crc: SUCCESS (1.243s) [77.709006] [021/130] (948s left) gem_mmap_gtt (basic-copy) [77.738092] Starting subtest: basic-copy [78.170071] Subtest basic-copy: SUCCESS (0.430s) [78.301443] [022/130] (948s left) kms_color (ctm-negative) [78.400961] Starting subtest: ctm-negative [78.401746] Starting dynamic subtest: pipe-A-HDMI-A-1 [78.977657] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.584s) [78.983569] Starting dynamic subtest: pipe-B-HDMI-A-1 [79.431781] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.458s) [79.432864] Subtest ctm-negative: SUCCESS (1.043s) [79.817026] [023/130] (946s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf) [79.933951] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s) [79.980149] [024/130] (946s left) kms_ccs (crc-primary-basic-yf-tiled-ccs) [80.135047] Starting subtest: crc-primary-basic-yf-tiled-ccs [80.135819] Starting dynamic subtest: pipe-A-HDMI-A-1 [80.143192] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s) [80.148628] Starting dynamic subtest: pipe-B-HDMI-A-1 [80.155393] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s) [80.156751] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.003s) [80.383221] [025/130] (946s left) gem_ctx_bad_destroy (invalid-pad) [80.410456] Starting subtest: invalid-pad [80.411158] Subtest invalid-pad: SUCCESS (0.000s) [80.508790] [026/130] (946s left) i915_pm_rpm (system-suspend) [81.942896] Starting subtest: system-suspend [99.955530] Subtest system-suspend: SUCCESS (3.144s) [107.186489] [027/130] (926s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic) [107.293140] Starting subtest: 2x-flip-vs-cursor-atomic [107.295376] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s) [107.387280] [028/130] (926s left) gem_eio (in-flight-contexts-immediate) [107.424593] Starting subtest: in-flight-contexts-immediate [118.713605] Subtest in-flight-contexts-immediate: SUCCESS (11.456s) [118.881211] [029/130] (914s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render) [118.990041] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render [118.991388] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [119.102816] [030/130] (914s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render) [119.208723] Starting subtest: fbc-rgb101010-draw-render [121.985124] Subtest fbc-rgb101010-draw-render: SUCCESS (2.793s) [122.148577] [031/130] (911s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled) [122.178318] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled [122.179055] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s) [122.280663] [032/130] (911s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs) [122.382009] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs [122.382788] Starting dynamic subtest: pipe-A-HDMI-A-1 [122.389881] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [122.396650] Starting dynamic subtest: pipe-B-HDMI-A-1 [122.403532] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [122.404946] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SKIP (0.001s) [122.626394] [033/130] (911s left) gem_exec_whisper (basic-normal) [122.663893] Starting subtest: basic-normal [123.767268] Subtest basic-normal: SUCCESS (1.108s) [123.963640] [034/130] (909s left) gem_linear_blits (normal) [124.167033] Starting subtest: normal [127.892612] Subtest normal: SUCCESS (3.729s) [128.020622] [035/130] (905s left) prime_vgem (basic-fence-read) [128.179868] Starting subtest: basic-fence-read [128.186802] Subtest basic-fence-read: SKIP (0.006s) [128.325145] [FACT prime_vgem (basic-fence-read)] new: kernel.kmod_is_loaded.vgem: true [128.327292] [036/130] (905s left) kms_chamelium_hpd (hdmi-hpd-storm) [128.495219] Subtest hdmi-hpd-storm: SKIP (0.000s) [128.577802] [037/130] (905s left) kms_psr (fbc-psr2-primary-mmap-cpu) [128.684731] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.000s) [128.738836] [038/130] (905s left) kms_vblank (query-forked) [128.839927] Starting subtest: query-forked [128.840717] Starting dynamic subtest: pipe-A-HDMI-A-1 [131.449389] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.614s) [131.463026] Starting dynamic subtest: pipe-B-HDMI-A-1 [134.000426] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.554s) [134.001140] Subtest query-forked: SUCCESS (5.170s) [134.198243] [039/130] (899s left) kms_flip (flip-vs-dpms-on-nop) [134.302633] Starting subtest: flip-vs-dpms-on-nop [134.303377] Starting dynamic subtest: A-HDMI-A1 [135.848568] Dynamic subtest A-HDMI-A1: SUCCESS (1.546s) [135.860095] Starting dynamic subtest: B-HDMI-A1 [137.342753] Dynamic subtest B-HDMI-A1: SUCCESS (1.495s) [137.346271] Subtest flip-vs-dpms-on-nop: SUCCESS (3.046s) [137.520286] [040/130] (896s left) gem_ctx_persistence (legacy-engines-hostile-preempt) [137.552791] Starting subtest: legacy-engines-hostile-preempt [137.553507] Starting dynamic subtest: render [137.663491] Dynamic subtest render: SUCCESS (0.109s) [137.686510] Starting dynamic subtest: bsd [137.792255] Dynamic subtest bsd: SUCCESS (0.127s) [137.815506] Starting dynamic subtest: blt [137.917514] Dynamic subtest blt: SUCCESS (0.124s) [137.930690] Starting dynamic subtest: vebox [138.036437] Dynamic subtest vebox: SUCCESS (0.117s) [138.038106] Subtest legacy-engines-hostile-preempt: SUCCESS (0.483s) [138.149481] [041/130] (896s left) i915_drm_fdinfo (busy) [138.180722] Starting subtest: busy [138.181438] Starting dynamic subtest: rcs0 [138.700041] Dynamic subtest rcs0: SUCCESS (0.517s) [138.710657] Starting dynamic subtest: bcs0 [139.229014] Dynamic subtest bcs0: SUCCESS (0.529s) [139.247259] Starting dynamic subtest: vcs0 [139.764905] Dynamic subtest vcs0: SUCCESS (0.535s) [139.775508] Starting dynamic subtest: vecs0 [140.292845] Dynamic subtest vecs0: SUCCESS (0.527s) [140.294480] Subtest busy: SUCCESS (2.111s) [140.399268] [042/130] (893s left) gem_userptr_blits (dmabuf-sync) [140.439554] Starting subtest: dmabuf-sync [140.441736] Subtest dmabuf-sync: SKIP (0.002s) [140.616717] [043/130] (893s left) syncobj_wait (single-wait-signaled) [140.646808] Starting subtest: single-wait-signaled [140.647548] Subtest single-wait-signaled: SUCCESS (0.000s) [140.749801] [044/130] (893s left) gem_exec_reloc (basic-gtt-cpu-active) [140.781405] Subtest basic-gtt-cpu-active: SKIP (0.000s) [140.868980] [045/130] (893s left) gem_pxp (verify-pxp-stale-ctx-execution) [321.361205] Per-test timeout exceeded. Killing the current test with SIGQUIT. [330.918674] Closing watchdogs [330.922353] Initializing watchdogs [330.922390] /dev/watchdog0 [330.938516] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:4c8a Intel Rocketlake (Gen12) RocketLake-S GT1 [UHD Graphics 750] [330.945063] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [330.946089] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [330.946502] [FACT before any test] new: kernel.kmod_is_loaded.vgem: true [330.948300] [046/130] (703s left) kms_properties (invalid-properties-legacy) [331.053166] Starting subtest: invalid-properties-legacy [331.081506] Subtest invalid-properties-legacy: SUCCESS (0.028s) [331.194231] [047/130] (703s left) kms_flip (flip-vs-fences) [331.295428] Starting subtest: flip-vs-fences [331.296138] Starting dynamic subtest: A-HDMI-A1 [346.591589] Dynamic subtest A-HDMI-A1: SUCCESS (15.290s) [346.599017] Starting dynamic subtest: B-HDMI-A1 [361.852588] Dynamic subtest B-HDMI-A1: SUCCESS (15.251s) [361.853347] Subtest flip-vs-fences: SUCCESS (30.544s) [362.059451] [048/130] (672s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling) [362.162099] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling [362.162803] Starting dynamic subtest: pipe-A-valid-mode [362.214702] Dynamic subtest pipe-A-valid-mode: SKIP (0.051s) [362.216034] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.052s) [362.358288] [049/130] (672s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy) [362.461367] Starting subtest: 2x-long-cursor-vs-flip-legacy [362.463846] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.001s) [362.557602] [050/130] (672s left) kms_big_fb (x-tiled-64bpp-rotate-90) [362.677308] Starting subtest: x-tiled-64bpp-rotate-90 [362.725834] Subtest x-tiled-64bpp-rotate-90: SKIP (0.048s) [362.882757] [051/130] (671s left) intel_hwmon (hwmon-read) [362.912525] Subtest hwmon-read: SKIP (0.000s) [362.969406] [052/130] (671s left) kms_addfb_basic (no-handle) [362.998452] Starting subtest: no-handle [362.999146] Subtest no-handle: SUCCESS (0.000s) [363.231361] [053/130] (671s left) gem_mmap (pf-nonblock) [363.260027] Starting subtest: pf-nonblock [363.262608] Subtest pf-nonblock: SUCCESS (0.002s) [363.412090] [054/130] (671s left) kms_big_fb (y-tiled-16bpp-rotate-0) [363.523119] Starting subtest: y-tiled-16bpp-rotate-0 [365.398152] Subtest y-tiled-16bpp-rotate-0: SUCCESS (1.874s) [365.600270] [055/130] (669s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt) [365.707724] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt [365.709061] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [365.851673] [056/130] (669s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs) [365.956065] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs [365.957453] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s) [366.128682] [057/130] (668s left) kms_scaling_modes (scaling-mode-none) [366.233048] Starting subtest: scaling-mode-none [366.235772] Subtest scaling-mode-none: SKIP (0.000s) [366.338826] [058/130] (668s left) syncobj_timeline (multi-wait-for-submit-available-signaled) [366.367486] Starting subtest: multi-wait-for-submit-available-signaled [366.368176] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.000s) [366.468783] [059/130] (668s left) kms_async_flips (async-flip-suspend-resume) [366.570084] Starting subtest: async-flip-suspend-resume [366.763409] Starting dynamic subtest: pipe-A-HDMI-A-1 [385.838680] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.894s) [386.011395] Starting dynamic subtest: pipe-B-HDMI-A-1 [388.063039] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.050s) [388.063814] Subtest async-flip-suspend-resume: SUCCESS (6.303s) [393.360774] [060/130] (646s left) kms_ccs (random-ccs-data-yf-tiled-ccs) [393.475446] Starting subtest: random-ccs-data-yf-tiled-ccs [393.476248] Starting dynamic subtest: pipe-A-HDMI-A-1 [393.483908] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [393.494468] Starting dynamic subtest: pipe-B-HDMI-A-1 [393.502163] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [393.503526] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.002s) [393.707678] [061/130] (646s left) gem_render_copy_redux (flink-interruptible) [393.740541] Starting subtest: flink-interruptible [394.572331] Subtest flink-interruptible: SUCCESS (0.832s) [394.726827] [062/130] (645s left) gem_softpin (evict-snoop-interruptible) [394.761059] Starting subtest: evict-snoop-interruptible [394.762473] Subtest evict-snoop-interruptible: SKIP (0.000s) [394.854308] [063/130] (645s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt) [394.959177] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt [394.960539] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [395.085858] [064/130] (645s left) gem_eio (wait-1us) [395.120023] Starting subtest: wait-1us [395.277300] Subtest wait-1us: SUCCESS (0.157s) [395.469234] [065/130] (644s left) gem_pxp (regular-baseline-src-copy-readible) [410.409698] Starting subtest: regular-baseline-src-copy-readible [410.411168] Subtest regular-baseline-src-copy-readible: SKIP (0.000s) [410.492335] [066/130] (629s left) gem_partial_pwrite_pread (writes-after-reads) [410.525706] Subtest writes-after-reads: SKIP (0.000s) [410.617520] [067/130] (629s left) kms_big_fb (yf-tiled-16bpp-rotate-0) [410.733526] Starting subtest: yf-tiled-16bpp-rotate-0 [410.734878] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s) [410.856805] [068/130] (629s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic) [410.955605] Starting subtest: 2x-long-flip-vs-cursor-atomic [410.958040] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s) [411.063296] [069/130] (629s left) gem_exec_schedule (preempt-other-chain) [411.103198] Starting subtest: preempt-other-chain [411.103872] Starting dynamic subtest: rcs0 [411.131185] Dynamic subtest rcs0: SUCCESS (0.028s) [411.139459] Starting dynamic subtest: bcs0 [411.155993] Dynamic subtest bcs0: SUCCESS (0.024s) [411.164235] Starting dynamic subtest: vcs0 [411.180185] Dynamic subtest vcs0: SUCCESS (0.024s) [411.188577] Starting dynamic subtest: vecs0 [411.204643] Dynamic subtest vecs0: SUCCESS (0.024s) [411.205391] Subtest preempt-other-chain: SUCCESS (0.102s) [411.536938] [070/130] (629s left) gem_exec_params (secure-non-master) [411.570356] Starting subtest: secure-non-master [411.571900] Subtest secure-non-master: SKIP (0.000s) [411.705524] [071/130] (628s left) gem_exec_reloc (basic-concurrent16) [411.736095] Subtest basic-concurrent16: SKIP (0.000s) [411.824221] [072/130] (628s left) kms_getfb (getfb2-handle-closed) [411.925732] Starting subtest: getfb2-handle-closed [411.926490] Subtest getfb2-handle-closed: SUCCESS (0.000s) [412.060072] [073/130] (628s left) gem_lmem_swapping (smem-oom) [412.093019] Subtest smem-oom: SKIP (0.000s) [412.131009] [074/130] (628s left) kms_pm_rpm (universal-planes) [413.569549] Starting subtest: universal-planes [413.570923] Starting dynamic subtest: plane-33 [414.873273] Dynamic subtest plane-33: SUCCESS (1.312s) [414.889689] Starting dynamic subtest: plane-43 [416.134333] Dynamic subtest plane-43: SUCCESS (1.265s) [416.145340] Starting dynamic subtest: plane-53 [417.395668] Dynamic subtest plane-53: SUCCESS (1.264s) [417.413224] Starting dynamic subtest: plane-63 [418.649583] Dynamic subtest plane-63: SUCCESS (1.257s) [418.668158] Starting dynamic subtest: plane-73 [419.884145] Dynamic subtest plane-73: SUCCESS (1.237s) [419.898640] Starting dynamic subtest: plane-83 [421.101654] Dynamic subtest plane-83: SUCCESS (1.219s) [421.102548] Subtest universal-planes: SUCCESS (7.562s) [421.324209] [075/130] (619s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite) [421.431310] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite [421.432696] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [421.551460] [076/130] (619s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu) [421.656175] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu [421.657494] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [421.805454] [077/130] (619s left) gem_exec_capture (capture-recoverable) [421.838680] Starting subtest: capture-recoverable [421.840123] Subtest capture-recoverable: SKIP (0.000s) [421.958140] [078/130] (619s left) kms_pwrite_crc [422.786558] [079/130] (618s left) i915_getparams_basic (basic-eu-total) [422.814811] Starting subtest: basic-eu-total [422.816207] Subtest basic-eu-total: SUCCESS (0.000s) [422.917396] [080/130] (618s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180) [423.017505] Starting subtest: primary-yf-tiled-reflect-x-180 [423.131636] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.112s) [423.250592] [081/130] (617s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu) [423.355540] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu [425.971703] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (2.621s) [426.158254] [082/130] (615s left) syncobj_basic (test-valid-cycle) [426.187254] Starting subtest: test-valid-cycle [426.187973] Subtest test-valid-cycle: SUCCESS (0.000s) [426.280874] [083/130] (614s left) gem_create (create-ext-placement-each) [426.434220] Starting subtest: create-ext-placement-each [426.435652] Subtest create-ext-placement-each: SUCCESS (0.000s) [426.540362] [084/130] (614s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move) [426.644255] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move [426.645568] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [426.803856] [085/130] (614s left) gem_exec_balancer (invalid-bonds) [426.839177] Starting subtest: invalid-bonds [426.840573] Subtest invalid-bonds: SUCCESS (0.002s) [427.070613] [086/130] (614s left) gem_unref_active_buffers [427.279986] [087/130] (614s left) kms_psr (psr-sprite-mmap-cpu) [427.381065] Subtest psr-sprite-mmap-cpu: SKIP (0.000s) [427.421816] [088/130] (614s left) kms_cursor_crc (cursor-onscreen-256x256) [427.526621] Starting subtest: cursor-onscreen-256x256 [427.530250] Starting dynamic subtest: pipe-A-HDMI-A-1 [430.080455] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.552s) [430.108798] Starting dynamic subtest: pipe-B-HDMI-A-1 [432.532282] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.430s) [432.533034] Subtest cursor-onscreen-256x256: SUCCESS (5.009s) [432.699440] [089/130] (608s left) device_reset (cold-reset-bound) [432.743212] Starting subtest: cold-reset-bound [432.744702] Subtest cold-reset-bound: SKIP (0.000s) [432.841289] [090/130] (608s left) syncobj_timeline (host-signal-points) [432.871349] Starting subtest: host-signal-points [432.876338] Subtest host-signal-points: SUCCESS (0.006s) [432.983188] [091/130] (608s left) syncobj_timeline (wait-any-complex) [433.012190] Starting subtest: wait-any-complex [433.076135] Subtest wait-any-complex: SUCCESS (0.063s) [433.194275] [092/130] (608s left) gem_mmap_gtt (cpuset-basic-small-copy-xy) [433.222220] Starting subtest: cpuset-basic-small-copy-XY [439.961678] Subtest cpuset-basic-small-copy-XY: SUCCESS (6.738s) [440.061100] [093/130] (601s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt) [440.218595] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt [440.219990] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [440.348269] [094/130] (601s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff) [440.453496] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff [440.454867] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [440.595420] [095/130] (601s left) i915_pm_rc6_residency (rc6-idle) [440.625900] Starting subtest: rc6-idle [440.629454] Subtest rc6-idle: SKIP (0.004s) [440.723766] [096/130] (601s left) gem_exec_schedule (u-submit-early-slice) [440.773445] Starting subtest: u-submit-early-slice [440.774212] Starting dynamic subtest: rcs0 [440.797155] Dynamic subtest rcs0: SUCCESS (0.023s) [440.804963] Starting dynamic subtest: bcs0 [440.819238] Dynamic subtest bcs0: SUCCESS (0.021s) [440.827092] Starting dynamic subtest: vcs0 [440.841201] Dynamic subtest vcs0: SUCCESS (0.021s) [440.848948] Starting dynamic subtest: vecs0 [440.862548] Dynamic subtest vecs0: SUCCESS (0.021s) [440.863282] Subtest u-submit-early-slice: SUCCESS (0.089s) [441.202848] [097/130] (600s left) kms_atomic_transition (modeset-transition-fencing) [441.303699] Starting subtest: modeset-transition-fencing [441.304425] Starting dynamic subtest: 1x-outputs [442.117144] Dynamic subtest 1x-outputs: SUCCESS (0.812s) [442.164160] Subtest modeset-transition-fencing: SUCCESS (0.860s) [442.335636] [098/130] (599s left) sw_sync (sync_multi_producer_single_consumer) [442.365447] Starting subtest: sync_multi_producer_single_consumer [443.449511] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s) [443.522220] [099/130] (598s left) kms_content_protection (dp-mst-lic-type-1) [443.636383] Starting subtest: dp-mst-lic-type-1 [443.637808] Subtest dp-mst-lic-type-1: SKIP (0.000s) [443.777880] [100/130] (598s left) gem_exec_balancer (bonded-chain) [443.814160] Starting subtest: bonded-chain [445.001955] Subtest bonded-chain: SUCCESS (1.179s) [445.216016] [101/130] (596s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs) [445.317681] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs [445.318418] Starting dynamic subtest: pipe-A-HDMI-A-1 [445.325174] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [445.333199] Starting dynamic subtest: pipe-B-HDMI-A-1 [445.339887] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [445.341245] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SKIP (0.002s) [445.568298] [102/130] (596s left) vgem_basic (create) [445.609433] Starting subtest: create [445.610181] Subtest create: SUCCESS (0.000s) [445.699932] [103/130] (596s left) syncobj_timeline (invalid-transfer-non-existent-point) [445.730402] Starting subtest: invalid-transfer-non-existent-point [445.731128] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s) [445.834615] [104/130] (596s left) gen7_exec_parse (load-register-reg) [445.865757] Subtest load-register-reg: SKIP (0.000s) [445.903953] [105/130] (596s left) kms_vrr (max-min) [446.004619] Starting subtest: max-min [446.006705] Subtest max-min: SKIP (0.000s) [446.120397] [106/130] (596s left) kms_dsc (dsc-basic) [446.221615] Starting subtest: dsc-basic [446.224512] Subtest dsc-basic: SKIP (0.000s) [446.328074] [107/130] (595s left) api_intel_allocator (two-level-inception-interruptible) [446.357382] Starting subtest: two-level-inception-interruptible [451.802663] Subtest two-level-inception-interruptible: SUCCESS (5.411s) [451.885957] [108/130] (590s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu) [451.994512] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu [451.995903] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [452.114245] [109/130] (590s left) gem_softpin (allocator-nopin-reserve) [452.147536] Starting subtest: allocator-nopin-reserve [452.235287] Subtest allocator-nopin-reserve: SUCCESS (0.088s) [452.378433] [110/130] (590s left) kms_psr (fbc-psr-primary-blt) [452.486977] Subtest fbc-psr-primary-blt: SKIP (0.000s) [452.523848] [111/130] (589s left) gem_ctx_persistence (heartbeat-hang) [452.571665] Starting subtest: heartbeat-hang [453.832780] Subtest heartbeat-hang: SUCCESS (1.276s) [453.943669] [112/130] (588s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu) [454.050323] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu [456.650313] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (2.601s) [456.837826] [113/130] (585s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [456.945487] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt [456.946887] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [457.084746] [114/130] (585s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180) [457.197167] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180 [457.198537] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s) [457.330492] [115/130] (585s left) gem_spin_batch (user-each) [457.366061] Starting subtest: user-each [460.645179] Subtest user-each: SUCCESS (3.250s) [460.840906] [116/130] (581s left) kms_psr (fbc-pr-sprite-render) [460.942926] Subtest fbc-pr-sprite-render: SKIP (0.000s) [460.987241] [117/130] (581s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt) [461.092415] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt [461.093743] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [461.239875] [118/130] (581s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0) [461.349292] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0 [461.350663] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s) [461.484945] [119/130] (581s left) kms_flip (basic-flip-vs-wf_vblank) [461.589170] Starting subtest: basic-flip-vs-wf_vblank [461.590468] Starting dynamic subtest: A-HDMI-A1 [463.247542] Dynamic subtest A-HDMI-A1: SUCCESS (1.656s) [463.260061] Starting dynamic subtest: B-HDMI-A1 [464.871910] Dynamic subtest B-HDMI-A1: SUCCESS (1.621s) [464.876197] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.287s) [465.093701] [120/130] (577s left) gem_tiled_partial_pwrite_pread (writes-after-reads) [465.128228] Subtest writes-after-reads: SKIP (0.000s) [465.211214] [121/130] (577s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20) [465.312546] Starting subtest: planes-downscale-factor-0-5-upscale-20x20 [465.313244] Starting dynamic subtest: pipe-A [465.476435] Dynamic subtest pipe-A: SUCCESS (0.163s) [465.497438] Starting dynamic subtest: pipe-B [465.623844] Dynamic subtest pipe-B: SUCCESS (0.145s) [465.625014] Subtest planes-downscale-factor-0-5-upscale-20x20: SUCCESS (0.312s) [465.835462] [122/130] (577s left) kms_flip (2x-flip-vs-rmfb-interruptible) [465.940446] Starting subtest: 2x-flip-vs-rmfb-interruptible [465.941835] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.001s) [466.092281] [123/130] (576s left) gem_partial_pwrite_pread (reads-uncached) [466.123059] Subtest reads-uncached: SKIP (0.000s) [466.234207] [124/130] (576s left) dmabuf_sync_file (import-basic) [466.283850] Starting subtest: import-basic [466.286599] Subtest import-basic: SUCCESS (0.003s) [466.373242] [125/130] (576s left) gem_eio (wait-immediate) [466.406090] Starting subtest: wait-immediate [466.559819] Subtest wait-immediate: SUCCESS (0.152s) [466.735572] [126/130] (576s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled) [466.764180] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled [466.868616] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.104s) [466.983605] [127/130] (576s left) kms_cursor_legacy (forked-move) [467.084800] Starting subtest: forked-move [467.085495] Starting dynamic subtest: pipe-A [472.539288] Dynamic subtest pipe-A: SUCCESS (5.422s) [472.548035] Starting dynamic subtest: pipe-B [477.990212] Dynamic subtest pipe-B: SUCCESS (5.452s) [477.999188] Starting dynamic subtest: all-pipes [483.449461] Dynamic subtest all-pipes: SUCCESS (5.458s) [483.450751] Subtest forked-move: SUCCESS (16.335s) [483.522479] [128/130] (559s left) gem_exec_fence (syncobj-wait) [483.851607] Starting subtest: syncobj-wait [483.918414] Subtest syncobj-wait: SUCCESS (0.067s) [484.321236] [129/130] (558s left) kms_pm_lpsp (kms-lpsp) [485.428895] Starting subtest: kms-lpsp [485.430265] Subtest kms-lpsp: SKIP (0.000s) [485.524527] [130/130] (557s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt) [485.630276] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt [485.631727] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [485.759919] Closing watchdogs results: parsing output: 0/ for test: kms_psr2_sf results: parsing output: 1/ for test: perf_pmu results: parsing output: 2/ for test: gem_mmap_gtt results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: perf_pmu results: parsing output: 5/ for test: kms_lease results: parsing output: 6/ for test: sriov_basic results: parsing output: 7/ for test: i915_query results: parsing output: 8/ for test: kms_chamelium_color results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: kms_frontbuffer_tracking results: parsing output: 11/ for test: gem_ctx_engines results: parsing output: 12/ for test: kms_psr results: parsing output: 13/ for test: kms_plane_scaling results: parsing output: 14/ for test: kms_cursor_crc results: parsing output: 15/ for test: kms_plane_lowres results: parsing output: 16/ for test: kms_big_fb results: parsing output: 17/ for test: perf results: parsing output: 18/ for test: kms_invalid_mode results: parsing output: 19/ for test: kms_pipe_crc_basic results: parsing output: 20/ for test: gem_mmap_gtt results: parsing output: 21/ for test: kms_color results: parsing output: 22/ for test: kms_psr2_sf results: parsing output: 23/ for test: kms_ccs results: parsing output: 24/ for test: gem_ctx_bad_destroy results: parsing output: 25/ for test: i915_pm_rpm results: parsing output: 26/ for test: kms_cursor_legacy results: parsing output: 27/ for test: gem_eio results: parsing output: 28/ for test: kms_frontbuffer_tracking results: parsing output: 29/ for test: kms_frontbuffer_tracking results: parsing output: 30/ for test: syncobj_wait results: parsing output: 31/ for test: kms_ccs results: parsing output: 32/ for test: gem_exec_whisper results: parsing output: 33/ for test: gem_linear_blits results: parsing output: 34/ for test: prime_vgem results: parsing output: 35/ for test: kms_chamelium_hpd results: parsing output: 36/ for test: kms_psr results: parsing output: 37/ for test: kms_vblank results: parsing output: 38/ for test: kms_flip results: parsing output: 39/ for test: gem_ctx_persistence results: parsing output: 40/ for test: i915_drm_fdinfo results: parsing output: 41/ for test: gem_userptr_blits results: parsing output: 42/ for test: syncobj_wait results: parsing output: 43/ for test: gem_exec_reloc results: parsing output: 44/ for test: gem_pxp results: parsing output: 45/ for test: kms_properties results: parsing output: 46/ for test: kms_flip results: parsing output: 47/ for test: kms_flip_scaled_crc results: parsing output: 48/ for test: kms_cursor_legacy results: parsing output: 49/ for test: kms_big_fb results: parsing output: 50/ for test: intel_hwmon results: parsing output: 51/ for test: kms_addfb_basic results: parsing output: 52/ for test: gem_mmap results: parsing output: 53/ for test: kms_big_fb results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: kms_ccs results: parsing output: 56/ for test: kms_scaling_modes results: parsing output: 57/ for test: syncobj_timeline results: parsing output: 58/ for test: kms_async_flips results: parsing output: 59/ for test: kms_ccs results: parsing output: 60/ for test: gem_render_copy_redux results: parsing output: 61/ for test: gem_softpin results: parsing output: 62/ for test: kms_frontbuffer_tracking results: parsing output: 63/ for test: gem_eio results: parsing output: 64/ for test: gem_pxp results: parsing output: 65/ for test: gem_partial_pwrite_pread results: parsing output: 66/ for test: kms_big_fb results: parsing output: 67/ for test: kms_cursor_legacy results: parsing output: 68/ for test: gem_exec_schedule results: parsing output: 69/ for test: gem_exec_params results: parsing output: 70/ for test: gem_exec_reloc results: parsing output: 71/ for test: kms_getfb results: parsing output: 72/ for test: gem_lmem_swapping results: parsing output: 73/ for test: kms_pm_rpm results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: gem_exec_capture results: parsing output: 77/ for test: kms_pwrite_crc results: parsing output: 78/ for test: i915_getparams_basic results: parsing output: 79/ for test: kms_rotation_crc results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: syncobj_basic results: parsing output: 82/ for test: gem_create results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: gem_exec_balancer results: parsing output: 85/ for test: gem_unref_active_buffers results: parsing output: 86/ for test: kms_psr results: parsing output: 87/ for test: kms_cursor_crc results: parsing output: 88/ for test: device_reset results: parsing output: 89/ for test: syncobj_timeline results: parsing output: 90/ for test: syncobj_timeline results: parsing output: 91/ for test: gem_mmap_gtt results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: i915_pm_rc6_residency results: parsing output: 95/ for test: gem_exec_schedule results: parsing output: 96/ for test: kms_atomic_transition results: parsing output: 97/ for test: sw_sync results: parsing output: 98/ for test: kms_content_protection results: parsing output: 99/ for test: gem_exec_balancer results: parsing output: 100/ for test: kms_ccs results: parsing output: 101/ for test: vgem_basic results: parsing output: 102/ for test: syncobj_timeline results: parsing output: 103/ for test: gen7_exec_parse results: parsing output: 104/ for test: kms_vrr results: parsing output: 105/ for test: kms_dsc results: parsing output: 106/ for test: api_intel_allocator results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: gem_softpin results: parsing output: 109/ for test: kms_psr results: parsing output: 110/ for test: gem_ctx_persistence results: parsing output: 111/ for test: kms_frontbuffer_tracking results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: kms_big_fb results: parsing output: 114/ for test: gem_spin_batch results: parsing output: 115/ for test: kms_psr results: parsing output: 116/ for test: kms_frontbuffer_tracking results: parsing output: 117/ for test: kms_big_fb results: parsing output: 118/ for test: kms_flip results: parsing output: 119/ for test: gem_tiled_partial_pwrite_pread results: parsing output: 120/ for test: kms_plane_scaling results: parsing output: 121/ for test: kms_flip results: parsing output: 122/ for test: gem_partial_pwrite_pread results: parsing output: 123/ for test: dmabuf_sync_file results: parsing output: 124/ for test: gem_eio results: parsing output: 125/ for test: syncobj_timeline results: parsing output: 126/ for test: kms_cursor_legacy results: parsing output: 127/ for test: gem_exec_fence results: parsing output: 128/ for test: kms_pm_lpsp results: parsing output: 129/ for test: kms_frontbuffer_tracking Done.