[67.928628] Initializing watchdogs [67.928767] /dev/watchdog0 [67.953165] [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] [67.961324] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [67.966393] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [67.969770] [001/133] (960s left) gem_exec_params (rs-invalid) [68.126054] Starting subtest: rs-invalid [68.131050] Subtest rs-invalid: SUCCESS (0.003s) [68.253707] [002/133] (960s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [68.355553] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [69.013515] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.658s) [69.207149] [003/133] (959s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs) [69.304681] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs [69.309242] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s) [70.438606] [004/133] (958s left) gem_mmap_wc (bad-offset) [70.483651] Subtest bad-offset: SKIP (0.000s) [70.541566] [005/133] (958s left) kms_debugfs (display-off-read-all) [70.622711] Starting subtest: display-off-read-all [70.914535] Subtest display-off-read-all: SUCCESS (0.292s) [71.757541] [006/133] (956s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt) [71.868173] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt [71.872395] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [71.992058] [007/133] (956s left) kms_psr (pr-cursor-plane-onoff) [72.095221] Starting subtest: pr-cursor-plane-onoff [72.099374] Subtest pr-cursor-plane-onoff: SKIP (0.000s) [72.163934] [008/133] (956s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc) [72.266788] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc [78.942430] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.676s) [79.051904] [009/133] (949s left) gem_mmap (big-bo) [79.111190] Subtest big-bo: SKIP (0.000s) [79.164964] [010/133] (949s left) gem_close_race (multigpu-basic-threads) [79.225996] Starting subtest: multigpu-basic-threads [79.231477] Subtest multigpu-basic-threads: SKIP (0.000s) [79.449161] [011/133] (949s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite) [79.539148] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite [79.543409] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [79.633381] [012/133] (949s left) syncobj_timeline (wait-zero-handles) [79.689996] Starting subtest: wait-zero-handles [79.692317] Subtest wait-zero-handles: SUCCESS (0.000s) [79.771329] [013/133] (949s left) gem_exec_fence (parallel) [79.946033] Starting subtest: parallel [79.948647] Starting dynamic subtest: rcs0 [82.094939] Dynamic subtest rcs0: SUCCESS (2.149s) [82.103618] Starting dynamic subtest: bcs0 [84.243884] Dynamic subtest bcs0: SUCCESS (2.148s) [84.254369] Starting dynamic subtest: vcs0 [86.398291] Dynamic subtest vcs0: SUCCESS (2.154s) [86.409957] Starting dynamic subtest: vcs1 [88.549713] Dynamic subtest vcs1: SUCCESS (2.151s) [88.559622] Starting dynamic subtest: vecs0 [90.701468] Dynamic subtest vecs0: SUCCESS (2.151s) [90.713346] Starting dynamic subtest: ccs0 [92.854589] Dynamic subtest ccs0: SUCCESS (2.152s) [92.856563] Subtest parallel: SUCCESS (12.908s) [93.993027] [FACT gem_exec_fence (parallel)] new: kernel.kmod_is_loaded.vgem: true [93.996422] [014/133] (934s left) gem_ctx_param (set-priority-range) [94.050649] Starting subtest: set-priority-range [94.064306] Subtest set-priority-range: SUCCESS (0.014s) [94.157191] [015/133] (934s left) i915_drm_fdinfo (virtual-busy-hang) [94.202725] Starting subtest: virtual-busy-hang [94.207246] Subtest virtual-busy-hang: SKIP (0.000s) [94.266675] [016/133] (934s left) i915_pm_rps (engine-order) [94.327735] Starting subtest: engine-order [99.226618] Subtest engine-order: SUCCESS (4.897s) [99.369507] [017/133] (929s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted) [99.424694] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted [99.529285] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.103s) [99.603990] [018/133] (929s left) kms_vblank (ts-continuation-dpms-rpm) [99.716525] Starting subtest: ts-continuation-dpms-rpm [99.718452] Starting dynamic subtest: pipe-A-eDP-1 [102.261715] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.545s) [102.276940] Starting dynamic subtest: pipe-D-eDP-1 [104.511613] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.246s) [104.513952] Subtest ts-continuation-dpms-rpm: SUCCESS (4.795s) [105.385560] [019/133] (923s left) gem_userptr_blits (sd-probe) [105.451446] Starting subtest: sd-probe [105.453764] Subtest sd-probe: SUCCESS (0.000s) [105.583981] [020/133] (923s left) kms_frontbuffer_tracking (psr-slowdraw) [105.689592] Starting subtest: psr-slowdraw [130.911578] Subtest psr-slowdraw: SUCCESS (25.224s) [131.047815] [021/133] (898s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite) [131.142753] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite [140.502300] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.362s) [140.634927] [022/133] (888s left) kms_cursor_edge_walk (64x64-left-edge) [140.738939] Starting subtest: 64x64-left-edge [140.741285] Starting dynamic subtest: pipe-A-eDP-1 [144.225225] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.485s) [144.234065] Starting dynamic subtest: pipe-D-eDP-1 [147.347545] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.121s) [147.349460] Subtest 64x64-left-edge: SUCCESS (6.608s) [148.160131] [023/133] (881s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff) [148.270502] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff [148.274605] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [148.381564] [024/133] (881s left) gem_spin_batch (resubmit-new-all) [148.442412] Starting subtest: resubmit-new-all [148.444811] Starting dynamic subtest: rcs0 [148.455510] Dynamic subtest rcs0: SUCCESS (0.013s) [148.465887] Starting dynamic subtest: bcs0 [148.467772] Dynamic subtest bcs0: SUCCESS (0.009s) [148.475409] Starting dynamic subtest: vcs0 [148.477593] Dynamic subtest vcs0: SUCCESS (0.008s) [148.485319] Starting dynamic subtest: vcs1 [148.487159] Dynamic subtest vcs1: SUCCESS (0.009s) [148.494798] Starting dynamic subtest: vecs0 [148.496967] Dynamic subtest vecs0: SUCCESS (0.010s) [148.504474] Starting dynamic subtest: ccs0 [148.506378] Dynamic subtest ccs0: SUCCESS (0.008s) [148.508279] Subtest resubmit-new-all: SUCCESS (0.058s) [149.949736] [025/133] (879s left) gem_exec_schedule (preempt) [150.030583] Starting subtest: preempt [150.032898] Starting dynamic subtest: rcs0 [150.045141] Dynamic subtest rcs0: SUCCESS (0.022s) [150.056038] Starting dynamic subtest: bcs0 [150.065452] Dynamic subtest bcs0: SUCCESS (0.020s) [150.073699] Starting dynamic subtest: vcs0 [150.085429] Dynamic subtest vcs0: SUCCESS (0.020s) [150.092800] Starting dynamic subtest: vcs1 [150.107033] Dynamic subtest vcs1: SUCCESS (0.021s) [150.114357] Starting dynamic subtest: vecs0 [150.129226] Dynamic subtest vecs0: SUCCESS (0.022s) [150.137219] Starting dynamic subtest: ccs0 [150.152301] Dynamic subtest ccs0: SUCCESS (0.023s) [150.154529] Subtest preempt: SUCCESS (0.130s) [151.965446] [026/133] (877s left) kms_atomic_transition (plane-toggle-modeset-transition) [152.080046] Starting subtest: plane-toggle-modeset-transition [152.082301] Starting dynamic subtest: pipe-A-eDP-1 [164.768793] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.688s) [164.780982] Starting dynamic subtest: pipe-B-eDP-1 [177.161422] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.388s) [177.163849] Subtest plane-toggle-modeset-transition: SUCCESS (25.081s) [177.974412] [027/133] (851s left) kms_flip (flip-vs-suspend-interruptible) [178.066289] Starting subtest: flip-vs-suspend-interruptible [178.068472] Starting dynamic subtest: A-eDP1 [227.025153] Dynamic subtest A-eDP1: SUCCESS (4.569s) [227.039761] Starting dynamic subtest: B-eDP1 [276.037968] Dynamic subtest B-eDP1: SUCCESS (4.508s) [276.047641] Starting dynamic subtest: C-eDP1 [325.051978] Dynamic subtest C-eDP1: SUCCESS (4.486s) [325.061358] Starting dynamic subtest: D-eDP1 [374.039021] Dynamic subtest D-eDP1: SUCCESS (4.468s) [374.041362] Subtest flip-vs-suspend-interruptible: SUCCESS (18.040s) [375.236294] [028/133] (654s left) kms_pipe_crc_basic (disable-crc-after-crtc) [375.333246] Starting subtest: disable-crc-after-crtc [375.335462] Starting dynamic subtest: pipe-A-eDP-1 [376.985492] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.631s) [376.995895] Starting dynamic subtest: pipe-B-eDP-1 [379.294174] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.280s) [379.305545] Starting dynamic subtest: pipe-C-eDP-1 [381.553162] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.242s) [381.564040] Starting dynamic subtest: pipe-D-eDP-1 [383.830477] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.261s) [383.832871] Subtest disable-crc-after-crtc: SUCCESS (8.419s) [384.664495] [029/133] (644s left) vgem_basic (dmabuf-export) [384.711336] Starting subtest: dmabuf-export [384.725322] Subtest dmabuf-export: SUCCESS (0.016s) [384.823057] [030/133] (644s left) gem_lmem_swapping (heavy-multi) [384.866759] Subtest heavy-multi: SKIP (0.000s) [384.918813] [031/133] (644s left) kms_properties (connector-properties-atomic) [385.017360] Starting subtest: connector-properties-atomic [385.019275] Starting dynamic subtest: pipe-A-eDP-1 [392.972326] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.930s) [392.981397] Starting dynamic subtest: pipe-None-DP-1 [392.985628] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s) [392.993883] Starting dynamic subtest: pipe-None-HDMI-A-1 [392.997986] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s) [393.006453] Starting dynamic subtest: pipe-None-DP-2 [393.010445] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s) [393.018439] Starting dynamic subtest: pipe-None-HDMI-A-2 [393.022429] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s) [393.032632] Starting dynamic subtest: pipe-None-DP-3 [393.036988] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s) [393.044971] Starting dynamic subtest: pipe-None-DP-4 [393.049632] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s) [393.051885] Subtest connector-properties-atomic: SUCCESS (7.942s) [393.834790] [032/133] (635s left) api_intel_allocator (default-alignment) [393.886422] Starting subtest: default-alignment [393.888634] Subtest default-alignment: SUCCESS (0.002s) [393.993918] [033/133] (635s left) kms_atomic_transition (modeset-transition-fencing) [394.088903] Starting subtest: modeset-transition-fencing [394.091147] Starting dynamic subtest: 1x-outputs [404.924842] Dynamic subtest 1x-outputs: SUCCESS (10.824s) [404.927432] Subtest modeset-transition-fencing: SUCCESS (10.825s) [405.784551] [034/133] (624s left) kms_addfb_basic (addfb25-modifier-no-flag) [405.897280] Starting subtest: addfb25-modifier-no-flag [405.899575] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [406.004964] [035/133] (623s left) kms_cursor_crc (cursor-sliding-128x128) [406.220127] Starting subtest: cursor-sliding-128x128 [406.225053] Starting dynamic subtest: pipe-A-eDP-1 [409.543549] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.320s) [409.572860] Starting dynamic subtest: pipe-D-eDP-1 [413.489528] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.926s) [413.491757] Subtest cursor-sliding-128x128: SUCCESS (7.271s) [414.392291] [036/133] (615s left) gem_ctx_shared (q-promotion) [414.451947] Starting subtest: Q-promotion [414.454321] Starting dynamic subtest: rcs0 [414.553404] Dynamic subtest rcs0: SUCCESS (0.100s) [414.568067] Starting dynamic subtest: vcs0 [414.642170] Dynamic subtest vcs0: SUCCESS (0.088s) [414.661214] Starting dynamic subtest: vcs1 [414.722471] Dynamic subtest vcs1: SUCCESS (0.079s) [414.737894] Starting dynamic subtest: vecs0 [414.799937] Dynamic subtest vecs0: SUCCESS (0.076s) [414.815846] Starting dynamic subtest: ccs0 [414.885924] Dynamic subtest ccs0: SUCCESS (0.085s) [414.888347] Subtest Q-promotion: SUCCESS (0.434s) [415.749062] [037/133] (614s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [415.852748] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt [415.857123] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [415.948650] [038/133] (614s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt) [416.042520] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt [423.246424] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.205s) [423.378673] [039/133] (606s left) kms_psr (psr2-sprite-plane-onoff) [423.467717] Starting subtest: psr2-sprite-plane-onoff [423.469836] Starting dynamic subtest: eDP-1 [425.198745] Dynamic subtest eDP-1: SUCCESS (1.729s) [425.200638] Subtest psr2-sprite-plane-onoff: SUCCESS (1.730s) [426.046101] [040/133] (604s left) perf (rc6-disable) [426.180931] Starting subtest: rc6-disable [426.355259] Subtest rc6-disable: SUCCESS (0.176s) [426.405973] [041/133] (603s left) gem_mmap_wc (coherency) [426.459930] Subtest coherency: SKIP (0.000s) [426.530224] [042/133] (603s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render) [426.620812] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render [426.625160] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [426.706687] [043/133] (603s left) gem_eio (in-flight-contexts-10ms) [426.935321] Starting subtest: in-flight-contexts-10ms [438.657042] Subtest in-flight-contexts-10ms: SUCCESS (11.717s) [438.844122] [044/133] (591s left) kms_big_fb (y-tiled-64bpp-rotate-270) [438.949049] Starting subtest: y-tiled-64bpp-rotate-270 [438.953306] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s) [439.043804] [045/133] (591s left) kms_prime (d3hot) [439.120459] Subtest D3hot: SKIP (0.000s) [439.214501] [046/133] (591s left) kms_psr (fbc-pr-cursor-blt) [439.306316] Starting subtest: fbc-pr-cursor-blt [439.310828] Subtest fbc-pr-cursor-blt: SKIP (0.000s) [439.381544] [047/133] (590s left) kms_flip (flip-vs-rmfb) [439.476825] Starting subtest: flip-vs-rmfb [439.479164] Starting dynamic subtest: A-eDP1 [448.144137] Dynamic subtest A-eDP1: SUCCESS (8.664s) [448.152825] Starting dynamic subtest: B-eDP1 [456.785544] Dynamic subtest B-eDP1: SUCCESS (8.636s) [456.797339] Starting dynamic subtest: C-eDP1 [465.414558] Dynamic subtest C-eDP1: SUCCESS (8.623s) [465.426812] Starting dynamic subtest: D-eDP1 [474.072706] Dynamic subtest D-eDP1: SUCCESS (8.656s) [474.077173] Subtest flip-vs-rmfb: SUCCESS (34.593s) [475.214442] [048/133] (555s left) kms_invalid_mode (bad-vtotal) [475.304997] Starting subtest: bad-vtotal [475.307154] Starting dynamic subtest: pipe-A-eDP-1 [475.591637] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s) [475.601615] Starting dynamic subtest: pipe-B-eDP-1 [475.604005] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [475.613452] Starting dynamic subtest: pipe-C-eDP-1 [475.615933] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [475.628034] Starting dynamic subtest: pipe-D-eDP-1 [475.630324] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [475.632515] Subtest bad-vtotal: SUCCESS (0.293s) [476.442543] [049/133] (553s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs) [476.533121] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs [476.535419] Starting dynamic subtest: pipe-A-eDP-1 [476.558605] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [476.568840] Starting dynamic subtest: pipe-B-eDP-1 [476.590862] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [476.599259] Starting dynamic subtest: pipe-C-eDP-1 [476.621070] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [476.629556] Starting dynamic subtest: pipe-D-eDP-1 [476.651522] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [476.655535] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.004s) [478.714693] [050/133] (551s left) i915_selftest (mock) [481.985562] Starting subtest: mock [481.988090] Starting dynamic subtest: sanitycheck [482.658451] Dynamic subtest sanitycheck: SUCCESS (0.673s) [482.667294] Starting dynamic subtest: shmem [483.310567] Dynamic subtest shmem: SUCCESS (0.650s) [483.327803] Starting dynamic subtest: fence [490.802647] Dynamic subtest fence: SUCCESS (7.489s) [490.812300] Starting dynamic subtest: scatterlist [492.458414] Dynamic subtest scatterlist: SUCCESS (1.655s) [492.468417] Starting dynamic subtest: syncmap [495.770352] Dynamic subtest syncmap: SUCCESS (3.310s) [495.780174] Starting dynamic subtest: uncore [496.417487] Dynamic subtest uncore: SUCCESS (0.646s) [496.426933] Starting dynamic subtest: ring [497.073475] Dynamic subtest ring: SUCCESS (0.654s) [497.083240] Starting dynamic subtest: engine [497.713235] Dynamic subtest engine: SUCCESS (0.638s) [497.723034] Starting dynamic subtest: timelines [501.447942] Dynamic subtest timelines: SUCCESS (3.731s) [501.458303] Starting dynamic subtest: requests [504.841669] Dynamic subtest requests: SUCCESS (3.393s) [504.851410] Starting dynamic subtest: objects [505.574526] Dynamic subtest objects: SUCCESS (0.732s) [505.584034] Starting dynamic subtest: phys [506.362626] Dynamic subtest phys: SUCCESS (0.786s) [506.372023] Starting dynamic subtest: dmabuf [507.100408] Dynamic subtest dmabuf: SUCCESS (0.737s) [507.109874] Starting dynamic subtest: vma [512.704189] Dynamic subtest vma: SUCCESS (5.600s) [512.713918] Starting dynamic subtest: evict [514.085561] Dynamic subtest evict: SUCCESS (1.380s) [514.095172] Starting dynamic subtest: gtt [517.369430] Dynamic subtest gtt: SUCCESS (3.282s) [517.378952] Starting dynamic subtest: hugepages [518.214013] Dynamic subtest hugepages: SUCCESS (0.843s) [518.226636] Starting dynamic subtest: memory_region [520.670355] Dynamic subtest memory_region: SUCCESS (2.453s) [520.672980] Subtest mock: SUCCESS (38.684s) [520.701483] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [520.702273] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true [520.705594] [051/133] (509s left) gem_ctx_param (set-priority-invalid-size) [522.211470] Starting subtest: set-priority-invalid-size [522.214295] Subtest set-priority-invalid-size: SUCCESS (0.000s) [522.259409] [FACT gem_ctx_param (set-priority-invalid-size)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [522.260801] [FACT gem_ctx_param (set-priority-invalid-size)] new: kernel.kmod_is_loaded.i915: true [522.264895] [052/133] (508s left) gem_exec_schedule (u-submit-early-slice) [522.350279] Starting subtest: u-submit-early-slice [522.352494] Starting dynamic subtest: rcs0 [522.404939] Dynamic subtest rcs0: SUCCESS (0.056s) [522.416185] Starting dynamic subtest: bcs0 [522.444952] Dynamic subtest bcs0: SUCCESS (0.039s) [522.454197] Starting dynamic subtest: vcs0 [522.477407] Dynamic subtest vcs0: SUCCESS (0.031s) [522.489331] Starting dynamic subtest: vcs1 [522.514001] Dynamic subtest vcs1: SUCCESS (0.036s) [522.528171] Starting dynamic subtest: vecs0 [522.553216] Dynamic subtest vecs0: SUCCESS (0.038s) [522.564342] Starting dynamic subtest: ccs0 [522.591728] Dynamic subtest ccs0: SUCCESS (0.038s) [522.593968] Subtest u-submit-early-slice: SUCCESS (0.243s) [523.713679] [053/133] (506s left) kms_chamelium_edid (dp-edid-stress-resolution-4k) [524.102572] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s) [524.879928] [054/133] (505s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip) [524.977743] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip [524.982101] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [525.072283] [055/133] (505s left) perf (sysctl-defaults) [525.158935] Starting subtest: sysctl-defaults [525.160928] Subtest sysctl-defaults: SUCCESS (0.000s) [525.243725] [056/133] (505s left) gem_lmem_swapping (verify) [525.289249] Subtest verify: SKIP (0.000s) [525.339721] [057/133] (505s left) sw_sync (sync_multi_producer_single_consumer) [525.379475] Starting subtest: sync_multi_producer_single_consumer [526.454412] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s) [526.516953] [058/133] (504s left) gem_fenced_exec_thrash (no-spare-fences-interruptible) [526.576607] Subtest no-spare-fences-interruptible: SKIP (0.000s) [526.648600] [059/133] (504s left) gen9_exec_parse (batch-zero-length) [526.708231] Subtest batch-zero-length: SKIP (0.000s) [526.781770] [060/133] (504s left) syncobj_wait (single-wait-for-submit-unsubmitted) [526.837516] Starting subtest: single-wait-for-submit-unsubmitted [526.938942] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.102s) [527.016621] [061/133] (503s left) gem_ctx_create (basic-files) [527.071473] Starting subtest: basic-files [529.091479] Subtest basic-files: SUCCESS (2.018s) [530.718006] [062/133] (500s left) intel_hwmon (hwmon-read) [530.778437] Subtest hwmon-read: SKIP (0.000s) [530.835668] [063/133] (500s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier) [530.929409] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier [530.933951] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier: SKIP (0.000s) [531.011253] [064/133] (500s left) syncobj_timeline (multi-wait-all-available-submitted-signaled) [531.055458] Starting subtest: multi-wait-all-available-submitted-signaled [531.057821] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s) [531.149046] [065/133] (499s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc) [531.249246] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc [531.253358] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [531.352830] [066/133] (499s left) gem_exec_reloc (basic-softpin) [531.410813] Subtest basic-softpin: SKIP (0.000s) [531.478221] [067/133] (499s left) kms_plane_cursor (overlay) [531.565556] Starting subtest: overlay [531.570049] Starting dynamic subtest: pipe-A-eDP-1-size-64 [534.009143] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.443s) [534.068260] Starting dynamic subtest: pipe-A-eDP-1-size-128 [536.511576] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.449s) [536.570402] Starting dynamic subtest: pipe-A-eDP-1-size-256 [539.036440] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.471s) [539.382170] Starting dynamic subtest: pipe-B-eDP-1-size-64 [542.615383] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.242s) [542.675250] Starting dynamic subtest: pipe-B-eDP-1-size-128 [545.160637] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.494s) [545.221451] Starting dynamic subtest: pipe-B-eDP-1-size-256 [547.652672] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.438s) [548.002538] Starting dynamic subtest: pipe-C-eDP-1-size-64 [550.834749] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.842s) [550.872066] Starting dynamic subtest: pipe-C-eDP-1-size-128 [552.945498] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.081s) [552.983990] Starting dynamic subtest: pipe-C-eDP-1-size-256 [555.101875] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.125s) [555.430861] Starting dynamic subtest: pipe-D-eDP-1-size-64 [558.283942] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.863s) [558.321832] Starting dynamic subtest: pipe-D-eDP-1-size-128 [560.539403] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.224s) [560.577564] Starting dynamic subtest: pipe-D-eDP-1-size-256 [562.696726] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.125s) [563.017581] Subtest overlay: SUCCESS (31.444s) [563.831777] [068/133] (467s left) perf (create-destroy-userspace-config) [563.944331] Starting subtest: create-destroy-userspace-config [563.967794] Subtest create-destroy-userspace-config: SUCCESS (0.021s) [564.019915] [069/133] (467s left) gem_exec_parallel (contexts) [564.085763] Starting subtest: contexts [564.088157] Starting dynamic subtest: rcs0 [566.789131] Dynamic subtest rcs0: SUCCESS (2.701s) [566.798692] Starting dynamic subtest: bcs0 [570.419946] Dynamic subtest bcs0: SUCCESS (3.629s) [570.430457] Starting dynamic subtest: vcs0 [574.104340] Dynamic subtest vcs0: SUCCESS (3.682s) [574.113756] Starting dynamic subtest: vcs1 [578.161070] Dynamic subtest vcs1: SUCCESS (4.054s) [578.170893] Starting dynamic subtest: vecs0 [582.144940] Dynamic subtest vecs0: SUCCESS (3.980s) [582.154245] Starting dynamic subtest: ccs0 [585.758485] Dynamic subtest ccs0: SUCCESS (3.612s) [585.760785] Subtest contexts: SUCCESS (21.667s) [585.945955] [070/133] (445s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf) [586.054179] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf [586.056496] Starting dynamic subtest: pipe-A-eDP-1 [586.161968] Dynamic subtest pipe-A-eDP-1: SKIP (0.111s) [586.172615] Starting dynamic subtest: pipe-B-eDP-1 [587.298921] Dynamic subtest pipe-B-eDP-1: SKIP (1.134s) [587.303407] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.248s) [588.483450] [071/133] (442s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc) [588.598455] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc [588.600763] Starting dynamic subtest: pipe-A-eDP-1 [588.609600] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [588.624238] Starting dynamic subtest: pipe-B-eDP-1 [588.632222] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [588.643423] Starting dynamic subtest: pipe-C-eDP-1 [588.651936] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [588.660464] Starting dynamic subtest: pipe-D-eDP-1 [588.668525] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [588.672464] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s) [590.755810] [072/133] (440s left) gem_exec_whisper (basic-forked) [590.820449] Starting subtest: basic-forked [598.163226] Subtest basic-forked: SUCCESS (7.341s) [598.364825] [073/133] (433s left) kms_big_fb (linear-16bpp-rotate-90) [598.469589] Starting subtest: linear-16bpp-rotate-90 [598.489664] Subtest linear-16bpp-rotate-90: SKIP (0.019s) [598.617992] [074/133] (432s left) kms_busy (basic-hang) [598.707675] Starting subtest: basic-hang [598.709454] Starting dynamic subtest: flip-pipe-A [599.309765] Dynamic subtest flip-pipe-A: SUCCESS (0.604s) [599.319704] Starting dynamic subtest: modeset-pipe-A [602.763773] Dynamic subtest modeset-pipe-A: SUCCESS (3.454s) [602.774103] Starting dynamic subtest: flip-pipe-D [603.972640] Dynamic subtest flip-pipe-D: SUCCESS (1.206s) [603.982926] Starting dynamic subtest: modeset-pipe-D [607.392440] Dynamic subtest modeset-pipe-D: SUCCESS (3.418s) [607.394638] Subtest basic-hang: SUCCESS (8.689s) [608.195270] [075/133] (423s left) gem_busy (semaphore) [608.380863] Subtest semaphore: SKIP (0.000s) [608.611498] [076/133] (422s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf) [608.712766] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf [608.715008] Starting dynamic subtest: pipe-A-eDP-1 [608.787272] Dynamic subtest pipe-A-eDP-1: SKIP (0.078s) [608.796829] Starting dynamic subtest: pipe-B-eDP-1 [609.892182] Dynamic subtest pipe-B-eDP-1: SKIP (1.103s) [609.896270] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.183s) [611.105608] [077/133] (420s left) kms_dsc (dsc-with-bpc) [611.207128] Starting subtest: dsc-with-bpc [611.238078] Subtest dsc-with-bpc: SKIP (0.001s) [611.291901] [078/133] (420s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled) [611.356962] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled [611.359192] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.001s) [611.466888] [079/133] (420s left) kms_addfb_basic (invalid-set-prop-any) [611.513750] Starting subtest: invalid-set-prop-any [611.515625] Subtest invalid-set-prop-any: SUCCESS (0.000s) [611.637932] [080/133] (420s left) gem_mmap_gtt (basic-copy) [611.697942] Subtest basic-copy: SKIP (0.000s) [611.758238] [081/133] (419s left) drm_read (short-buffer-wakeup) [611.904946] Starting subtest: short-buffer-wakeup [644.116271] Subtest short-buffer-wakeup: SUCCESS (32.215s) [644.251131] [082/133] (387s left) syncobj_timeline (single-wait-available-signaled) [644.307010] Starting subtest: single-wait-available-signaled [644.309317] Subtest single-wait-available-signaled: SUCCESS (0.000s) [644.399472] [083/133] (387s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [644.492641] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip [645.149841] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.659s) [645.315381] [084/133] (386s left) gem_render_copy (linear-to-vebox-yf-tiled) [645.381910] Starting subtest: linear-to-vebox-yf-tiled [645.386571] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s) [645.568296] [085/133] (386s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [645.669713] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [645.674195] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [645.754497] [086/133] (386s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling) [645.835644] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling [645.839954] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s) [645.907825] [087/133] (386s left) gem_ctx_persistence (heartbeat-hang) [645.975951] Starting subtest: heartbeat-hang [645.980626] Subtest heartbeat-hang: SKIP (0.000s) [646.077909] [088/133] (385s left) kms_rotation_crc (primary-4-tiled-reflect-x-0) [646.171668] Starting subtest: primary-4-tiled-reflect-x-0 [653.106779] Subtest primary-4-tiled-reflect-x-0: SUCCESS (6.934s) [654.336975] [089/133] (377s left) perf (non-sampling-read-error) [654.418322] Starting subtest: non-sampling-read-error [654.427240] Subtest non-sampling-read-error: SUCCESS (0.007s) [654.469586] [090/133] (377s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping) [654.547606] Starting subtest: pixel-format-4-tiled-modifier-source-clamping [654.576815] Starting dynamic subtest: pipe-A-plane-0 [655.242698] Dynamic subtest pipe-A-plane-0: SUCCESS (0.666s) [655.258161] Starting dynamic subtest: pipe-A-plane-3 [655.631012] Dynamic subtest pipe-A-plane-3: SUCCESS (0.388s) [656.724345] Starting dynamic subtest: pipe-B-plane-0 [657.372351] Dynamic subtest pipe-B-plane-0: SUCCESS (0.655s) [657.381253] Starting dynamic subtest: pipe-B-plane-3 [657.794249] Dynamic subtest pipe-B-plane-3: SUCCESS (0.421s) [658.103323] Subtest pixel-format-4-tiled-modifier-source-clamping: SUCCESS (3.556s) [658.915269] [091/133] (373s left) gem_madvise (dontneed-before-mmap) [658.958870] Starting subtest: dontneed-before-mmap [658.985015] Subtest dontneed-before-mmap: SUCCESS (0.025s) [659.088984] [092/133] (373s left) kms_content_protection (atomic-dpms-hdcp14) [659.240825] Starting subtest: atomic-dpms-hdcp14 [659.245172] Subtest atomic-dpms-hdcp14: SKIP (0.000s) [659.371013] [093/133] (372s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt) [659.466561] Starting subtest: psr-rgb565-draw-blt [666.553032] Subtest psr-rgb565-draw-blt: SUCCESS (7.089s) [666.675961] [094/133] (365s left) gem_eio (in-flight-internal-1us) [666.907035] Starting subtest: in-flight-internal-1us [668.727516] Subtest in-flight-internal-1us: SUCCESS (1.819s) [668.873924] [095/133] (363s left) kms_sequence (get-idle) [668.960234] Starting subtest: get-idle [668.962543] Starting dynamic subtest: pipe-A-eDP-1 [670.772620] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.812s) [670.783025] Starting dynamic subtest: pipe-B-eDP-1 [673.205606] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.430s) [673.215235] Starting dynamic subtest: pipe-C-eDP-1 [675.609102] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.402s) [675.624239] Starting dynamic subtest: pipe-D-eDP-1 [678.048440] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.438s) [678.050709] Subtest get-idle: SUCCESS (9.089s) [678.850992] [096/133] (353s left) gem_mmap_gtt (hang-user) [678.915190] Subtest hang-user: SKIP (0.000s) [678.984756] [097/133] (353s left) kms_cursor_crc (cursor-alpha-opaque) [679.074427] Starting subtest: cursor-alpha-opaque [679.076669] Starting dynamic subtest: pipe-A-eDP-1 [679.675204] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.599s) [679.685437] Starting dynamic subtest: pipe-D-eDP-1 [680.920838] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.246s) [680.923005] Subtest cursor-alpha-opaque: SUCCESS (1.848s) [681.718978] [098/133] (350s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu) [681.822297] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu [681.826457] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [681.904806] [099/133] (350s left) kms_pm_backlight (basic-brightness) [681.994953] Starting subtest: basic-brightness [682.049849] Starting dynamic subtest: eDP-1 [682.370199] Dynamic subtest eDP-1: SUCCESS (0.321s) [682.372337] Subtest basic-brightness: SUCCESS (0.375s) [683.250010] [100/133] (349s left) kms_addfb_basic (small-bo) [683.330426] Starting subtest: small-bo [683.332375] Subtest small-bo: SUCCESS (0.000s) [683.427476] [101/133] (349s left) syncobj_eventfd (binary-wait-before-signal) [683.482116] Starting subtest: binary-wait-before-signal [683.513282] Subtest binary-wait-before-signal: SUCCESS (0.031s) [683.590211] [102/133] (349s left) gem_exec_fence (expired-history) [684.127429] Starting subtest: expired-history [691.362681] Subtest expired-history: SUCCESS (7.234s) [691.996230] [103/133] (340s left) gem_mmap_wc (fault-concurrent) [692.053403] Subtest fault-concurrent: SKIP (0.000s) [692.127421] [104/133] (340s left) kms_lease (lease-invalid-crtc) [692.216386] Starting subtest: lease-invalid-crtc [692.218603] Starting dynamic subtest: pipe-A-eDP-1 [692.220863] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [692.231018] Starting dynamic subtest: pipe-B-eDP-1 [692.233274] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [692.244617] Starting dynamic subtest: pipe-C-eDP-1 [692.246767] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [692.255643] Starting dynamic subtest: pipe-D-eDP-1 [692.257800] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [692.259924] Subtest lease-invalid-crtc: SUCCESS (0.004s) [692.296631] [105/133] (340s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt) [692.396825] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt [692.401130] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [692.497376] [106/133] (340s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs) [692.585471] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs [692.587694] Starting dynamic subtest: pipe-A-eDP-1 [692.609711] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [692.621235] Starting dynamic subtest: pipe-B-eDP-1 [692.640012] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [692.648470] Starting dynamic subtest: pipe-C-eDP-1 [692.669535] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [692.677838] Starting dynamic subtest: pipe-D-eDP-1 [692.699877] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [692.704254] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.004s) [694.748566] [107/133] (338s left) kms_psr (fbc-psr-sprite-mmap-cpu) [694.843538] Starting subtest: fbc-psr-sprite-mmap-cpu [694.845829] Starting dynamic subtest: eDP-1 [694.850237] Dynamic subtest eDP-1: SKIP (0.000s) [694.854437] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.001s) [694.918727] [108/133] (337s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs) [694.972170] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs [694.976751] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s) [695.171325] [109/133] (337s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render) [695.275220] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render [699.390046] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (4.118s) [700.530447] [110/133] (332s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc) [700.622228] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc [707.164320] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.544s) [707.276235] [111/133] (325s left) gem_userptr_blits (stress-mm) [707.346642] Starting subtest: stress-mm [712.715645] Subtest stress-mm: SUCCESS (5.369s) [712.824774] [112/133] (320s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20) [712.914954] Starting subtest: planes-downscale-factor-0-5-upscale-20x20 [712.917139] Starting dynamic subtest: pipe-A [712.937879] Dynamic subtest pipe-A: SKIP (0.018s) [712.947117] Starting dynamic subtest: pipe-B [712.968334] Dynamic subtest pipe-B: SKIP (0.030s) [712.978007] Starting dynamic subtest: pipe-C [713.000254] Dynamic subtest pipe-C: SKIP (0.030s) [713.009772] Starting dynamic subtest: pipe-D [713.032172] Dynamic subtest pipe-D: SKIP (0.030s) [713.036349] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.111s) [713.114898] [113/133] (319s left) kms_vrr (negative-basic) [713.205539] Starting subtest: negative-basic [713.212307] Starting dynamic subtest: pipe-A-eDP-1 [718.629754] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.416s) [718.920594] Subtest negative-basic: SUCCESS (5.713s) [719.780251] [114/133] (313s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt) [719.894089] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt [724.317563] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.426s) [725.495255] [115/133] (307s left) gem_ctx_param (vm) [725.548175] Starting subtest: vm [725.587661] Subtest vm: SUCCESS (0.039s) [725.715183] [116/133] (307s left) i915_hangman (error-state-basic) [725.773305] Starting subtest: error-state-basic [725.939324] Subtest error-state-basic: SUCCESS (0.167s) [726.016852] [117/133] (307s left) gem_exec_balancer (bonded-semaphore) [726.068787] Starting subtest: bonded-semaphore [726.073160] Subtest bonded-semaphore: SKIP (0.000s) [726.371394] [118/133] (306s left) gem_exec_params (no-vebox) [726.428389] Starting subtest: no-vebox [726.430572] Subtest no-vebox: SUCCESS (0.002s) [727.737728] [119/133] (305s left) gem_create (create-valid-nonaligned) [727.801090] Starting subtest: create-valid-nonaligned [727.803542] Subtest create-valid-nonaligned: SUCCESS (0.000s) [728.001777] [120/133] (305s left) kms_fbcon_fbt (fbc-suspend) [728.063572] Starting subtest: fbc-suspend [777.282927] Subtest fbc-suspend: SUCCESS (19.321s) [778.625041] [121/133] (254s left) sriov_basic (enable-vfs-bind-unbind-each) [778.698154] Starting subtest: enable-vfs-bind-unbind-each [778.700261] Starting dynamic subtest: numvfs-1 [778.774361] Dynamic subtest numvfs-1: FAIL (0.014s) [778.785976] Starting dynamic subtest: numvfs-2 [778.858587] Dynamic subtest numvfs-2: FAIL (0.004s) [778.869707] Starting dynamic subtest: numvfs-3 [778.941583] Dynamic subtest numvfs-3: FAIL (0.003s) [778.952189] Starting dynamic subtest: numvfs-4 [779.023505] Dynamic subtest numvfs-4: FAIL (0.003s) [779.036041] Starting dynamic subtest: numvfs-5 [779.108596] Dynamic subtest numvfs-5: FAIL (0.003s) [779.118383] Starting dynamic subtest: numvfs-6 [779.186535] Dynamic subtest numvfs-6: FAIL (0.003s) [779.198731] Starting dynamic subtest: numvfs-7 [779.270578] Dynamic subtest numvfs-7: FAIL (0.003s) [779.281341] Starting dynamic subtest: numvfs-random [779.352887] Dynamic subtest numvfs-random: FAIL (0.003s) [779.355193] Subtest enable-vfs-bind-unbind-each: FAIL (0.043s) [779.395277] [122/133] (254s left) kms_color (deep-color) [779.492571] Starting subtest: deep-color [780.515332] Starting dynamic subtest: pipe-A-eDP-1-gamma [781.219994] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.706s) [781.229744] Starting dynamic subtest: pipe-A-eDP-1-degamma [782.688442] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.467s) [782.698611] Starting dynamic subtest: pipe-A-eDP-1-ctm [784.149424] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.465s) [784.909534] Starting dynamic subtest: pipe-B-eDP-1-gamma [785.610312] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.711s) [785.619901] Starting dynamic subtest: pipe-B-eDP-1-degamma [787.078399] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.467s) [787.088631] Starting dynamic subtest: pipe-B-eDP-1-ctm [788.548330] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.470s) [789.296441] Starting dynamic subtest: pipe-C-eDP-1-gamma [789.985655] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.700s) [789.995810] Starting dynamic subtest: pipe-C-eDP-1-degamma [791.360680] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.375s) [791.371166] Starting dynamic subtest: pipe-C-eDP-1-ctm [792.783566] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.421s) [793.603129] Starting dynamic subtest: pipe-D-eDP-1-gamma [794.305576] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.712s) [794.316735] Starting dynamic subtest: pipe-D-eDP-1-degamma [795.753571] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.446s) [795.764003] Starting dynamic subtest: pipe-D-eDP-1-ctm [797.167069] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.414s) [797.169456] Subtest deep-color: SUCCESS (17.693s) [798.054018] [123/133] (235s left) kms_cursor_legacy (cursora-vs-flipb-atomic) [798.177428] Starting subtest: cursorA-vs-flipB-atomic [798.181735] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s) [798.334965] [124/133] (235s left) core_debugfs (read-all-entries) [798.398420] Starting subtest: read-all-entries [798.492011] Subtest read-all-entries: SUCCESS (0.094s) [798.596167] [125/133] (235s left) kms_psr (fbc-pr-suspend) [798.686697] Starting subtest: fbc-pr-suspend [798.690687] Subtest fbc-pr-suspend: SKIP (0.000s) [798.764557] [126/133] (234s left) gem_userptr_blits (stress-mm-invalidate-close) [798.824759] Starting subtest: stress-mm-invalidate-close [800.969471] Subtest stress-mm-invalidate-close: SUCCESS (2.148s) [801.078324] [127/133] (232s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render) [801.187923] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render [801.192462] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [801.290252] [128/133] (232s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs) [801.386883] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs [801.389215] Starting dynamic subtest: pipe-A-eDP-1 [801.416233] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [801.437926] Starting dynamic subtest: pipe-B-eDP-1 [801.462553] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [801.483275] Starting dynamic subtest: pipe-C-eDP-1 [801.507694] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [801.523255] Starting dynamic subtest: pipe-D-eDP-1 [801.547621] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [801.551665] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.004s) [803.615136] [129/133] (230s left) kms_atomic_transition (plane-all-modeset-transition-fencing) [803.714442] Starting subtest: plane-all-modeset-transition-fencing [803.718949] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s) [803.788659] [130/133] (230s left) kms_flip (flip-vs-fences) [803.875983] Starting subtest: flip-vs-fences [803.880830] Subtest flip-vs-fences: SKIP (0.000s) [803.976276] [131/133] (229s left) gem_mmap_gtt (basic-small-copy) [804.039268] Subtest basic-small-copy: SKIP (0.000s) [804.095363] [132/133] (229s left) kms_chamelium_hpd (vga-hpd-fast) [804.476150] Subtest vga-hpd-fast: SKIP (0.000s) [805.324493] [133/133] (228s left) perf_pmu (busy-idle-check-all) [805.365465] Starting subtest: busy-idle-check-all [805.367811] Starting dynamic subtest: rcs0 [806.016141] Dynamic subtest rcs0: SUCCESS (0.652s) [806.029042] Starting dynamic subtest: bcs0 [806.669966] Dynamic subtest bcs0: SUCCESS (0.651s) [806.686247] Starting dynamic subtest: vcs0 [807.377623] Dynamic subtest vcs0: FAIL (0.623s) [807.388635] Starting dynamic subtest: vcs1 [807.996636] Dynamic subtest vcs1: FAIL (0.622s) [808.008155] Starting dynamic subtest: vecs0 [808.625291] Dynamic subtest vecs0: FAIL (0.622s) [808.639025] Starting dynamic subtest: ccs0 [809.196446] Dynamic subtest ccs0: SUCCESS (0.653s) [809.198760] Subtest busy-idle-check-all: FAIL (3.832s) [809.310610] Closing watchdogs results: parsing output: 0/ for test: gem_exec_params results: parsing output: 1/ for test: kms_big_fb results: parsing output: 2/ for test: kms_ccs results: parsing output: 3/ for test: gem_mmap_wc results: parsing output: 4/ for test: kms_debugfs results: parsing output: 5/ for test: kms_frontbuffer_tracking results: parsing output: 6/ for test: kms_psr results: parsing output: 7/ for test: kms_frontbuffer_tracking results: parsing output: 8/ for test: gem_mmap results: parsing output: 9/ for test: gem_close_race results: parsing output: 10/ for test: kms_frontbuffer_tracking results: parsing output: 11/ for test: syncobj_timeline results: parsing output: 12/ for test: gem_exec_fence results: parsing output: 13/ for test: gem_ctx_param results: parsing output: 14/ for test: i915_drm_fdinfo results: parsing output: 15/ for test: i915_pm_rps results: parsing output: 16/ for test: syncobj_timeline results: parsing output: 17/ for test: kms_vblank results: parsing output: 18/ for test: gem_userptr_blits results: parsing output: 19/ for test: kms_frontbuffer_tracking results: parsing output: 20/ for test: kms_frontbuffer_tracking results: parsing output: 21/ for test: kms_cursor_edge_walk results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: gem_spin_batch results: parsing output: 24/ for test: gem_exec_schedule results: parsing output: 25/ for test: kms_atomic_transition results: parsing output: 26/ for test: kms_flip results: parsing output: 27/ for test: kms_pipe_crc_basic results: parsing output: 28/ for test: vgem_basic results: parsing output: 29/ for test: gem_lmem_swapping results: parsing output: 30/ for test: kms_properties results: parsing output: 31/ for test: api_intel_allocator results: parsing output: 32/ for test: kms_atomic_transition results: parsing output: 33/ for test: kms_addfb_basic results: parsing output: 34/ for test: kms_cursor_crc results: parsing output: 35/ for test: gem_ctx_shared results: parsing output: 36/ for test: kms_frontbuffer_tracking results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: kms_psr results: parsing output: 39/ for test: perf results: parsing output: 40/ for test: gem_mmap_wc results: parsing output: 41/ for test: kms_frontbuffer_tracking results: parsing output: 42/ for test: gem_eio results: parsing output: 43/ for test: kms_big_fb results: parsing output: 44/ for test: kms_prime results: parsing output: 45/ for test: kms_psr results: parsing output: 46/ for test: kms_flip results: parsing output: 47/ for test: kms_invalid_mode results: parsing output: 48/ for test: kms_ccs results: parsing output: 49/ for test: i915_selftest results: parsing output: 50/ for test: gem_ctx_param results: parsing output: 51/ for test: gem_exec_schedule results: parsing output: 52/ for test: kms_chamelium_edid results: parsing output: 53/ for test: kms_big_fb results: parsing output: 54/ for test: perf results: parsing output: 55/ for test: gem_lmem_swapping results: parsing output: 56/ for test: sw_sync results: parsing output: 57/ for test: gem_fenced_exec_thrash results: parsing output: 58/ for test: gen9_exec_parse results: parsing output: 59/ for test: syncobj_wait results: parsing output: 60/ for test: gem_ctx_create results: parsing output: 61/ for test: intel_hwmon results: parsing output: 62/ for test: kms_plane results: parsing output: 63/ for test: syncobj_timeline results: parsing output: 64/ for test: kms_frontbuffer_tracking results: parsing output: 65/ for test: gem_exec_reloc results: parsing output: 66/ for test: kms_plane_cursor results: parsing output: 67/ for test: perf results: parsing output: 68/ for test: gem_exec_parallel results: parsing output: 69/ for test: kms_psr2_sf results: parsing output: 70/ for test: kms_ccs results: parsing output: 71/ for test: gem_exec_whisper results: parsing output: 72/ for test: kms_big_fb results: parsing output: 73/ for test: kms_busy results: parsing output: 74/ for test: gem_busy results: parsing output: 75/ for test: kms_psr2_sf results: parsing output: 76/ for test: kms_dsc results: parsing output: 77/ for test: syncobj_timeline results: parsing output: 78/ for test: kms_addfb_basic results: parsing output: 79/ for test: gem_mmap_gtt results: parsing output: 80/ for test: drm_read results: parsing output: 81/ for test: syncobj_timeline results: parsing output: 82/ for test: kms_big_fb results: parsing output: 83/ for test: gem_render_copy results: parsing output: 84/ for test: kms_big_fb results: parsing output: 85/ for test: kms_flip_scaled_crc results: parsing output: 86/ for test: gem_ctx_persistence results: parsing output: 87/ for test: kms_rotation_crc results: parsing output: 88/ for test: perf results: parsing output: 89/ for test: kms_plane results: parsing output: 90/ for test: gem_madvise results: parsing output: 91/ for test: kms_content_protection results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: gem_eio results: parsing output: 94/ for test: kms_sequence results: parsing output: 95/ for test: gem_mmap_gtt results: parsing output: 96/ for test: kms_cursor_crc results: parsing output: 97/ for test: kms_frontbuffer_tracking results: parsing output: 98/ for test: kms_pm_backlight results: parsing output: 99/ for test: kms_addfb_basic results: parsing output: 100/ for test: syncobj_eventfd results: parsing output: 101/ for test: gem_exec_fence results: parsing output: 102/ for test: gem_mmap_wc results: parsing output: 103/ for test: kms_lease results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: kms_ccs results: parsing output: 106/ for test: kms_psr results: parsing output: 107/ for test: gem_render_copy results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: kms_frontbuffer_tracking results: parsing output: 110/ for test: gem_userptr_blits results: parsing output: 111/ for test: kms_plane_scaling results: parsing output: 112/ for test: kms_vrr results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: gem_ctx_param results: parsing output: 115/ for test: i915_hangman results: parsing output: 116/ for test: gem_exec_balancer results: parsing output: 117/ for test: gem_exec_params results: parsing output: 118/ for test: gem_create results: parsing output: 119/ for test: kms_fbcon_fbt results: parsing output: 120/ for test: sriov_basic results: parsing output: 121/ for test: kms_color results: parsing output: 122/ for test: kms_cursor_legacy results: parsing output: 123/ for test: core_debugfs results: parsing output: 124/ for test: kms_psr results: parsing output: 125/ for test: gem_userptr_blits results: parsing output: 126/ for test: kms_frontbuffer_tracking results: parsing output: 127/ for test: kms_ccs results: parsing output: 128/ for test: kms_atomic_transition results: parsing output: 129/ for test: kms_flip results: parsing output: 130/ for test: gem_mmap_gtt results: parsing output: 131/ for test: kms_chamelium_hpd results: parsing output: 132/ for test: perf_pmu Done.