[58.351646] Initializing watchdogs [58.351694] /dev/watchdog0 [58.366597] [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.371285] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.373737] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.375708] [001/133] (960s left) i915_pm_freq_api (freq-reset-multiple) [58.442058] Starting subtest: freq-reset-multiple [58.443129] Starting dynamic subtest: gt0 [65.817234] Dynamic subtest gt0: SUCCESS (7.375s) [65.824347] Starting dynamic subtest: gt1 [72.386315] Dynamic subtest gt1: SUCCESS (6.559s) [72.387842] Subtest freq-reset-multiple: SUCCESS (13.935s) [72.457222] [002/133] (946s left) gem_flink_basic (bad-open) [72.507492] Starting subtest: bad-open [72.508412] Subtest bad-open: SUCCESS (0.000s) [72.597974] [003/133] (946s left) kms_big_fb (4-tiled-32bpp-rotate-270) [72.705973] Starting subtest: 4-tiled-32bpp-rotate-270 [72.739759] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.033s) [72.854834] [004/133] (946s left) gem_caching (writes) [72.911371] Subtest writes: SKIP (0.000s) [72.971409] [005/133] (946s left) kms_plane_alpha_blend (constant-alpha-mid) [73.075371] Starting subtest: constant-alpha-mid [73.371218] Starting dynamic subtest: pipe-A-eDP-1 [74.300086] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.929s) [74.306152] Starting dynamic subtest: pipe-D-eDP-1 [75.872512] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.571s) [75.873452] Subtest constant-alpha-mid: SUCCESS (2.798s) [76.685287] [006/133] (942s left) kms_big_fb (linear-64bpp-rotate-270) [76.784198] Starting subtest: linear-64bpp-rotate-270 [76.806111] Subtest linear-64bpp-rotate-270: SKIP (0.021s) [76.903710] [007/133] (942s left) kms_ccs (bad-rotation-90-y-tiled-ccs) [76.978097] Starting subtest: bad-rotation-90-y-tiled-ccs [76.979213] Starting dynamic subtest: pipe-A-eDP-1 [76.988276] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [76.994862] Starting dynamic subtest: pipe-B-eDP-1 [77.003505] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [77.009681] Starting dynamic subtest: pipe-C-eDP-1 [77.017843] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [77.023497] Starting dynamic subtest: pipe-D-eDP-1 [77.031615] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [77.033222] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.003s) [79.253103] [008/133] (939s left) kms_hdr (bpc-switch) [79.341222] Starting subtest: bpc-switch [80.427906] Starting dynamic subtest: pipe-A-eDP-1 [83.922290] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.493s) [83.923422] Subtest bpc-switch: SUCCESS (4.581s) [84.037607] [009/133] (935s left) gem_create (create-ext-set-pat) [84.202144] Starting subtest: create-ext-set-pat [84.203312] Subtest create-ext-set-pat: SUCCESS (0.001s) [84.314572] [010/133] (934s left) gem_ctx_persistence (legacy-engines-persistence) [84.387583] Starting subtest: legacy-engines-persistence [84.388523] Starting dynamic subtest: render [85.203810] Dynamic subtest render: SUCCESS (0.815s) [85.214223] Starting dynamic subtest: bsd1 [85.974803] Dynamic subtest bsd1: SUCCESS (0.769s) [85.986065] Starting dynamic subtest: bsd2 [86.740727] Dynamic subtest bsd2: SUCCESS (0.764s) [86.751875] Starting dynamic subtest: blt [87.508326] Dynamic subtest blt: SUCCESS (0.766s) [87.517986] Starting dynamic subtest: vebox [88.273585] Dynamic subtest vebox: SUCCESS (0.762s) [88.275288] Subtest legacy-engines-persistence: SUCCESS (3.886s) [88.345387] [011/133] (930s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf) [88.452822] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf [88.453632] Starting dynamic subtest: pipe-A-eDP-1 [99.435936] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.981s) [99.443343] Starting dynamic subtest: pipe-B-eDP-1 [111.198283] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.761s) [111.199159] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (22.744s) [112.040341] [012/133] (907s left) kms_chamelium_edid (vga-edid-read) [112.426880] Subtest vga-edid-read: SKIP (0.000s) [113.244480] [013/133] (906s left) gem_exec_balancer (individual) [113.311987] Starting subtest: individual [114.915242] Subtest individual: SUCCESS (1.593s) [115.218221] [014/133] (904s left) gem_render_copy (y-tiled-to-vebox-x-tiled) [115.270975] Starting subtest: y-tiled-to-vebox-x-tiled [115.272922] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s) [115.456550] [015/133] (903s left) kms_pm_rpm (drm-resources-equal) [117.094977] Starting subtest: drm-resources-equal [122.365878] Subtest drm-resources-equal: SUCCESS (5.282s) [122.447075] [016/133] (896s left) kms_async_flips (async-flip-hang) [122.546567] Starting subtest: async-flip-hang [122.921705] Starting dynamic subtest: pipe-A-eDP-1 [149.432079] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.506s) [149.814369] Starting dynamic subtest: pipe-B-eDP-1 [165.428353] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.618s) [165.827913] Starting dynamic subtest: pipe-C-eDP-1 [181.425843] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.601s) [181.811274] Starting dynamic subtest: pipe-D-eDP-1 [197.420585] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.614s) [197.421804] Subtest async-flip-hang: SUCCESS (74.875s) [198.641869] [017/133] (820s left) kms_plane_multiple (tiling-4) [198.728882] Starting subtest: tiling-4 [198.729811] Starting dynamic subtest: pipe-A-eDP-1 [202.569435] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.839s) [202.576654] Starting dynamic subtest: pipe-B-eDP-1 [206.919800] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.349s) [206.926760] Starting dynamic subtest: pipe-C-eDP-1 [211.254822] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.334s) [211.262293] Starting dynamic subtest: pipe-D-eDP-1 [215.622381] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.367s) [215.623252] Subtest tiling-4: SUCCESS (16.894s) [216.423045] [018/133] (802s left) kms_content_protection (lic-type-1) [216.570122] Starting subtest: lic-type-1 [216.572256] Subtest lic-type-1: SKIP (0.000s) [216.709088] [019/133] (802s left) kms_cursor_crc (cursor-offscreen-64x21) [216.905043] Starting subtest: cursor-offscreen-64x21 [216.949236] Subtest cursor-offscreen-64x21: SKIP (0.043s) [217.188373] [020/133] (802s left) kms_big_fb (x-tiled-64bpp-rotate-270) [217.280230] Starting subtest: x-tiled-64bpp-rotate-270 [217.299415] Subtest x-tiled-64bpp-rotate-270: SKIP (0.019s) [217.407865] [021/133] (802s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move) [217.490854] Starting subtest: fbc-1p-primscrn-cur-indfb-move [221.576335] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.086s) [222.729253] [022/133] (796s left) prime_vgem (basic-read) [222.855574] Starting subtest: basic-read [222.860339] Subtest basic-read: SKIP (0.005s) [222.975503] [FACT prime_vgem (basic-read)] new: kernel.kmod_is_loaded.vgem: true [222.977325] [023/133] (796s left) kms_cursor_crc (cursor-rapid-movement-512x170) [223.266234] Starting subtest: cursor-rapid-movement-512x170 [223.267952] Subtest cursor-rapid-movement-512x170: SKIP (0.001s) [223.411099] [024/133] (796s left) syncobj_timeline (wait-all-delayed-signal) [223.466477] Starting subtest: wait-all-delayed-signal [223.571850] Subtest wait-all-delayed-signal: SUCCESS (0.104s) [223.655630] [025/133] (795s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs) [223.738594] Starting subtest: crc-primary-suspend-yf-tiled-ccs [223.739646] Starting dynamic subtest: pipe-A-eDP-1 [223.743439] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [223.750300] Starting dynamic subtest: pipe-B-eDP-1 [223.753927] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [223.760757] Starting dynamic subtest: pipe-C-eDP-1 [223.764423] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [223.772545] Starting dynamic subtest: pipe-D-eDP-1 [223.775772] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [223.777430] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.011s) [225.996832] [026/133] (793s left) i915_pm_rpm (system-suspend-execbuf) [228.135995] Starting subtest: system-suspend-execbuf [286.762166] Subtest system-suspend-execbuf: SUCCESS (43.993s) [287.143609] [027/133] (732s left) gem_partial_pwrite_pread (writes-after-reads) [287.205420] Subtest writes-after-reads: SKIP (0.000s) [287.274917] [028/133] (732s left) syncobj_wait (invalid-single-wait-all-unsubmitted) [287.323453] Starting subtest: invalid-single-wait-all-unsubmitted [287.324533] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s) [287.424757] [029/133] (732s left) perf_pmu (idle) [287.463649] Starting subtest: idle [287.464538] Starting dynamic subtest: rcs0 [288.016129] Dynamic subtest rcs0: SUCCESS (0.542s) [288.024671] Starting dynamic subtest: bcs0 [288.540714] Dynamic subtest bcs0: SUCCESS (0.519s) [288.548681] Starting dynamic subtest: vcs0 [289.055125] Dynamic subtest vcs0: SUCCESS (0.514s) [289.063910] Starting dynamic subtest: vcs1 [289.577848] Dynamic subtest vcs1: SUCCESS (0.520s) [289.586118] Starting dynamic subtest: vecs0 [290.094110] Dynamic subtest vecs0: SUCCESS (0.514s) [290.104848] Starting dynamic subtest: ccs0 [290.611397] Dynamic subtest ccs0: SUCCESS (0.515s) [290.612764] Subtest idle: SUCCESS (3.139s) [290.712007] [030/133] (729s left) kms_debugfs (display-off-read-all) [290.820397] Starting subtest: display-off-read-all [291.109011] Subtest display-off-read-all: SUCCESS (0.289s) [291.955096] [031/133] (727s left) syncobj_wait (multi-wait-signaled) [292.005582] Starting subtest: multi-wait-signaled [292.006435] Subtest multi-wait-signaled: SUCCESS (0.000s) [292.110912] [032/133] (727s left) kms_cursor_crc (cursor-sliding-64x64) [292.288162] Starting subtest: cursor-sliding-64x64 [292.290407] Starting dynamic subtest: pipe-A-eDP-1 [295.492708] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.202s) [295.521979] Starting dynamic subtest: pipe-D-eDP-1 [299.362848] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.847s) [299.363799] Subtest cursor-sliding-64x64: SUCCESS (7.074s) [300.211848] [033/133] (719s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size) [300.339588] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size [309.507758] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (9.166s) [310.342052] [034/133] (709s left) kms_chamelium_color (ctm-green-to-red) [310.429478] Subtest ctm-green-to-red: SKIP (0.000s) [310.480918] [035/133] (709s left) gem_exec_schedule (u-fairslice) [310.537018] Starting subtest: u-fairslice [310.537945] Starting dynamic subtest: rcs0 [312.564358] Dynamic subtest rcs0: SUCCESS (2.018s) [312.571310] Starting dynamic subtest: bcs0 [314.580564] Dynamic subtest bcs0: SUCCESS (2.018s) [314.590084] Starting dynamic subtest: vcs0 [316.601250] Dynamic subtest vcs0: SUCCESS (2.019s) [316.610678] Starting dynamic subtest: vcs1 [318.620648] Dynamic subtest vcs1: SUCCESS (2.017s) [318.628582] Starting dynamic subtest: vecs0 [320.638996] Dynamic subtest vecs0: SUCCESS (2.017s) [320.646804] Starting dynamic subtest: ccs0 [322.657990] Dynamic subtest ccs0: SUCCESS (2.020s) [322.659032] Subtest u-fairslice: SUCCESS (12.114s) [322.950734] [036/133] (697s left) gem_mmap_gtt (basic-wc) [323.001162] Subtest basic-wc: SKIP (0.000s) [323.060058] [037/133] (697s left) i915_drm_fdinfo (memory-info-idle) [323.105565] Starting subtest: memory-info-idle [323.106658] Starting dynamic subtest: smem0 [323.156745] Dynamic subtest smem0: SUCCESS (0.050s) [323.157967] Subtest memory-info-idle: SUCCESS (0.051s) [323.226800] [038/133] (696s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [323.323840] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc [323.325538] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [323.415444] [039/133] (696s left) kms_psr (fbc-pr-cursor-mmap-gtt) [323.506704] Starting subtest: fbc-pr-cursor-mmap-gtt [323.508499] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s) [323.574399] [040/133] (696s left) kms_psr (psr2-sprite-plane-move) [323.658880] Starting subtest: psr2-sprite-plane-move [323.659831] Starting dynamic subtest: eDP-1 [325.380178] Dynamic subtest eDP-1: SUCCESS (1.721s) [325.381366] Subtest psr2-sprite-plane-move: SUCCESS (1.722s) [326.206731] [041/133] (694s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite) [326.288848] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite [326.290652] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [326.376772] [042/133] (693s left) syncobj_wait (wait-any-complex) [326.429637] Starting subtest: wait-any-complex [326.493042] Subtest wait-any-complex: SUCCESS (0.062s) [326.564212] [043/133] (693s left) gem_bad_reloc (negative-reloc-lut) [326.612798] Subtest negative-reloc-lut: SKIP (0.000s) [326.678370] [044/133] (693s left) gem_exec_capture (capture) [326.734230] Starting subtest: capture [326.735209] Starting dynamic subtest: rcs0-smem [327.561139] Dynamic subtest rcs0-smem: SUCCESS (0.828s) [327.569578] Starting dynamic subtest: bcs0-smem [328.381177] Dynamic subtest bcs0-smem: SUCCESS (0.819s) [328.390511] Starting dynamic subtest: vcs0-smem [329.196671] Dynamic subtest vcs0-smem: SUCCESS (0.814s) [329.205632] Starting dynamic subtest: vcs1-smem [330.511068] Dynamic subtest vcs1-smem: SUCCESS (1.314s) [330.520749] Starting dynamic subtest: vecs0-smem [331.352024] Dynamic subtest vecs0-smem: FAIL (0.821s) [331.360202] Starting dynamic subtest: ccs0-smem [332.653922] Dynamic subtest ccs0-smem: SUCCESS (1.319s) [332.654899] Subtest capture: FAIL (5.919s) [332.757876] [045/133] (687s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier) [332.849479] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier [332.851173] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (0.000s) [332.917381] [046/133] (687s left) syncobj_timeline (invalid-transfer-non-existent-point) [332.967125] Starting subtest: invalid-transfer-non-existent-point [332.968047] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s) [333.086691] [047/133] (687s left) kms_plane (plane-panning-top-left) [333.176659] Starting subtest: plane-panning-top-left [333.177547] Starting dynamic subtest: pipe-A [334.883135] Dynamic subtest pipe-A: SUCCESS (1.706s) [334.892088] Starting dynamic subtest: pipe-B [337.263319] Dynamic subtest pipe-B: SUCCESS (2.378s) [337.264263] Subtest plane-panning-top-left: SUCCESS (4.087s) [338.060156] [048/133] (682s left) kms_flip (flip-vs-wf_vblank-interruptible) [338.147084] Starting subtest: flip-vs-wf_vblank-interruptible [338.149993] Starting dynamic subtest: A-eDP1 [340.006065] Dynamic subtest A-eDP1: SUCCESS (1.856s) [340.017875] Starting dynamic subtest: B-eDP1 [341.928814] Dynamic subtest B-eDP1: SUCCESS (1.921s) [341.939650] Starting dynamic subtest: C-eDP1 [343.852701] Dynamic subtest C-eDP1: SUCCESS (1.920s) [343.862730] Starting dynamic subtest: D-eDP1 [345.777309] Dynamic subtest D-eDP1: SUCCESS (1.922s) [345.781259] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.631s) [347.002739] [049/133] (673s left) syncobj_wait (single-wait-submitted) [347.053187] Starting subtest: single-wait-submitted [347.159371] Subtest single-wait-submitted: SUCCESS (0.106s) [347.231354] [050/133] (673s left) gen9_exec_parse (cmd-crossing-page) [347.291934] Subtest cmd-crossing-page: SKIP (0.000s) [347.354239] [051/133] (673s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt) [347.443340] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt [347.445226] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [347.535788] [052/133] (673s left) kms_fbcon_fbt (psr-suspend) [347.590523] Starting subtest: psr-suspend [398.381744] Subtest psr-suspend: SUCCESS (20.475s) [400.463993] [053/133] (622s left) api_intel_bb (reset-flags) [400.522012] Starting subtest: reset-flags [400.527820] Subtest reset-flags: SUCCESS (0.007s) [400.642802] [054/133] (622s left) gem_ctx_persistence (engines-mixed) [400.689232] Starting subtest: engines-mixed [400.690171] Starting dynamic subtest: rcs0 [400.769345] Dynamic subtest rcs0: SUCCESS (0.081s) [400.780990] Starting dynamic subtest: bcs0 [400.817934] Dynamic subtest bcs0: SUCCESS (0.047s) [400.830118] Starting dynamic subtest: vcs0 [400.866786] Dynamic subtest vcs0: SUCCESS (0.048s) [400.880285] Starting dynamic subtest: vcs1 [400.910798] Dynamic subtest vcs1: SUCCESS (0.042s) [400.920973] Starting dynamic subtest: vecs0 [400.958684] Dynamic subtest vecs0: SUCCESS (0.047s) [400.967354] Starting dynamic subtest: ccs0 [401.013752] Dynamic subtest ccs0: SUCCESS (0.054s) [401.014893] Subtest engines-mixed: SUCCESS (0.327s) [401.087851] [055/133] (621s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render) [401.187346] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render [407.954964] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.766s) [408.109418] [056/133] (614s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt) [408.198283] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt [408.200022] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [408.287715] [057/133] (614s left) gem_exec_whisper (basic-queues-all) [408.344735] Starting subtest: basic-queues-all [419.781351] Subtest basic-queues-all: SUCCESS (11.423s) [419.953478] [058/133] (602s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip) [420.070952] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip [421.083079] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.012s) [421.189683] [059/133] (601s left) kms_cursor_crc (cursor-size-change) [421.280053] Starting subtest: cursor-size-change [421.280971] Starting dynamic subtest: pipe-A-eDP-1 [422.094358] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.813s) [422.104337] Starting dynamic subtest: pipe-D-eDP-1 [423.652909] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.557s) [423.653659] Subtest cursor-size-change: SUCCESS (2.373s) [424.543266] [060/133] (598s left) drm_buddy (drm_buddy) [424.578229] Starting subtest: drm_buddy [424.580062] Subtest drm_buddy: SKIP (0.001s) [424.632770] [061/133] (598s left) kms_dsc (dsc-with-formats) [424.728042] Starting subtest: dsc-with-formats [424.752231] Subtest dsc-with-formats: SKIP (0.001s) [424.795428] [062/133] (598s left) gem_bad_reloc (negative-reloc-bltcopy) [424.858399] Subtest negative-reloc-bltcopy: SKIP (0.000s) [424.933321] [063/133] (598s left) tools_test (sysfs_l3_parity) [424.966825] Starting subtest: sysfs_l3_parity [425.061216] Subtest sysfs_l3_parity: SKIP (0.097s) [425.137622] [064/133] (597s left) gem_eio (kms) [425.410462] Starting subtest: kms [446.197167] Subtest kms: SUCCESS (20.778s) [446.304756] [065/133] (576s left) kms_psr (fbc-psr2-no-drrs) [446.395666] Starting subtest: fbc-psr2-no-drrs [446.396548] Starting dynamic subtest: eDP-1 [446.398343] Dynamic subtest eDP-1: SKIP (0.000s) [446.400202] Subtest fbc-psr2-no-drrs: SKIP (0.001s) [446.463039] [066/133] (576s left) gem_mmap_wc (write-wc-read-gtt) [446.511237] Subtest write-wc-read-gtt: SKIP (0.000s) [446.562964] [067/133] (576s left) kms_plane_scaling (planes-downscale-factor-0-5) [446.647711] Starting subtest: planes-downscale-factor-0-5 [446.648490] Starting dynamic subtest: pipe-A [446.667756] Dynamic subtest pipe-A: SKIP (0.018s) [446.676042] Starting dynamic subtest: pipe-B [446.698786] Dynamic subtest pipe-B: SKIP (0.031s) [446.706965] Starting dynamic subtest: pipe-C [446.731533] Dynamic subtest pipe-C: SKIP (0.031s) [446.739525] Starting dynamic subtest: pipe-D [446.763690] Dynamic subtest pipe-D: SKIP (0.031s) [446.765288] Subtest planes-downscale-factor-0-5: SKIP (0.114s) [446.862526] [068/133] (576s left) gem_exec_schedule (noreorder) [447.047492] Starting subtest: noreorder [447.048332] Starting dynamic subtest: rcs0 [447.100959] Dynamic subtest rcs0: SUCCESS (0.061s) [447.112997] Starting dynamic subtest: vcs0 [448.844031] Dynamic subtest vcs0: SUCCESS (1.732s) [448.854766] Starting dynamic subtest: vcs1 [450.828176] Dynamic subtest vcs1: SUCCESS (1.981s) [450.839033] Starting dynamic subtest: vecs0 [452.832160] Dynamic subtest vecs0: SUCCESS (2.001s) [452.842504] Starting dynamic subtest: ccs0 [452.901193] Dynamic subtest ccs0: SUCCESS (0.075s) [452.902679] Subtest noreorder: SUCCESS (5.863s) [453.084471] [069/133] (570s left) kms_flip (flip-vs-modeset-vs-hang) [453.182705] Starting subtest: flip-vs-modeset-vs-hang [453.183793] Starting dynamic subtest: A-eDP1 [504.319123] Dynamic subtest A-eDP1: SUCCESS (51.130s) [504.329376] Starting dynamic subtest: D-eDP1 [554.361092] Dynamic subtest D-eDP1: SUCCESS (50.039s) [554.363688] Subtest flip-vs-modeset-vs-hang: SUCCESS (101.174s) [554.733895] [070/133] (468s left) gem_exec_reloc (basic-gtt-wc-active) [554.803759] Subtest basic-gtt-wc-active: SKIP (0.000s) [554.869547] [071/133] (468s left) gem_exec_schedule (u-submit-late-slice) [554.925990] Starting subtest: u-submit-late-slice [554.926933] Starting dynamic subtest: rcs0 [554.969169] Dynamic subtest rcs0: SUCCESS (0.043s) [554.980946] Starting dynamic subtest: bcs0 [555.014721] Dynamic subtest bcs0: SUCCESS (0.045s) [555.023142] Starting dynamic subtest: vcs0 [555.052194] Dynamic subtest vcs0: SUCCESS (0.037s) [555.061716] Starting dynamic subtest: vcs1 [555.087709] Dynamic subtest vcs1: SUCCESS (0.035s) [555.097954] Starting dynamic subtest: vecs0 [555.127469] Dynamic subtest vecs0: SUCCESS (0.039s) [555.136434] Starting dynamic subtest: ccs0 [555.167417] Dynamic subtest ccs0: SUCCESS (0.039s) [555.168353] Subtest u-submit-late-slice: SUCCESS (0.242s) [556.912212] [072/133] (466s left) vgem_basic (create) [556.959780] Starting subtest: create [556.960908] Subtest create: SUCCESS (0.000s) [557.030158] [073/133] (466s left) kms_prop_blob (blob-prop-validate) [557.085856] Starting subtest: blob-prop-validate [557.086725] Subtest blob-prop-validate: SUCCESS (0.000s) [557.169094] [074/133] (466s left) kms_async_flips (invalid-async-flip-atomic) [557.248187] Starting subtest: invalid-async-flip-atomic [557.620982] Starting dynamic subtest: pipe-A-eDP-1 [558.454657] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.833s) [558.812924] Starting dynamic subtest: pipe-B-eDP-1 [559.584387] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.779s) [559.942604] Starting dynamic subtest: pipe-C-eDP-1 [560.709095] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.775s) [561.060849] Starting dynamic subtest: pipe-D-eDP-1 [561.830649] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.777s) [561.831526] Subtest invalid-async-flip-atomic: SUCCESS (4.583s) [562.975777] [075/133] (460s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff) [563.067853] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff [563.069561] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [563.159054] [076/133] (460s left) kms_vblank (wait-busy-hang) [563.246818] Starting subtest: wait-busy-hang [563.247684] Starting dynamic subtest: pipe-A-eDP-1 [589.589009] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.339s) [589.600711] Starting dynamic subtest: pipe-D-eDP-1 [614.631538] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.036s) [614.632542] Subtest wait-busy-hang: SUCCESS (51.379s) [615.434293] [077/133] (408s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary) [615.526876] Starting subtest: fbcpsr-shrfb-scaledprimary [621.353491] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.827s) [621.497398] [078/133] (402s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc) [621.581658] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc [621.582502] Starting dynamic subtest: pipe-A-eDP-1 [621.585719] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [621.594106] Starting dynamic subtest: pipe-B-eDP-1 [621.597488] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [621.605460] Starting dynamic subtest: pipe-C-eDP-1 [621.609038] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [621.616696] Starting dynamic subtest: pipe-D-eDP-1 [621.620069] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [621.621959] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s) [623.753969] [079/133] (399s left) perf (global-sseu-config) [623.874535] Starting subtest: global-sseu-config [623.876328] Subtest global-sseu-config: SKIP (0.000s) [623.916808] [080/133] (399s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc) [624.007013] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc [628.034763] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (4.028s) [629.136414] [081/133] (394s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [629.232864] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt [629.234663] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [629.339425] [082/133] (394s left) kms_cursor_legacy (cursora-vs-flipb-legacy) [629.450301] Starting subtest: cursorA-vs-flipB-legacy [629.452221] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s) [629.590386] [083/133] (394s left) gem_lmem_swapping (verify) [629.633223] Subtest verify: SKIP (0.000s) [629.677861] [084/133] (394s left) gem_exec_fence (syncobj-timeline-invalid-wait) [630.208226] Starting subtest: syncobj-timeline-invalid-wait [630.209499] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.003s) [631.883696] [085/133] (391s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [631.984279] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt [631.996375] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [632.083910] [086/133] (391s left) kms_color (invalid-degamma-lut-sizes) [632.176273] Starting subtest: invalid-degamma-lut-sizes [632.177117] Starting dynamic subtest: pipe-A [632.472977] Dynamic subtest pipe-A: SUCCESS (0.297s) [632.481076] Starting dynamic subtest: pipe-B [632.481898] Dynamic subtest pipe-B: SUCCESS (0.000s) [632.489805] Starting dynamic subtest: pipe-C [632.490691] Dynamic subtest pipe-C: SUCCESS (0.000s) [632.498214] Starting dynamic subtest: pipe-D [632.499070] Dynamic subtest pipe-D: SUCCESS (0.000s) [632.499917] Subtest invalid-degamma-lut-sizes: SUCCESS (0.300s) [633.270691] [087/133] (390s left) gen3_mixed_blits [633.376064] [088/133] (390s left) kms_big_fb (y-tiled-addfb-size-offset-overflow) [633.475679] Starting subtest: y-tiled-addfb-size-offset-overflow [633.477227] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s) [633.580035] [089/133] (390s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt) [633.670520] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt [640.610987] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.932s) [640.716601] [090/133] (383s left) gem_softpin (allocator-fork) [640.764667] Starting subtest: allocator-fork [643.018992] Subtest allocator-fork: SUCCESS (2.209s) [643.084024] [091/133] (380s left) i915_suspend (forcewake) [643.125396] Starting subtest: forcewake [675.372824] Subtest forcewake: SUCCESS (3.027s) [682.473298] [092/133] (348s left) kms_lease (lease-unleased-crtc) [682.567116] Starting subtest: lease-unleased-crtc [682.568000] Starting dynamic subtest: pipe-A-eDP-1 [682.860937] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.294s) [682.873639] Starting dynamic subtest: pipe-B-eDP-1 [683.589080] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.715s) [683.600020] Starting dynamic subtest: pipe-C-eDP-1 [683.600937] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s) [683.609017] Starting dynamic subtest: pipe-D-eDP-1 [683.609912] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.008s) [683.610841] Subtest lease-unleased-crtc: SUCCESS (1.041s) [684.002889] [093/133] (347s left) gem_wait (await) [684.067034] Starting subtest: await [684.067921] Starting dynamic subtest: all-engines [685.146089] Dynamic subtest all-engines: SUCCESS (1.078s) [685.163264] Starting dynamic subtest: rcs0 [686.206196] Dynamic subtest rcs0: SUCCESS (1.056s) [686.225684] Starting dynamic subtest: bcs0 [687.266612] Dynamic subtest bcs0: SUCCESS (1.057s) [687.278258] Starting dynamic subtest: vcs0 [688.332298] Dynamic subtest vcs0: SUCCESS (1.061s) [688.353827] Starting dynamic subtest: vcs1 [689.387677] Dynamic subtest vcs1: SUCCESS (1.052s) [689.406325] Starting dynamic subtest: vecs0 [690.441130] Dynamic subtest vecs0: SUCCESS (1.050s) [690.457815] Starting dynamic subtest: ccs0 [691.499850] Dynamic subtest ccs0: SUCCESS (1.056s) [691.503128] Subtest await: SUCCESS (7.427s) [691.693580] [094/133] (339s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling) [691.787938] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling [691.789643] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.000s) [691.857123] [095/133] (339s left) gem_exec_reloc (basic-gtt-wc) [691.915251] Subtest basic-gtt-wc: SKIP (0.000s) [691.997363] [096/133] (339s left) gem_exec_parallel (userptr) [692.060387] Starting subtest: userptr [692.061416] Starting dynamic subtest: rcs0 [693.500213] Dynamic subtest rcs0: SUCCESS (1.439s) [693.511489] Starting dynamic subtest: bcs0 [694.983006] Dynamic subtest bcs0: SUCCESS (1.481s) [694.995250] Starting dynamic subtest: vcs0 [697.033801] Dynamic subtest vcs0: SUCCESS (2.039s) [697.044535] Starting dynamic subtest: vcs1 [699.082018] Dynamic subtest vcs1: SUCCESS (2.044s) [699.092921] Starting dynamic subtest: vecs0 [701.065849] Dynamic subtest vecs0: SUCCESS (1.980s) [701.077078] Starting dynamic subtest: ccs0 [702.570952] Dynamic subtest ccs0: SUCCESS (1.510s) [702.572030] Subtest userptr: SUCCESS (10.506s) [702.752093] [097/133] (328s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render) [702.843284] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render [702.844997] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [702.935610] [098/133] (328s left) kms_pm_rpm (pm-caching) [705.269884] Starting subtest: pm-caching [705.272408] Subtest pm-caching: SKIP (0.000s) [705.646847] [099/133] (325s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc) [705.747616] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc [705.749543] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [705.832525] [100/133] (325s left) kms_universal_plane (cursor-fb-leak) [705.915838] Starting subtest: cursor-fb-leak [705.916774] Starting dynamic subtest: pipe-A-eDP-1 [706.259343] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.342s) [706.271453] Starting dynamic subtest: pipe-B-eDP-1 [707.670465] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.408s) [707.682913] Starting dynamic subtest: pipe-C-eDP-1 [709.081298] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.409s) [709.092435] Starting dynamic subtest: pipe-D-eDP-1 [710.402644] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.319s) [710.404076] Subtest cursor-fb-leak: SUCCESS (4.486s) [711.556291] [101/133] (319s left) syncobj_wait (wait-all-interrupted) [711.615534] Starting subtest: wait-all-interrupted [711.718552] Subtest wait-all-interrupted: SUCCESS (0.102s) [711.789435] [102/133] (319s left) gem_fence_thrash (bo-write-verify-threaded-x) [711.818274] Starting subtest: bo-write-verify-threaded-x [711.835910] Subtest bo-write-verify-threaded-x: SKIP (0.018s) [711.886646] [103/133] (319s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling) [711.968060] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling [711.969740] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s) [712.036828] [104/133] (319s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted) [712.099158] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted [712.205875] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.105s) [712.291307] [105/133] (319s left) kms_joiner (invalid-modeset-force-big-joiner) [712.385800] Starting subtest: invalid-modeset-force-big-joiner [712.387421] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s) [712.456976] [106/133] (319s left) kms_busy (extended-modeset-hang-oldfb) [712.539172] Starting subtest: extended-modeset-hang-oldfb [712.541374] Starting dynamic subtest: pipe-A [724.336673] Dynamic subtest pipe-A: SUCCESS (11.793s) [724.348803] Starting dynamic subtest: pipe-D [736.635432] Dynamic subtest pipe-D: SUCCESS (12.291s) [736.636657] Subtest extended-modeset-hang-oldfb: SUCCESS (24.089s) [737.446455] [107/133] (294s left) gem_userptr_blits (sync-unmap) [737.506590] Starting subtest: sync-unmap [737.521347] Subtest sync-unmap: SUCCESS (0.014s) [737.675069] [108/133] (293s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [737.790224] Starting subtest: basic-flip-after-cursor-atomic [738.723346] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.932s) [739.580873] [109/133] (292s left) kms_psr (fbc-psr-sprite-blt) [739.665075] Starting subtest: fbc-psr-sprite-blt [739.665814] Starting dynamic subtest: eDP-1 [739.667496] Dynamic subtest eDP-1: SKIP (0.000s) [739.669069] Subtest fbc-psr-sprite-blt: SKIP (0.001s) [739.746197] [110/133] (291s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt) [739.830551] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt [739.832259] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [739.918764] [111/133] (291s left) prime_mmap (test_errors) [739.963025] Starting subtest: test_errors [739.963777] Starting dynamic subtest: test_errors-smem [740.062286] Dynamic subtest test_errors-smem: SUCCESS (0.099s) [740.063766] Subtest test_errors: SUCCESS (0.100s) [740.150806] [112/133] (291s left) api_intel_allocator (reloc-allocator) [740.199391] Starting subtest: reloc-allocator [740.200192] Starting dynamic subtest: basic [740.202014] Dynamic subtest basic: SUCCESS (0.003s) [740.210578] Starting dynamic subtest: parallel-one [740.211343] Dynamic subtest parallel-one: SUCCESS (0.008s) [740.219431] Starting dynamic subtest: print [740.220236] Dynamic subtest print: SUCCESS (0.000s) [740.228069] Starting dynamic subtest: reuse [740.228906] Dynamic subtest reuse: SUCCESS (0.000s) [740.236787] Starting dynamic subtest: fork-reopen-allocator [740.237625] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s) [740.238356] Subtest reloc-allocator: SUCCESS (0.026s) [740.343874] [113/133] (291s left) kms_getfb (getfb-repeated-different-handles) [740.431900] Starting subtest: getfb-repeated-different-handles [740.432723] Subtest getfb-repeated-different-handles: SUCCESS (0.000s) [740.525419] [114/133] (291s left) kms_atomic_interruptible (legacy-dpms) [740.619211] Starting subtest: legacy-dpms [740.620011] Starting dynamic subtest: pipe-A-eDP-1 [748.018450] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.396s) [748.019315] Subtest legacy-dpms: SUCCESS (7.397s) [748.846617] [115/133] (283s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary) [748.938690] Starting subtest: psr-shrfb-scaledprimary [754.745182] Subtest psr-shrfb-scaledprimary: SUCCESS (5.806s) [754.887150] [116/133] (276s left) kms_ccs (bad-pixel-format-y-tiled-ccs) [754.974075] Starting subtest: bad-pixel-format-y-tiled-ccs [754.974815] Starting dynamic subtest: pipe-A-eDP-1 [754.982397] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [754.990990] Starting dynamic subtest: pipe-B-eDP-1 [754.998545] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [755.007670] Starting dynamic subtest: pipe-C-eDP-1 [755.015514] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [755.023571] Starting dynamic subtest: pipe-D-eDP-1 [755.031435] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [755.033174] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.004s) [757.137095] [117/133] (274s left) perf (invalid-remove-userspace-config) [757.234542] Starting subtest: invalid-remove-userspace-config [757.244955] Subtest invalid-remove-userspace-config: SUCCESS (0.010s) [757.282940] [118/133] (274s left) syncobj_timeline (multi-wait-available-signaled) [757.332028] Starting subtest: multi-wait-available-signaled [757.332987] Subtest multi-wait-available-signaled: SUCCESS (0.000s) [757.448522] [119/133] (274s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt) [757.539955] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt [757.541694] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [757.632227] [120/133] (274s left) kms_psr (psr-sprite-render) [757.722334] Starting subtest: psr-sprite-render [757.723325] Starting dynamic subtest: eDP-1 [759.478962] Dynamic subtest eDP-1: SUCCESS (1.757s) [759.479769] Subtest psr-sprite-render: SUCCESS (1.758s) [760.311031] [121/133] (271s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted) [760.363086] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted [760.480924] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.107s) [760.543810] [122/133] (271s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0) [760.633013] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0 [760.634625] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s) [760.717779] [123/133] (271s left) gem_pxp (protected-raw-src-copy-not-readible) [760.840723] Starting subtest: protected-raw-src-copy-not-readible [760.899370] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.060s) [761.032991] [124/133] (271s left) gem_mmap_gtt (flink-race) [761.075757] Subtest flink-race: SKIP (0.000s) [761.131136] [125/133] (271s left) kms_chamelium_hpd (dp-hpd-for-each-pipe) [761.500849] Subtest dp-hpd-for-each-pipe: SKIP (0.000s) [762.317347] [126/133] (269s left) gem_exec_reloc (basic-gtt-cpu-noreloc) [762.371837] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s) [762.428660] [127/133] (269s left) sysfs_timeslice_duration (idempotent) [762.490419] Starting subtest: idempotent [762.491630] Starting dynamic subtest: vecs0 [762.492656] Dynamic subtest vecs0: SUCCESS (0.000s) [762.502624] Starting dynamic subtest: ccs0 [762.503506] Dynamic subtest ccs0: SUCCESS (0.000s) [762.512381] Starting dynamic subtest: vcs0 [762.513246] Dynamic subtest vcs0: SUCCESS (0.000s) [762.521291] Starting dynamic subtest: bcs0 [762.522114] Dynamic subtest bcs0: SUCCESS (0.000s) [762.530194] Starting dynamic subtest: rcs0 [762.531054] Dynamic subtest rcs0: SUCCESS (0.000s) [762.539189] Starting dynamic subtest: vcs1 [762.540086] Dynamic subtest vcs1: SUCCESS (0.000s) [762.540930] Subtest idempotent: SUCCESS (0.007s) [762.600749] [128/133] (269s left) kms_flip (plain-flip-ts-check-interruptible) [762.698417] Starting subtest: plain-flip-ts-check-interruptible [762.700830] Starting dynamic subtest: A-eDP1 [771.570570] Dynamic subtest A-eDP1: SUCCESS (8.843s) [771.581373] Starting dynamic subtest: B-eDP1 [780.411821] Dynamic subtest B-eDP1: SUCCESS (8.839s) [780.423367] Starting dynamic subtest: C-eDP1 [789.232675] Dynamic subtest C-eDP1: SUCCESS (8.808s) [789.243461] Starting dynamic subtest: D-eDP1 [798.065292] Dynamic subtest D-eDP1: SUCCESS (8.830s) [798.066258] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.334s) [799.201782] [129/133] (233s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all) [799.270496] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all [799.298801] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.005s) [799.352274] [130/133] (233s left) gem_close_race (basic-process) [799.414728] Starting subtest: basic-process [799.467830] Subtest basic-process: SUCCESS (0.053s) [799.644683] [131/133] (232s left) perf_pmu (all-busy-check-all) [799.687376] Starting subtest: all-busy-check-all [801.034632] Subtest all-busy-check-all: SUCCESS (1.337s) [801.119258] [132/133] (231s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw) [801.203571] Starting subtest: psr-2p-pri-indfb-multidraw [801.205276] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s) [801.315901] [133/133] (231s left) kms_psr (pr-basic) [801.427307] Starting subtest: pr-basic [801.429122] Subtest pr-basic: SKIP (0.000s) [801.496005] Closing watchdogs results: parsing output: 0/ for test: i915_pm_freq_api results: parsing output: 1/ for test: gem_flink_basic results: parsing output: 2/ for test: kms_big_fb results: parsing output: 3/ for test: gem_caching results: parsing output: 4/ for test: kms_plane_alpha_blend results: parsing output: 5/ for test: kms_big_fb results: parsing output: 6/ for test: kms_ccs results: parsing output: 7/ for test: kms_hdr results: parsing output: 8/ for test: gem_create results: parsing output: 9/ for test: gem_ctx_persistence results: parsing output: 10/ for test: kms_psr2_sf results: parsing output: 11/ for test: kms_chamelium_edid results: parsing output: 12/ for test: gem_exec_balancer results: parsing output: 13/ for test: gem_render_copy results: parsing output: 14/ for test: kms_pm_rpm results: parsing output: 15/ for test: kms_async_flips results: parsing output: 16/ for test: kms_plane_multiple results: parsing output: 17/ for test: kms_content_protection results: parsing output: 18/ for test: kms_cursor_crc results: parsing output: 19/ for test: kms_big_fb results: parsing output: 20/ for test: kms_frontbuffer_tracking results: parsing output: 21/ for test: prime_vgem results: parsing output: 22/ for test: kms_cursor_crc results: parsing output: 23/ for test: syncobj_timeline results: parsing output: 24/ for test: kms_ccs results: parsing output: 25/ for test: i915_pm_rpm results: parsing output: 26/ for test: gem_partial_pwrite_pread results: parsing output: 27/ for test: syncobj_wait results: parsing output: 28/ for test: perf_pmu results: parsing output: 29/ for test: kms_debugfs results: parsing output: 30/ for test: syncobj_wait results: parsing output: 31/ for test: kms_cursor_crc results: parsing output: 32/ for test: kms_cursor_legacy results: parsing output: 33/ for test: kms_chamelium_color results: parsing output: 34/ for test: gem_exec_schedule results: parsing output: 35/ for test: gem_mmap_gtt results: parsing output: 36/ for test: i915_drm_fdinfo results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: kms_psr results: parsing output: 39/ for test: kms_psr results: parsing output: 40/ for test: kms_frontbuffer_tracking results: parsing output: 41/ for test: syncobj_wait results: parsing output: 42/ for test: gem_bad_reloc results: parsing output: 43/ for test: gem_exec_capture results: parsing output: 44/ for test: kms_plane results: parsing output: 45/ for test: syncobj_timeline results: parsing output: 46/ for test: kms_plane results: parsing output: 47/ for test: kms_flip results: parsing output: 48/ for test: syncobj_wait results: parsing output: 49/ for test: gen9_exec_parse results: parsing output: 50/ for test: kms_frontbuffer_tracking results: parsing output: 51/ for test: kms_fbcon_fbt results: parsing output: 52/ for test: api_intel_bb results: parsing output: 53/ for test: gem_ctx_persistence results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: kms_frontbuffer_tracking results: parsing output: 56/ for test: gem_exec_whisper results: parsing output: 57/ for test: kms_big_fb results: parsing output: 58/ for test: kms_cursor_crc results: parsing output: 59/ for test: drm_buddy results: parsing output: 60/ for test: kms_dsc results: parsing output: 61/ for test: gem_bad_reloc results: parsing output: 62/ for test: tools_test results: parsing output: 63/ for test: gem_eio results: parsing output: 64/ for test: kms_psr results: parsing output: 65/ for test: gem_mmap_wc results: parsing output: 66/ for test: kms_plane_scaling results: parsing output: 67/ for test: gem_exec_schedule results: parsing output: 68/ for test: kms_flip results: parsing output: 69/ for test: gem_exec_reloc results: parsing output: 70/ for test: gem_exec_schedule results: parsing output: 71/ for test: vgem_basic results: parsing output: 72/ for test: kms_prop_blob results: parsing output: 73/ for test: kms_async_flips results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: kms_vblank results: parsing output: 76/ for test: kms_frontbuffer_tracking results: parsing output: 77/ for test: kms_ccs results: parsing output: 78/ for test: perf results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: kms_cursor_legacy results: parsing output: 82/ for test: gem_lmem_swapping results: parsing output: 83/ for test: gem_exec_fence results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: kms_color results: parsing output: 86/ for test: gen3_mixed_blits results: parsing output: 87/ for test: kms_big_fb results: parsing output: 88/ for test: kms_frontbuffer_tracking results: parsing output: 89/ for test: gem_softpin results: parsing output: 90/ for test: i915_suspend results: parsing output: 91/ for test: kms_lease results: parsing output: 92/ for test: gem_wait results: parsing output: 93/ for test: kms_flip_scaled_crc results: parsing output: 94/ for test: gem_exec_reloc results: parsing output: 95/ for test: gem_exec_parallel results: parsing output: 96/ for test: kms_frontbuffer_tracking results: parsing output: 97/ for test: kms_pm_rpm results: parsing output: 98/ for test: kms_frontbuffer_tracking results: parsing output: 99/ for test: kms_universal_plane results: parsing output: 100/ for test: syncobj_wait results: parsing output: 101/ for test: gem_fence_thrash results: parsing output: 102/ for test: kms_flip_scaled_crc results: parsing output: 103/ for test: syncobj_timeline results: parsing output: 104/ for test: kms_joiner results: parsing output: 105/ for test: kms_busy results: parsing output: 106/ for test: gem_userptr_blits results: parsing output: 107/ for test: kms_cursor_legacy results: parsing output: 108/ for test: kms_psr results: parsing output: 109/ for test: kms_frontbuffer_tracking results: parsing output: 110/ for test: prime_mmap results: parsing output: 111/ for test: api_intel_allocator results: parsing output: 112/ for test: kms_getfb results: parsing output: 113/ for test: kms_atomic_interruptible results: parsing output: 114/ for test: kms_frontbuffer_tracking results: parsing output: 115/ for test: kms_ccs results: parsing output: 116/ for test: perf results: parsing output: 117/ for test: syncobj_timeline results: parsing output: 118/ for test: kms_frontbuffer_tracking results: parsing output: 119/ for test: kms_psr results: parsing output: 120/ for test: syncobj_timeline results: parsing output: 121/ for test: kms_big_fb results: parsing output: 122/ for test: gem_pxp results: parsing output: 123/ for test: gem_mmap_gtt results: parsing output: 124/ for test: kms_chamelium_hpd results: parsing output: 125/ for test: gem_exec_reloc results: parsing output: 126/ for test: sysfs_timeslice_duration results: parsing output: 127/ for test: kms_flip results: parsing output: 128/ for test: sriov_basic results: parsing output: 129/ for test: gem_close_race results: parsing output: 130/ for test: perf_pmu results: parsing output: 131/ for test: kms_frontbuffer_tracking results: parsing output: 132/ for test: kms_psr Done.