[59.837924] Initializing watchdogs [59.838099] /dev/watchdog0 [59.853683] [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] [59.858602] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [59.860948] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.864366] [001/132] (960s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip) [60.002368] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip [61.038457] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.036s) [61.170215] [002/132] (959s left) gem_fenced_exec_thrash (no-spare-fences-interruptible) [61.238472] Subtest no-spare-fences-interruptible: SKIP (0.000s) [61.313805] [003/132] (959s left) gem_pread (display) [61.375761] Subtest display: SKIP (0.000s) [61.429274] [004/132] (959s left) kms_setmode (invalid-clone-single-crtc) [61.482367] Starting subtest: invalid-clone-single-crtc [61.487881] Subtest invalid-clone-single-crtc: SKIP (0.000s) [61.577685] [005/132] (958s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [61.707330] Starting subtest: basic-flip-after-cursor-legacy [62.641619] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.931s) [63.449281] [006/132] (957s left) kms_psr (fbc-psr-sprite-blt) [63.545722] Starting subtest: fbc-psr-sprite-blt [63.548022] Starting dynamic subtest: eDP-1 [63.552228] Dynamic subtest eDP-1: SKIP (0.000s) [63.556524] Subtest fbc-psr-sprite-blt: SKIP (0.000s) [63.617152] [007/132] (956s left) perf_pmu (most-busy-check-all) [63.660041] Starting subtest: most-busy-check-all [63.662779] Starting dynamic subtest: rcs0 [64.918326] Dynamic subtest rcs0: SUCCESS (1.257s) [64.927548] Starting dynamic subtest: bcs0 [66.838190] Dynamic subtest bcs0: SUCCESS (1.917s) [66.848083] Starting dynamic subtest: vcs0 [68.885884] Dynamic subtest vcs0: SUCCESS (2.045s) [68.896626] Starting dynamic subtest: vcs1 [70.934660] Dynamic subtest vcs1: SUCCESS (2.046s) [70.945749] Starting dynamic subtest: vecs0 [72.917601] Dynamic subtest vecs0: SUCCESS (1.981s) [72.928455] Starting dynamic subtest: ccs0 [74.901721] Dynamic subtest ccs0: SUCCESS (1.981s) [74.904703] Subtest most-busy-check-all: SUCCESS (11.234s) [75.005100] [008/132] (945s left) kms_big_fb (yf-tiled-8bpp-rotate-0) [75.111692] Starting subtest: yf-tiled-8bpp-rotate-0 [75.116380] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s) [75.210032] [009/132] (945s left) kms_flip (basic-plain-flip) [75.304922] Starting subtest: basic-plain-flip [75.307740] Starting dynamic subtest: A-eDP1 [76.968246] Dynamic subtest A-eDP1: SUCCESS (1.663s) [76.978587] Starting dynamic subtest: B-eDP1 [78.607562] Dynamic subtest B-eDP1: SUCCESS (1.637s) [78.617666] Starting dynamic subtest: C-eDP1 [80.239027] Dynamic subtest C-eDP1: SUCCESS (1.630s) [80.248919] Starting dynamic subtest: D-eDP1 [81.878724] Dynamic subtest D-eDP1: SUCCESS (1.638s) [81.883565] Subtest basic-plain-flip: SUCCESS (6.578s) [83.035972] [010/132] (937s left) kms_invalid_mode (bad-vsync-start) [83.137129] Starting subtest: bad-vsync-start [83.139539] Starting dynamic subtest: pipe-A-eDP-1 [83.423062] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s) [83.431829] Starting dynamic subtest: pipe-B-eDP-1 [83.434083] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [83.441706] Starting dynamic subtest: pipe-C-eDP-1 [83.443694] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [83.451229] Starting dynamic subtest: pipe-D-eDP-1 [83.453802] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [83.456314] Subtest bad-vsync-start: SUCCESS (0.293s) [84.266846] [011/132] (936s left) kms_psr (fbc-psr2-sprite-blt) [84.365888] Starting subtest: fbc-psr2-sprite-blt [84.368183] Starting dynamic subtest: eDP-1 [84.372734] Dynamic subtest eDP-1: SKIP (0.000s) [84.377429] Subtest fbc-psr2-sprite-blt: SKIP (0.000s) [84.437676] [012/132] (936s left) kms_cursor_legacy (flip-vs-cursor-varying-size) [84.566195] Starting subtest: flip-vs-cursor-varying-size [93.325716] Subtest flip-vs-cursor-varying-size: SUCCESS (8.757s) [94.199156] [013/132] (926s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier) [94.300537] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier [94.326721] Starting dynamic subtest: pipe-A-plane-0 [94.616423] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s) [94.623684] Starting dynamic subtest: pipe-A-plane-3 [94.849071] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s) [94.857319] Starting dynamic subtest: pipe-A-plane-5 [94.860890] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [95.981520] Starting dynamic subtest: pipe-B-plane-0 [96.284912] Dynamic subtest pipe-B-plane-0: SUCCESS (0.311s) [96.293576] Starting dynamic subtest: pipe-B-plane-3 [96.529306] Dynamic subtest pipe-B-plane-3: SUCCESS (0.244s) [96.536751] Starting dynamic subtest: pipe-B-plane-5 [96.540853] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [96.842792] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SUCCESS (2.541s) [97.660539] [014/132] (923s left) gen7_exec_parse (basic-allocation) [97.731993] Subtest basic-allocation: SKIP (0.000s) [97.793572] [015/132] (923s left) gem_exec_reloc (basic-gtt) [97.859638] Subtest basic-gtt: SKIP (0.000s) [97.926376] [016/132] (923s left) kms_cursor_crc (cursor-rapid-movement-256x256) [98.172690] Starting subtest: cursor-rapid-movement-256x256 [98.174984] Starting dynamic subtest: pipe-A-eDP-1 [98.719983] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.544s) [98.754075] Starting dynamic subtest: pipe-D-eDP-1 [99.902403] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.160s) [99.905627] Subtest cursor-rapid-movement-256x256: SUCCESS (1.731s) [100.754430] [017/132] (920s left) kms_rotation_crc (primary-x-tiled-reflect-x-180) [100.854018] Starting subtest: primary-x-tiled-reflect-x-180 [107.817374] Subtest primary-x-tiled-reflect-x-180: SUCCESS (6.964s) [109.027565] [018/132] (911s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [109.116953] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip [109.121202] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s) [109.223809] [019/132] (911s left) i915_selftest (perf) [110.839813] Starting subtest: perf [110.842339] Starting dynamic subtest: engine_cs [115.140566] Dynamic subtest engine_cs: SUCCESS (4.301s) [115.149175] Starting dynamic subtest: request [122.365561] Dynamic subtest request: SUCCESS (7.223s) [122.374613] Starting dynamic subtest: migrate [126.708424] Dynamic subtest migrate: SUCCESS (4.341s) [126.716844] Starting dynamic subtest: region [132.481269] Dynamic subtest region: SUCCESS (5.771s) [132.484335] Subtest perf: SUCCESS (21.640s) [132.513478] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true [132.516671] [020/132] (888s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5) [134.023785] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5 [134.026122] Starting dynamic subtest: pipe-A [134.046626] Dynamic subtest pipe-A: SKIP (0.020s) [134.055066] Starting dynamic subtest: pipe-B [134.085848] Dynamic subtest pipe-B: SKIP (0.037s) [134.094138] Starting dynamic subtest: pipe-C [134.123680] Dynamic subtest pipe-C: SKIP (0.036s) [134.131922] Starting dynamic subtest: pipe-D [134.157083] Dynamic subtest pipe-D: SKIP (0.036s) [134.161467] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.131s) [134.257424] [FACT kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)] new: kernel.kmod_is_loaded.i915: true [134.260872] [021/132] (886s left) perf_pmu (busy-hang) [134.307614] Starting subtest: busy-hang [134.309968] Starting dynamic subtest: rcs0 [135.517044] Dynamic subtest rcs0: SUCCESS (1.208s) [135.528697] Starting dynamic subtest: bcs0 [136.676873] Dynamic subtest bcs0: SUCCESS (1.159s) [136.687535] Starting dynamic subtest: vcs0 [138.455682] Dynamic subtest vcs0: SUCCESS (1.777s) [138.465618] Starting dynamic subtest: vcs1 [140.436057] Dynamic subtest vcs1: SUCCESS (1.979s) [140.446869] Starting dynamic subtest: vecs0 [142.417159] Dynamic subtest vecs0: SUCCESS (1.980s) [142.426069] Starting dynamic subtest: ccs0 [143.587051] Dynamic subtest ccs0: SUCCESS (1.166s) [143.589048] Subtest busy-hang: SUCCESS (9.277s) [143.700071] [022/132] (877s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf) [143.817917] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf [143.820328] Starting dynamic subtest: pipe-A-eDP-1 [143.917076] Dynamic subtest pipe-A-eDP-1: SKIP (0.104s) [143.925258] Starting dynamic subtest: pipe-B-eDP-1 [145.091726] Dynamic subtest pipe-B-eDP-1: SKIP (1.173s) [145.095959] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.278s) [146.275120] [023/132] (874s left) gem_exec_schedule (independent) [146.358594] Starting subtest: independent [146.360846] Starting dynamic subtest: rcs0 [147.927935] Dynamic subtest rcs0: SUCCESS (1.573s) [147.943640] Starting dynamic subtest: vcs0 [149.918697] Dynamic subtest vcs0: SUCCESS (1.989s) [149.930746] Starting dynamic subtest: vcs1 [151.908494] Dynamic subtest vcs1: SUCCESS (1.989s) [151.920320] Starting dynamic subtest: vecs0 [153.888717] Dynamic subtest vecs0: SUCCESS (1.978s) [153.899635] Starting dynamic subtest: ccs0 [155.926382] Dynamic subtest ccs0: SUCCESS (2.036s) [155.929341] Subtest independent: SUCCESS (9.573s) [156.254948] [024/132] (865s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt) [156.354445] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt [163.922318] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.569s) [164.055234] [025/132] (857s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [164.160433] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip [164.164946] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s) [164.254165] [026/132] (857s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions) [164.385660] Starting subtest: cursorB-vs-flipA-atomic-transitions [164.390257] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s) [164.530329] [027/132] (856s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled) [164.594345] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled [164.698602] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.104s) [164.786342] [028/132] (856s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt) [164.880416] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt [164.884782] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [164.983592] [029/132] (856s left) i915_pm_rps (min-max-config-idle) [165.053485] Starting subtest: min-max-config-idle [165.058164] Subtest min-max-config-idle: SKIP (0.001s) [165.126824] [030/132] (856s left) kms_chamelium_frames (hdmi-cmp-planar-formats) [165.518026] Subtest hdmi-cmp-planar-formats: SKIP (0.000s) [166.296599] [031/132] (855s left) gem_mmap_wc (write-cpu-read-wc-unflushed) [166.356240] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s) [166.417042] [032/132] (855s left) gem_lmem_swapping (verify-ccs) [166.463293] Subtest verify-ccs: SKIP (0.000s) [166.502524] [033/132] (855s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render) [166.597532] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render [166.601872] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [166.688979] [034/132] (854s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size) [166.802081] Starting subtest: basic-busy-flip-before-cursor-varying-size [166.806366] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s) [166.943576] [035/132] (854s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu) [167.037178] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu [167.041163] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [167.146742] [036/132] (854s left) kms_3d (basic) [167.199696] Starting subtest: basic [169.209527] Subtest basic: SUCCESS (2.011s) [169.688285] [037/132] (852s left) syncobj_basic (bad-destroy-pad) [169.747919] Starting subtest: bad-destroy-pad [169.750313] Subtest bad-destroy-pad: SUCCESS (0.000s) [169.849106] [038/132] (851s left) gem_create (create-ext-cpu-access-big) [170.007950] Starting subtest: create-ext-cpu-access-big [170.012982] Subtest create-ext-cpu-access-big: SKIP (0.001s) [170.093814] [039/132] (851s left) syncobj_wait (reset-signaled) [170.142825] Starting subtest: reset-signaled [170.144971] Subtest reset-signaled: SUCCESS (0.000s) [170.235330] [040/132] (851s left) kms_dsc (dsc-with-output-formats) [170.318770] Starting subtest: dsc-with-output-formats [170.339748] Subtest dsc-with-output-formats: SKIP (0.001s) [170.387858] [041/132] (851s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt) [170.490628] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt [170.495043] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [170.583832] [042/132] (851s left) kms_flip (2x-blocking-wf_vblank) [170.684071] Starting subtest: 2x-blocking-wf_vblank [170.693315] Subtest 2x-blocking-wf_vblank: SKIP (0.011s) [170.772091] [043/132] (851s left) kms_rotation_crc (sprite-rotation-90) [170.855284] Starting subtest: sprite-rotation-90 [170.859786] Subtest sprite-rotation-90: SKIP (0.001s) [170.926100] [044/132] (851s left) kms_psr (fbc-pr-cursor-blt) [171.015423] Starting subtest: fbc-pr-cursor-blt [171.019626] Subtest fbc-pr-cursor-blt: SKIP (0.000s) [171.082717] [045/132] (851s left) perf (invalid-oa-exponent) [171.196549] Starting subtest: invalid-oa-exponent [171.209582] Subtest invalid-oa-exponent: SUCCESS (0.014s) [171.249328] [046/132] (850s left) gem_flink_race (flink_name) [171.282988] Starting subtest: flink_name [176.675146] Subtest flink_name: SUCCESS (5.384s) [176.791474] [047/132] (845s left) sw_sync (sync_busy) [176.829614] Starting subtest: sync_busy [176.831959] Subtest sync_busy: SUCCESS (0.002s) [176.878480] [048/132] (845s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs) [176.967395] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs [176.971999] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s) [178.051105] [049/132] (844s left) gem_sync (basic-many-each) [178.132302] Starting subtest: basic-many-each [180.408729] Subtest basic-many-each: SUCCESS (2.287s) [180.598379] [050/132] (841s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs) [180.661762] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs [180.666509] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s) [180.843924] [051/132] (841s left) gem_lmem_swapping (heavy-verify-multi-ccs) [180.883484] Subtest heavy-verify-multi-ccs: SKIP (0.000s) [180.931100] [052/132] (841s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling) [181.021849] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling [181.026278] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.000s) [181.093414] [053/132] (841s left) kms_properties (connector-properties-atomic) [181.191207] Starting subtest: connector-properties-atomic [181.193241] Starting dynamic subtest: pipe-A-eDP-1 [189.319052] Dynamic subtest pipe-A-eDP-1: SUCCESS (8.126s) [189.327988] Starting dynamic subtest: pipe-None-DP-1 [189.332653] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s) [189.342725] Starting dynamic subtest: pipe-None-HDMI-A-1 [189.347123] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s) [189.355214] Starting dynamic subtest: pipe-None-DP-2 [189.359115] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s) [189.366846] Starting dynamic subtest: pipe-None-HDMI-A-2 [189.370700] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s) [189.378624] Starting dynamic subtest: pipe-None-DP-3 [189.383973] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s) [189.394876] Starting dynamic subtest: pipe-None-DP-4 [189.399739] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s) [189.402168] Subtest connector-properties-atomic: SUCCESS (8.137s) [190.138579] [054/132] (832s left) api_intel_bb (render) [190.195860] Starting subtest: render [190.198062] Starting dynamic subtest: render-none-512 [190.296619] Dynamic subtest render-none-512: SUCCESS (0.101s) [190.306180] Starting dynamic subtest: render-none-1024 [190.675346] Dynamic subtest render-none-1024: SUCCESS (0.376s) [190.684795] Starting dynamic subtest: render-x-512 [190.759586] Dynamic subtest render-x-512: SUCCESS (0.084s) [190.771020] Starting dynamic subtest: render-x-1024 [191.106597] Dynamic subtest render-x-1024: SUCCESS (0.345s) [191.116132] Starting dynamic subtest: render-y-512 [191.190977] Dynamic subtest render-y-512: SUCCESS (0.085s) [191.202645] Starting dynamic subtest: render-y-1024 [191.795273] Dynamic subtest render-y-1024: SUCCESS (0.602s) [191.797963] Subtest render: SUCCESS (1.600s) [191.904891] [055/132] (830s left) kms_psr2_sf (pr-plane-move-sf-dmg-area) [192.006079] Starting subtest: pr-plane-move-sf-dmg-area [192.010253] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s) [192.087379] [056/132] (830s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs) [192.178165] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs [192.180390] Starting dynamic subtest: pipe-A-eDP-1 [192.202278] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [192.211535] Starting dynamic subtest: pipe-B-eDP-1 [192.232229] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [192.240845] Starting dynamic subtest: pipe-C-eDP-1 [192.262506] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [192.270716] Starting dynamic subtest: pipe-D-eDP-1 [192.294095] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [192.298498] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.005s) [194.450761] [057/132] (828s left) kms_cursor_legacy (cursora-vs-flipb-atomic) [194.567366] Starting subtest: cursorA-vs-flipB-atomic [194.571682] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s) [194.722450] [058/132] (827s left) i915_hangman (hangcheck-unterminated) [194.781695] Starting subtest: hangcheck-unterminated [204.853696] Subtest hangcheck-unterminated: SUCCESS (10.070s) [204.986388] [059/132] (817s left) perf (unprivileged-single-ctx-counters) [205.080307] Starting subtest: unprivileged-single-ctx-counters [205.084867] Subtest unprivileged-single-ctx-counters: SKIP (0.000s) [205.121766] [060/132] (817s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen) [205.241203] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen [205.245169] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [205.336866] [061/132] (817s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip) [205.431961] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip [205.436447] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s) [205.528770] [062/132] (817s left) kms_sequence (get-forked-busy) [205.614076] Starting subtest: get-forked-busy [205.615935] Starting dynamic subtest: pipe-A-eDP-1 [207.541037] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.925s) [207.552459] Starting dynamic subtest: pipe-B-eDP-1 [210.109246] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.567s) [210.118603] Starting dynamic subtest: pipe-C-eDP-1 [212.685507] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.577s) [212.694937] Starting dynamic subtest: pipe-D-eDP-1 [215.290098] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.601s) [215.292430] Subtest get-forked-busy: SUCCESS (9.676s) [216.155022] [063/132] (806s left) gem_exec_fence (syncobj-timeline-invalid-flags) [216.710695] Starting subtest: syncobj-timeline-invalid-flags [216.713768] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s) [217.948197] [FACT gem_exec_fence (syncobj-timeline-invalid-flags)] new: kernel.kmod_is_loaded.vgem: true [217.951905] [064/132] (804s left) gem_pxp (create-regular-context-1) [218.072059] Starting subtest: create-regular-context-1 [218.074745] Subtest create-regular-context-1: SUCCESS (0.002s) [218.195972] [065/132] (804s left) kms_concurrent (multi-plane-atomic-lowres) [218.289867] Starting subtest: multi-plane-atomic-lowres [218.292161] Starting dynamic subtest: pipe-A-eDP-1 [218.767489] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.477s) [218.777070] Starting dynamic subtest: pipe-B-eDP-1 [220.062568] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.292s) [220.071566] Starting dynamic subtest: pipe-C-eDP-1 [221.343257] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.281s) [221.353068] Starting dynamic subtest: pipe-D-eDP-1 [222.544470] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.198s) [222.546743] Subtest multi-plane-atomic-lowres: SUCCESS (4.254s) [223.339244] [066/132] (799s left) gem_userptr_blits (unsync-unmap) [223.420576] Subtest unsync-unmap: SKIP (0.000s) [223.558223] [067/132] (799s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted) [223.617109] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted [223.619301] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s) [223.718735] [068/132] (799s left) kms_flip (absolute-wf_vblank-interruptible) [223.807190] Starting subtest: absolute-wf_vblank-interruptible [223.809476] Starting dynamic subtest: A-eDP1 [232.562699] Dynamic subtest A-eDP1: SUCCESS (8.754s) [232.572640] Starting dynamic subtest: B-eDP1 [241.269582] Dynamic subtest B-eDP1: SUCCESS (8.705s) [241.284473] Starting dynamic subtest: C-eDP1 [249.954507] Dynamic subtest C-eDP1: SUCCESS (8.681s) [249.966879] Starting dynamic subtest: D-eDP1 [258.656496] Dynamic subtest D-eDP1: SUCCESS (8.699s) [258.658887] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.851s) [259.830290] [069/132] (763s left) gem_close (basic) [259.894790] Starting subtest: basic [259.897102] Subtest basic: SUCCESS (0.000s) [260.002497] [070/132] (763s left) core_sysfs (read-all-entries) [260.057734] Starting subtest: read-all-entries [260.064823] Subtest read-all-entries: SUCCESS (0.009s) [260.172025] [071/132] (762s left) kms_plane_multiple (tiling-4) [260.266075] Starting subtest: tiling-4 [260.268376] Starting dynamic subtest: pipe-A-eDP-1 [264.060191] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.795s) [264.069675] Starting dynamic subtest: pipe-B-eDP-1 [268.668680] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.605s) [268.678646] Starting dynamic subtest: pipe-C-eDP-1 [273.271325] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.602s) [273.280599] Starting dynamic subtest: pipe-D-eDP-1 [277.858949] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.585s) [277.861288] Subtest tiling-4: SUCCESS (17.592s) [278.736306] [072/132] (744s left) kms_cursor_crc (cursor-size-change) [278.848124] Starting subtest: cursor-size-change [278.849974] Starting dynamic subtest: pipe-A-eDP-1 [279.634383] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.785s) [279.643498] Starting dynamic subtest: pipe-D-eDP-1 [281.060222] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.424s) [281.062550] Subtest cursor-size-change: SUCCESS (2.212s) [281.934264] [073/132] (741s left) api_intel_allocator (reopen-fork) [281.997527] Starting subtest: reopen-fork [285.324408] Subtest reopen-fork: SUCCESS (3.328s) [285.416737] [074/132] (737s left) gem_exec_params (sol-reset-not-gen7) [285.479242] Starting subtest: sol-reset-not-gen7 [285.484216] Subtest sol-reset-not-gen7: SUCCESS (0.003s) [285.598370] [075/132] (737s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu) [285.710678] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu [289.938467] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.231s) [291.139535] [076/132] (732s left) syncobj_timeline (transfer-timeline-point) [291.194196] Starting subtest: transfer-timeline-point [291.196658] Subtest transfer-timeline-point: SUCCESS (0.000s) [291.290036] [077/132] (732s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt) [291.394316] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt [291.398763] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [291.491607] [078/132] (731s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted) [291.553443] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted [291.555456] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s) [291.649623] [079/132] (731s left) gem_mmap_offset (clear-via-pagefault) [291.709785] Starting subtest: clear-via-pagefault [291.711837] Starting dynamic subtest: smem0 [325.301954] Dynamic subtest smem0: SUCCESS (33.587s) [325.304503] Subtest clear-via-pagefault: SUCCESS (33.589s) [325.428149] [080/132] (698s left) syncobj_timeline (invalid-query-illegal-handle) [325.485537] Starting subtest: invalid-query-illegal-handle [325.487787] Subtest invalid-query-illegal-handle: SUCCESS (0.000s) [325.588019] [081/132] (697s left) kms_atomic (plane-invalid-params) [325.677956] Starting subtest: plane-invalid-params [325.680292] Starting dynamic subtest: pipe-A-eDP-1 [326.068742] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.388s) [326.070661] Subtest plane-invalid-params: SUCCESS (0.390s) [326.935786] [082/132] (696s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs) [327.027044] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs [327.029192] Starting dynamic subtest: pipe-A-eDP-1 [327.051162] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.023s) [327.060675] Starting dynamic subtest: pipe-B-eDP-1 [327.082276] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.023s) [327.091828] Starting dynamic subtest: pipe-C-eDP-1 [327.112303] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.023s) [327.121432] Starting dynamic subtest: pipe-D-eDP-1 [327.140592] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.023s) [327.142730] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.098s) [329.327530] [083/132] (694s left) gem_userptr_blits (stress-mm-invalidate-close-overlap) [329.399172] Starting subtest: stress-mm-invalidate-close-overlap [331.546266] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s) [331.678129] [084/132] (691s left) kms_fbcon_fbt (psr) [331.731987] Starting subtest: psr [339.212969] Subtest psr: SUCCESS (7.476s) [339.289950] [085/132] (684s left) kms_color (invalid-gamma-lut-sizes) [339.381967] Starting subtest: invalid-gamma-lut-sizes [339.384161] Starting dynamic subtest: pipe-A [339.667045] Dynamic subtest pipe-A: SUCCESS (0.285s) [339.678638] Starting dynamic subtest: pipe-B [339.681052] Dynamic subtest pipe-B: SUCCESS (0.000s) [339.691731] Starting dynamic subtest: pipe-C [339.694205] Dynamic subtest pipe-C: SUCCESS (0.000s) [339.703186] Starting dynamic subtest: pipe-D [339.705072] Dynamic subtest pipe-D: SUCCESS (0.000s) [339.706946] Subtest invalid-gamma-lut-sizes: SUCCESS (0.289s) [340.532487] [086/132] (683s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu) [340.638483] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu [340.642863] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [340.733095] [087/132] (683s left) gem_exec_balancer (full) [340.798809] Starting subtest: full [345.753791] Subtest full: SUCCESS (4.957s) [346.081042] [088/132] (677s left) gem_pxp (regular-baseline-src-copy-readible) [346.141144] Starting subtest: regular-baseline-src-copy-readible [346.207025] Subtest regular-baseline-src-copy-readible: SUCCESS (0.068s) [346.319243] [089/132] (677s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary) [346.424561] Starting subtest: fbc-shrfb-scaledprimary [349.370519] Subtest fbc-shrfb-scaledprimary: SUCCESS (2.949s) [350.535126] [090/132] (673s left) kms_psr (psr-dpms) [350.627783] Starting subtest: psr-dpms [350.630469] Starting dynamic subtest: eDP-1 [353.599429] Dynamic subtest eDP-1: SUCCESS (2.968s) [353.601736] Subtest psr-dpms: SUCCESS (2.970s) [354.433632] [091/132] (669s left) gem_exec_big (single) [354.493335] Starting subtest: single [356.939043] Subtest single: SUCCESS (2.445s) [357.163520] [092/132] (666s left) kms_prime (basic-crc-hybrid) [357.304791] Subtest basic-crc-hybrid: SKIP (0.000s) [357.411177] [093/132] (666s left) gen9_exec_parse (allowed-single) [357.473292] Subtest allowed-single: SKIP (0.000s) [357.544260] [094/132] (666s left) gem_softpin (overlap) [357.608505] Starting subtest: overlap [358.593761] Subtest overlap: SUCCESS (0.986s) [358.702838] [095/132] (665s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs) [358.790466] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs [358.792554] Starting dynamic subtest: pipe-A-eDP-1 [359.539788] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.741s) [359.550168] Starting dynamic subtest: pipe-B-eDP-1 [361.329912] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.788s) [361.340125] Starting dynamic subtest: pipe-C-eDP-1 [363.131616] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.801s) [363.142300] Starting dynamic subtest: pipe-D-eDP-1 [364.924472] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.792s) [364.926675] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.127s) [366.134550] [096/132] (658s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot) [366.270533] Starting subtest: modeset-atomic-cursor-hotspot [366.275163] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s) [366.426549] [097/132] (657s left) gem_exec_whisper (basic-contexts-forked) [366.491489] Starting subtest: basic-contexts-forked [391.452423] Subtest basic-contexts-forked: SUCCESS (24.962s) [391.654591] [098/132] (632s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt) [391.765896] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt [398.464025] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.703s) [398.591718] [099/132] (625s left) gem_exec_reloc (basic-active) [398.654988] Subtest basic-active: SKIP (0.000s) [398.731061] [100/132] (625s left) syncobj_wait (multi-wait-for-submit-submitted) [398.792792] Starting subtest: multi-wait-for-submit-submitted [398.897900] Subtest multi-wait-for-submit-submitted: SUCCESS (0.105s) [398.976967] [101/132] (625s left) gem_mmap_wc (copy) [399.027489] Subtest copy: SKIP (0.000s) [399.099576] [102/132] (625s left) gem_ctx_persistence (engines-hang) [399.156175] Starting subtest: engines-hang [399.158596] Starting dynamic subtest: rcs0 [399.252993] Dynamic subtest rcs0: SUCCESS (0.096s) [399.266314] Starting dynamic subtest: bcs0 [399.349939] Dynamic subtest bcs0: SUCCESS (0.095s) [399.362607] Starting dynamic subtest: vcs0 [399.447822] Dynamic subtest vcs0: SUCCESS (0.096s) [399.458965] Starting dynamic subtest: vcs1 [399.526553] Dynamic subtest vcs1: SUCCESS (0.076s) [399.537505] Starting dynamic subtest: vecs0 [399.644537] Dynamic subtest vecs0: SUCCESS (0.116s) [399.656510] Starting dynamic subtest: ccs0 [399.749752] Dynamic subtest ccs0: SUCCESS (0.103s) [399.752181] Subtest engines-hang: SUCCESS (0.594s) [399.842824] [103/132] (624s left) kms_chamelium_hpd (dp-hpd-fast) [400.228083] Subtest dp-hpd-fast: SKIP (0.000s) [401.000759] [104/132] (623s left) gem_exec_schedule (u-lateslice) [401.091075] Starting subtest: u-lateslice [401.093071] Starting dynamic subtest: rcs0 [401.104699] Dynamic subtest rcs0: SUCCESS (0.022s) [401.117935] Starting dynamic subtest: bcs0 [401.123566] Dynamic subtest bcs0: SUCCESS (0.018s) [401.133147] Starting dynamic subtest: vcs0 [401.141163] Dynamic subtest vcs0: SUCCESS (0.016s) [401.150699] Starting dynamic subtest: vcs1 [401.159206] Dynamic subtest vcs1: SUCCESS (0.017s) [401.171714] Starting dynamic subtest: vecs0 [401.177333] Dynamic subtest vecs0: SUCCESS (0.017s) [401.186994] Starting dynamic subtest: ccs0 [401.194761] Dynamic subtest ccs0: SUCCESS (0.017s) [401.197044] Subtest u-lateslice: SUCCESS (0.113s) [402.977164] [105/132] (621s left) kms_vblank (ts-continuation-modeset-rpm) [403.077727] Starting subtest: ts-continuation-modeset-rpm [403.079992] Starting dynamic subtest: pipe-A-eDP-1 [405.579833] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.500s) [405.597731] Starting dynamic subtest: pipe-D-eDP-1 [407.769766] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.188s) [407.771942] Subtest ts-continuation-modeset-rpm: SUCCESS (4.692s) [408.623908] [106/132] (615s left) kms_psr (psr2-dpms) [408.725723] Starting subtest: psr2-dpms [408.727898] Starting dynamic subtest: eDP-1 [411.685339] Dynamic subtest eDP-1: SUCCESS (2.956s) [411.687561] Subtest psr2-dpms: SUCCESS (2.957s) [412.530606] [107/132] (612s left) gem_softpin (evict-prime-sanity-check) [412.592795] Starting subtest: evict-prime-sanity-check [412.595094] Starting dynamic subtest: rcs0 [413.731984] Dynamic subtest rcs0: SUCCESS (1.138s) [413.744737] Starting dynamic subtest: bcs0 [414.844849] Dynamic subtest bcs0: SUCCESS (1.111s) [414.857201] Starting dynamic subtest: vcs0 [416.852373] Dynamic subtest vcs0: SUCCESS (2.005s) [416.864915] Starting dynamic subtest: vcs1 [418.896759] Dynamic subtest vcs1: SUCCESS (2.042s) [418.909772] Starting dynamic subtest: vecs0 [420.878676] Dynamic subtest vecs0: SUCCESS (1.979s) [420.891208] Starting dynamic subtest: ccs0 [421.994775] Dynamic subtest ccs0: SUCCESS (1.115s) [422.007113] Starting dynamic subtest: all [423.119829] Dynamic subtest all: SUCCESS (1.123s) [423.122321] Subtest evict-prime-sanity-check: SUCCESS (10.528s) [423.204173] [108/132] (601s left) gem_ctx_shared (create-shared-gtt) [423.256393] Starting subtest: create-shared-gtt [425.413295] Subtest create-shared-gtt: SUCCESS (2.155s) [425.782375] [109/132] (598s left) gem_pipe_control_store_loop (reused-buffer) [425.842363] Starting subtest: reused-buffer [428.000073] Subtest reused-buffer: SUCCESS (2.156s) [428.120942] [110/132] (596s left) gem_blits (basic) [428.191900] Starting subtest: basic [430.441427] Subtest basic: SUCCESS (2.248s) [430.564220] [111/132] (594s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [430.661075] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [430.665203] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [430.766311] [112/132] (594s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format) [430.850220] Starting subtest: plane-downscale-factor-0-5-with-pixel-format [430.852424] Starting dynamic subtest: pipe-A [430.869996] Dynamic subtest pipe-A: SKIP (0.017s) [430.884108] Starting dynamic subtest: pipe-B [430.900993] Dynamic subtest pipe-B: SKIP (0.030s) [430.910567] Starting dynamic subtest: pipe-C [430.932990] Dynamic subtest pipe-C: SKIP (0.031s) [430.942579] Starting dynamic subtest: pipe-D [430.965630] Dynamic subtest pipe-D: SKIP (0.031s) [430.969491] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.111s) [431.063313] [113/132] (593s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc) [431.164249] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc [431.168437] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [431.270092] [114/132] (593s left) kms_pm_rpm (dpms-mode-unset-lpsp) [433.030670] Starting subtest: dpms-mode-unset-lpsp [437.078729] Subtest dpms-mode-unset-lpsp: SUCCESS (4.051s) [437.455033] [115/132] (587s left) kms_big_fb (4-tiled-32bpp-rotate-90) [437.559118] Starting subtest: 4-tiled-32bpp-rotate-90 [437.578710] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.019s) [437.697214] [116/132] (587s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled) [437.746834] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled [437.749123] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s) [437.841712] [117/132] (587s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc) [437.940234] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc [437.942529] Starting dynamic subtest: pipe-A-eDP-1 [437.962529] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [437.978576] Starting dynamic subtest: pipe-B-eDP-1 [437.999148] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [438.008626] Starting dynamic subtest: pipe-C-eDP-1 [438.028414] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [438.037727] Starting dynamic subtest: pipe-D-eDP-1 [438.057407] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [438.059623] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s) [440.227333] [118/132] (584s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [440.331649] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu [440.335709] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [440.430292] [119/132] (584s left) kms_lease (simple-lease) [440.534772] Starting subtest: simple-lease [440.537042] Starting dynamic subtest: pipe-A-eDP-1 [441.033510] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.497s) [441.043794] Starting dynamic subtest: pipe-B-eDP-1 [442.439127] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.404s) [442.449567] Starting dynamic subtest: pipe-C-eDP-1 [443.833421] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.394s) [443.843922] Starting dynamic subtest: pipe-D-eDP-1 [445.332393] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.495s) [445.334564] Subtest simple-lease: SUCCESS (4.798s) [446.132019] [120/132] (579s left) kms_addfb_basic (unused-handle) [446.190860] Starting subtest: unused-handle [446.192711] Subtest unused-handle: SUCCESS (0.000s) [446.333206] [121/132] (578s left) gen9_exec_parse (unaligned-jump) [446.391204] Subtest unaligned-jump: SKIP (0.000s) [446.468200] [122/132] (578s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling) [446.551079] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling [446.553338] Starting dynamic subtest: pipe-A-default-mode [447.761513] Dynamic subtest pipe-A-default-mode: SKIP (1.209s) [447.765971] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.210s) [447.891671] [123/132] (577s left) kms_getfb (getfb2-accept-nv12) [447.986728] Starting subtest: getfb2-accept-nv12 [447.988869] Subtest getfb2-accept-nv12: SUCCESS (0.001s) [448.084087] [124/132] (577s left) kms_cursor_crc (cursor-offscreen-128x128) [448.301939] Starting subtest: cursor-offscreen-128x128 [448.304157] Starting dynamic subtest: pipe-A-eDP-1 [450.237464] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.932s) [450.264583] Starting dynamic subtest: pipe-D-eDP-1 [452.906692] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.647s) [452.908943] Subtest cursor-offscreen-128x128: SUCCESS (4.605s) [453.736189] [125/132] (571s left) kms_addfb_basic (small-bo) [453.830861] Starting subtest: small-bo [453.833046] Subtest small-bo: SUCCESS (0.000s) [453.920566] [126/132] (571s left) kms_psr (pr-sprite-plane-move) [454.027041] Starting subtest: pr-sprite-plane-move [454.031410] Subtest pr-sprite-plane-move: SKIP (0.000s) [454.100615] [127/132] (571s left) prime_vgem (busy) [454.187958] Starting subtest: busy [454.190374] Starting dynamic subtest: rcs0 [454.270412] Dynamic subtest rcs0: SUCCESS (0.082s) [454.282099] Starting dynamic subtest: bcs0 [454.317852] Dynamic subtest bcs0: SUCCESS (0.046s) [454.327583] Starting dynamic subtest: vcs0 [454.366783] Dynamic subtest vcs0: SUCCESS (0.048s) [454.376694] Starting dynamic subtest: vcs1 [454.413375] Dynamic subtest vcs1: SUCCESS (0.045s) [454.423245] Starting dynamic subtest: vecs0 [454.459197] Dynamic subtest vecs0: SUCCESS (0.045s) [454.468983] Starting dynamic subtest: ccs0 [454.506159] Dynamic subtest ccs0: SUCCESS (0.046s) [454.508413] Subtest busy: SUCCESS (0.319s) [454.636461] [128/132] (570s left) kms_plane_alpha_blend (coverage-7efc) [454.730536] Starting subtest: coverage-7efc [455.044717] Starting dynamic subtest: pipe-A-eDP-1 [455.614106] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.568s) [455.644661] Starting dynamic subtest: pipe-D-eDP-1 [456.907755] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.271s) [456.910341] Subtest coverage-7efc: SUCCESS (2.178s) [457.714405] [129/132] (567s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render) [457.811389] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render [464.455108] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.646s) [464.570905] [130/132] (561s left) sysfs_heartbeat_interval (nopreempt) [464.640286] Starting subtest: nopreempt [464.642685] Starting dynamic subtest: vecs0 [473.873465] Dynamic subtest vecs0: SUCCESS (9.230s) [473.885399] Starting dynamic subtest: ccs0 [477.858860] Dynamic subtest ccs0: SUCCESS (3.985s) [477.875893] Starting dynamic subtest: vcs0 [487.889133] Dynamic subtest vcs0: SUCCESS (10.030s) [487.901557] Starting dynamic subtest: bcs0 [491.854767] Dynamic subtest bcs0: SUCCESS (3.963s) [491.867240] Starting dynamic subtest: rcs0 [495.961596] Dynamic subtest rcs0: SUCCESS (4.104s) [495.974467] Starting dynamic subtest: vcs1 [505.943634] Dynamic subtest vcs1: SUCCESS (9.977s) [505.946218] Subtest nopreempt: SUCCESS (41.300s) [506.021201] [131/132] (519s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [506.123035] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip [506.825361] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.703s) [506.990060] [132/132] (518s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary) [507.088344] Starting subtest: psr-indfb-scaledprimary [512.786088] Subtest psr-indfb-scaledprimary: SUCCESS (5.699s) [512.922309] Closing watchdogs results: parsing output: 0/ for test: kms_big_fb results: parsing output: 1/ for test: gem_fenced_exec_thrash results: parsing output: 2/ for test: gem_pread results: parsing output: 3/ for test: kms_setmode results: parsing output: 4/ for test: kms_cursor_legacy results: parsing output: 5/ for test: kms_psr results: parsing output: 6/ for test: perf_pmu results: parsing output: 7/ for test: kms_big_fb results: parsing output: 8/ for test: kms_flip results: parsing output: 9/ for test: kms_invalid_mode results: parsing output: 10/ for test: kms_psr results: parsing output: 11/ for test: kms_cursor_legacy results: parsing output: 12/ for test: kms_plane results: parsing output: 13/ for test: gen7_exec_parse results: parsing output: 14/ for test: gem_exec_reloc results: parsing output: 15/ for test: kms_cursor_crc results: parsing output: 16/ for test: kms_rotation_crc results: parsing output: 17/ for test: kms_big_fb results: parsing output: 18/ for test: i915_selftest results: parsing output: 19/ for test: kms_plane_scaling results: parsing output: 20/ for test: perf_pmu results: parsing output: 21/ for test: kms_psr2_sf results: parsing output: 22/ for test: gem_exec_schedule results: parsing output: 23/ for test: kms_frontbuffer_tracking results: parsing output: 24/ for test: kms_big_fb results: parsing output: 25/ for test: kms_cursor_legacy results: parsing output: 26/ for test: syncobj_timeline results: parsing output: 27/ for test: kms_frontbuffer_tracking results: parsing output: 28/ for test: i915_pm_rps results: parsing output: 29/ for test: kms_chamelium_frames results: parsing output: 30/ for test: gem_mmap_wc results: parsing output: 31/ for test: gem_lmem_swapping results: parsing output: 32/ for test: kms_frontbuffer_tracking results: parsing output: 33/ for test: kms_cursor_legacy results: parsing output: 34/ for test: kms_frontbuffer_tracking results: parsing output: 35/ for test: kms_3d results: parsing output: 36/ for test: syncobj_basic results: parsing output: 37/ for test: gem_create results: parsing output: 38/ for test: syncobj_wait results: parsing output: 39/ for test: kms_dsc results: parsing output: 40/ for test: kms_frontbuffer_tracking results: parsing output: 41/ for test: kms_flip results: parsing output: 42/ for test: kms_rotation_crc results: parsing output: 43/ for test: kms_psr results: parsing output: 44/ for test: perf results: parsing output: 45/ for test: gem_flink_race results: parsing output: 46/ for test: sw_sync results: parsing output: 47/ for test: kms_ccs results: parsing output: 48/ for test: gem_sync results: parsing output: 49/ for test: gem_render_copy results: parsing output: 50/ for test: gem_lmem_swapping results: parsing output: 51/ for test: kms_flip_scaled_crc results: parsing output: 52/ for test: kms_properties results: parsing output: 53/ for test: api_intel_bb results: parsing output: 54/ for test: kms_psr2_sf results: parsing output: 55/ for test: kms_ccs results: parsing output: 56/ for test: kms_cursor_legacy results: parsing output: 57/ for test: i915_hangman results: parsing output: 58/ for test: perf results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: kms_big_fb results: parsing output: 61/ for test: kms_sequence results: parsing output: 62/ for test: gem_exec_fence results: parsing output: 63/ for test: gem_pxp results: parsing output: 64/ for test: kms_concurrent results: parsing output: 65/ for test: gem_userptr_blits results: parsing output: 66/ for test: syncobj_timeline results: parsing output: 67/ for test: kms_flip results: parsing output: 68/ for test: gem_close results: parsing output: 69/ for test: core_sysfs results: parsing output: 70/ for test: kms_plane_multiple results: parsing output: 71/ for test: kms_cursor_crc results: parsing output: 72/ for test: api_intel_allocator results: parsing output: 73/ for test: gem_exec_params results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: syncobj_timeline results: parsing output: 76/ for test: kms_frontbuffer_tracking results: parsing output: 77/ for test: syncobj_timeline results: parsing output: 78/ for test: gem_mmap_offset results: parsing output: 79/ for test: syncobj_timeline results: parsing output: 80/ for test: kms_atomic results: parsing output: 81/ for test: kms_ccs results: parsing output: 82/ for test: gem_userptr_blits results: parsing output: 83/ for test: kms_fbcon_fbt results: parsing output: 84/ for test: kms_color results: parsing output: 85/ for test: kms_frontbuffer_tracking results: parsing output: 86/ for test: gem_exec_balancer results: parsing output: 87/ for test: gem_pxp results: parsing output: 88/ for test: kms_frontbuffer_tracking results: parsing output: 89/ for test: kms_psr results: parsing output: 90/ for test: gem_exec_big results: parsing output: 91/ for test: kms_prime results: parsing output: 92/ for test: gen9_exec_parse results: parsing output: 93/ for test: gem_softpin results: parsing output: 94/ for test: kms_ccs results: parsing output: 95/ for test: kms_cursor_legacy results: parsing output: 96/ for test: gem_exec_whisper results: parsing output: 97/ for test: kms_frontbuffer_tracking results: parsing output: 98/ for test: gem_exec_reloc results: parsing output: 99/ for test: syncobj_wait results: parsing output: 100/ for test: gem_mmap_wc results: parsing output: 101/ for test: gem_ctx_persistence results: parsing output: 102/ for test: kms_chamelium_hpd results: parsing output: 103/ for test: gem_exec_schedule results: parsing output: 104/ for test: kms_vblank results: parsing output: 105/ for test: kms_psr results: parsing output: 106/ for test: gem_softpin results: parsing output: 107/ for test: gem_ctx_shared results: parsing output: 108/ for test: gem_pipe_control_store_loop results: parsing output: 109/ for test: gem_blits results: parsing output: 110/ for test: kms_frontbuffer_tracking results: parsing output: 111/ for test: kms_plane_scaling results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: kms_pm_rpm results: parsing output: 114/ for test: kms_big_fb results: parsing output: 115/ for test: syncobj_wait results: parsing output: 116/ for test: kms_ccs results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: kms_lease results: parsing output: 119/ for test: kms_addfb_basic results: parsing output: 120/ for test: gen9_exec_parse results: parsing output: 121/ for test: kms_flip_scaled_crc results: parsing output: 122/ for test: kms_getfb results: parsing output: 123/ for test: kms_cursor_crc results: parsing output: 124/ for test: kms_addfb_basic results: parsing output: 125/ for test: kms_psr results: parsing output: 126/ for test: prime_vgem results: parsing output: 127/ for test: kms_plane_alpha_blend results: parsing output: 128/ for test: kms_frontbuffer_tracking results: parsing output: 129/ for test: sysfs_heartbeat_interval results: parsing output: 130/ for test: kms_big_fb results: parsing output: 131/ for test: kms_frontbuffer_tracking Done.