[62.404575] Initializing watchdogs [62.404620] /dev/watchdog0 [62.420078] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [62.424788] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [62.427499] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [62.430828] [001/134] (960s left) kms_psr (fbc-psr-primary-mmap-gtt) [62.566881] Starting subtest: fbc-psr-primary-mmap-gtt [62.569165] Starting dynamic subtest: eDP-1 [62.573239] Dynamic subtest eDP-1: SKIP (0.000s) [62.577338] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s) [62.639474] [002/134] (960s left) i915_drm_fdinfo (isolation) [62.685806] Starting subtest: isolation [62.688108] Starting dynamic subtest: rcs0 [62.721350] Dynamic subtest rcs0: SKIP (0.033s) [62.732167] Starting dynamic subtest: bcs0 [62.736642] Dynamic subtest bcs0: SKIP (0.000s) [62.745740] Starting dynamic subtest: vcs0 [62.750155] Dynamic subtest vcs0: SKIP (0.000s) [62.757693] Starting dynamic subtest: vcs1 [62.761969] Dynamic subtest vcs1: SKIP (0.000s) [62.769599] Starting dynamic subtest: vecs0 [62.773961] Dynamic subtest vecs0: SKIP (0.000s) [62.781618] Starting dynamic subtest: ccs0 [62.786106] Dynamic subtest ccs0: SKIP (0.000s) [62.790430] Subtest isolation: SKIP (0.036s) [62.826492] [003/134] (960s left) dumb_buffer (map-uaf) [62.872836] Starting subtest: map-uaf [62.875262] Subtest map-uaf: SUCCESS (0.005s) [62.974624] [004/134] (960s left) kms_cursor_legacy (cursor-vs-flip-toggle) [63.095664] Starting subtest: cursor-vs-flip-toggle [94.583800] Subtest cursor-vs-flip-toggle: SUCCESS (31.453s) [95.422584] [005/134] (927s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs) [95.562603] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs [95.565094] Starting dynamic subtest: pipe-A-eDP-1 [95.589234] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [95.599204] Starting dynamic subtest: pipe-B-eDP-1 [95.621518] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [95.629547] Starting dynamic subtest: pipe-C-eDP-1 [95.651332] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [95.658962] Starting dynamic subtest: pipe-D-eDP-1 [95.681937] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [95.686588] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.004s) [97.889086] [006/134] (925s left) kms_cursor_legacy (cursorb-vs-flipa-toggle) [98.018691] Starting subtest: cursorB-vs-flipA-toggle [98.023538] Subtest cursorB-vs-flipA-toggle: SKIP (0.002s) [98.170122] [007/134] (924s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc) [98.264588] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc [98.268945] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [98.383863] [008/134] (924s left) gem_mmap_wc (write-read) [98.442999] Subtest write-read: SKIP (0.000s) [98.505277] [009/134] (924s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area) [98.608260] Starting subtest: fbc-psr2-plane-move-sf-dmg-area [98.610691] Starting dynamic subtest: pipe-A-eDP-1 [98.704433] Dynamic subtest pipe-A-eDP-1: SKIP (0.101s) [98.715774] Starting dynamic subtest: pipe-B-eDP-1 [99.864853] Dynamic subtest pipe-B-eDP-1: SKIP (1.159s) [99.869657] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.261s) [101.149124] [010/134] (922s left) kms_pm_rpm (pc8-residency) [103.486237] Starting subtest: pc8-residency [103.491865] Subtest pc8-residency: SKIP (0.000s) [103.881626] [011/134] (919s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt) [103.977185] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt [103.981479] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [104.072299] [012/134] (919s left) kms_chamelium_frames (hdmi-cmp-planar-formats) [104.467765] Subtest hdmi-cmp-planar-formats: SKIP (0.000s) [105.287699] [013/134] (918s left) gem_ccs (block-copy-compressed) [105.347901] Starting subtest: block-copy-compressed [105.352795] Subtest block-copy-compressed: SKIP (0.000s) [105.453414] [014/134] (917s left) gem_gtt_cpu_tlb [105.575703] [015/134] (917s left) syncobj_timeline (single-wait-signaled) [105.625738] Starting subtest: single-wait-signaled [105.627985] Subtest single-wait-signaled: SUCCESS (0.000s) [105.729137] [016/134] (917s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75) [105.821137] Starting subtest: planes-upscale-20x20-downscale-factor-0-75 [105.823467] Starting dynamic subtest: pipe-A [105.844238] Dynamic subtest pipe-A: SKIP (0.019s) [105.853852] Starting dynamic subtest: pipe-B [105.878533] Dynamic subtest pipe-B: SKIP (0.035s) [105.886789] Starting dynamic subtest: pipe-C [105.920331] Dynamic subtest pipe-C: SKIP (0.040s) [105.928488] Starting dynamic subtest: pipe-D [105.954585] Dynamic subtest pipe-D: SKIP (0.035s) [105.958816] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.131s) [106.054349] [017/134] (917s left) api_intel_bb (purge-bb) [106.113108] Starting subtest: purge-bb [106.117504] Subtest purge-bb: SUCCESS (0.004s) [106.246881] [018/134] (917s left) gem_ctx_shared (exec-single-timeline) [106.305811] Starting subtest: exec-single-timeline [106.307767] Starting dynamic subtest: rcs0 [107.356963] Dynamic subtest rcs0: SUCCESS (1.048s) [107.373148] Starting dynamic subtest: bcs0 [108.444932] Dynamic subtest bcs0: SUCCESS (1.086s) [108.457075] Starting dynamic subtest: vcs0 [109.533401] Dynamic subtest vcs0: SUCCESS (1.087s) [109.545043] Starting dynamic subtest: vcs1 [110.621499] Dynamic subtest vcs1: SUCCESS (1.086s) [110.632008] Starting dynamic subtest: vecs0 [111.709107] Dynamic subtest vecs0: SUCCESS (1.086s) [111.721330] Starting dynamic subtest: ccs0 [112.797186] Dynamic subtest ccs0: SUCCESS (1.086s) [112.800213] Subtest exec-single-timeline: SUCCESS (6.489s) [112.988358] [019/134] (910s left) gem_exec_reloc (basic-write-cpu-noreloc) [113.056649] Subtest basic-write-cpu-noreloc: SKIP (0.000s) [113.135337] [020/134] (910s left) syncobj_wait (single-wait-submitted) [113.187535] Starting subtest: single-wait-submitted [113.293277] Subtest single-wait-submitted: SUCCESS (0.104s) [113.367821] [021/134] (910s left) gen9_exec_parse (batch-invalid-length) [113.422812] Subtest batch-invalid-length: SKIP (0.000s) [113.488714] [022/134] (910s left) kms_color (degamma) [113.592093] Starting subtest: degamma [113.594254] Starting dynamic subtest: pipe-A-eDP-1 [114.336107] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.742s) [114.348511] Starting dynamic subtest: pipe-B-eDP-1 [115.740804] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.406s) [115.750063] Starting dynamic subtest: pipe-C-eDP-1 [117.091801] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.350s) [117.100344] Starting dynamic subtest: pipe-D-eDP-1 [118.431563] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.338s) [118.433705] Subtest degamma: SUCCESS (4.840s) [119.228846] [023/134] (904s left) kms_big_fb (y-tiled-addfb) [119.334474] Starting subtest: y-tiled-addfb [119.338943] Subtest y-tiled-addfb: SKIP (0.000s) [119.422296] [024/134] (904s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [119.536898] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [119.541331] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [119.662745] [025/134] (904s left) gem_exec_schedule (pi-common) [119.838895] Starting subtest: pi-common [119.841508] Starting dynamic subtest: rcs0 [119.888314] Dynamic subtest rcs0: SUCCESS (0.051s) [119.901809] Starting dynamic subtest: bcs0 [119.914859] Dynamic subtest bcs0: SUCCESS (0.026s) [119.927840] Starting dynamic subtest: vcs0 [119.941799] Dynamic subtest vcs0: SUCCESS (0.026s) [119.955214] Starting dynamic subtest: vcs1 [119.967710] Dynamic subtest vcs1: SUCCESS (0.025s) [119.981860] Starting dynamic subtest: vecs0 [119.993851] Dynamic subtest vecs0: SUCCESS (0.026s) [120.007763] Starting dynamic subtest: ccs0 [120.019135] Dynamic subtest ccs0: SUCCESS (0.025s) [120.021409] Subtest pi-common: SUCCESS (0.183s) [120.262431] [FACT gem_exec_schedule (pi-common)] new: kernel.kmod_is_loaded.vgem: true [120.266385] [026/134] (903s left) gem_huc_copy (huc-copy) [120.341068] Starting subtest: huc-copy [120.343693] Subtest huc-copy: SUCCESS (0.003s) [120.475058] [027/134] (903s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt) [120.570560] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt [127.345647] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.777s) [127.519055] [028/134] (896s left) kms_dp_linktrain_fallback (dsc-fallback) [127.617066] Starting subtest: dsc-fallback [127.623699] Subtest dsc-fallback: SKIP (0.000s) [127.689148] [029/134] (896s left) gem_exec_schedule (semaphore-resolve) [127.763112] Starting subtest: semaphore-resolve [127.795118] Subtest semaphore-resolve: SUCCESS (0.040s) [128.145887] [030/134] (895s left) kms_plane (pixel-format-linear-modifier) [128.240506] Starting subtest: pixel-format-linear-modifier [128.265569] Starting dynamic subtest: pipe-A-plane-0 [128.810457] Dynamic subtest pipe-A-plane-0: SUCCESS (0.544s) [128.820050] Starting dynamic subtest: pipe-A-plane-3 [129.287476] Dynamic subtest pipe-A-plane-3: SUCCESS (0.477s) [129.296680] Starting dynamic subtest: pipe-A-plane-5 [129.498835] Dynamic subtest pipe-A-plane-5: SUCCESS (0.211s) [130.644761] Starting dynamic subtest: pipe-B-plane-0 [131.236817] Dynamic subtest pipe-B-plane-0: SUCCESS (0.600s) [131.245903] Starting dynamic subtest: pipe-B-plane-3 [131.691923] Dynamic subtest pipe-B-plane-3: SUCCESS (0.455s) [131.700234] Starting dynamic subtest: pipe-B-plane-5 [131.903067] Dynamic subtest pipe-B-plane-5: SUCCESS (0.211s) [132.215611] Subtest pixel-format-linear-modifier: SUCCESS (3.977s) [133.017400] [031/134] (891s left) gem_softpin (zero) [133.075056] Starting subtest: zero [133.082502] Subtest zero: SUCCESS (0.005s) [133.196947] [032/134] (891s left) gem_ctx_bad_destroy (double-destroy) [133.250064] Starting subtest: double-destroy [133.252339] Subtest double-destroy: SUCCESS (0.000s) [133.322182] [033/134] (890s left) gem_exec_fence (nb-await) [133.496129] Starting subtest: nb-await [133.498547] Starting dynamic subtest: rcs0 [133.563252] Dynamic subtest rcs0: SUCCESS (0.066s) [133.573750] Starting dynamic subtest: bcs0 [133.622103] Dynamic subtest bcs0: SUCCESS (0.058s) [133.632030] Starting dynamic subtest: vcs0 [133.680955] Dynamic subtest vcs0: SUCCESS (0.057s) [133.690662] Starting dynamic subtest: vcs1 [133.740147] Dynamic subtest vcs1: SUCCESS (0.058s) [133.751997] Starting dynamic subtest: vecs0 [133.798994] Dynamic subtest vecs0: SUCCESS (0.058s) [133.810565] Starting dynamic subtest: ccs0 [133.861992] Dynamic subtest ccs0: SUCCESS (0.062s) [133.864743] Subtest nb-await: SUCCESS (0.366s) [135.377641] [034/134] (888s left) kms_cursor_crc (cursor-rapid-movement-64x64) [135.568697] Starting subtest: cursor-rapid-movement-64x64 [135.573645] Starting dynamic subtest: pipe-A-eDP-1 [136.139918] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.567s) [136.169952] Starting dynamic subtest: pipe-D-eDP-1 [137.351435] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.186s) [137.353763] Subtest cursor-rapid-movement-64x64: SUCCESS (1.781s) [138.199796] [035/134] (886s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [138.295321] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt [138.299207] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [138.398096] [036/134] (885s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu) [138.492964] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu [145.600175] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.110s) [145.726182] [037/134] (878s left) kms_flip (blocking-absolute-wf_vblank-interruptible) [145.834431] Starting subtest: blocking-absolute-wf_vblank-interruptible [145.836840] Starting dynamic subtest: A-eDP1 [154.575841] Dynamic subtest A-eDP1: SUCCESS (8.739s) [154.585239] Starting dynamic subtest: B-eDP1 [163.295686] Dynamic subtest B-eDP1: SUCCESS (8.718s) [163.307376] Starting dynamic subtest: C-eDP1 [172.011914] Dynamic subtest C-eDP1: SUCCESS (8.715s) [172.023804] Starting dynamic subtest: D-eDP1 [180.742583] Dynamic subtest D-eDP1: SUCCESS (8.728s) [180.745076] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.910s) [181.967498] [038/134] (842s left) gem_exec_params (no-blt) [182.023053] Starting subtest: no-blt [182.026169] Subtest no-blt: SUCCESS (0.002s) [182.137768] [039/134] (842s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled) [182.188210] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled [182.191426] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s) [182.291657] [040/134] (842s left) kms_cursor_crc (cursor-onscreen-512x170) [182.578311] Starting subtest: cursor-onscreen-512x170 [182.582761] Subtest cursor-onscreen-512x170: SKIP (0.001s) [182.720399] [041/134] (841s left) gem_mmap (basic) [182.779139] Subtest basic: SKIP (0.000s) [182.845547] [042/134] (841s left) gem_mmap_gtt (big-bo-tiledx) [182.902336] Subtest big-bo-tiledX: SKIP (0.000s) [182.960908] [043/134] (841s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic) [183.075938] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic [200.895602] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.816s) [201.774299] [044/134] (822s left) kms_ccs (bad-rotation-90-y-tiled-ccs) [201.875097] Starting subtest: bad-rotation-90-y-tiled-ccs [201.877331] Starting dynamic subtest: pipe-A-eDP-1 [201.900486] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [201.911096] Starting dynamic subtest: pipe-B-eDP-1 [201.932122] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [201.940923] Starting dynamic subtest: pipe-C-eDP-1 [201.962189] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [201.972483] Starting dynamic subtest: pipe-D-eDP-1 [201.994093] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [201.998097] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.004s) [204.158236] [045/134] (820s left) i915_selftest (mock) [205.791474] Starting subtest: mock [205.793509] Starting dynamic subtest: sanitycheck [206.476303] Dynamic subtest sanitycheck: SUCCESS (0.688s) [206.488572] Starting dynamic subtest: shmem [207.181942] Dynamic subtest shmem: SUCCESS (0.704s) [207.191911] Starting dynamic subtest: fence [215.430364] Dynamic subtest fence: SUCCESS (8.245s) [215.446171] Starting dynamic subtest: scatterlist [217.139378] Dynamic subtest scatterlist: SUCCESS (1.706s) [217.149502] Starting dynamic subtest: syncmap [220.354450] Dynamic subtest syncmap: SUCCESS (3.213s) [220.364189] Starting dynamic subtest: uncore [221.057169] Dynamic subtest uncore: SUCCESS (0.702s) [221.067118] Starting dynamic subtest: ring [221.765643] Dynamic subtest ring: SUCCESS (0.706s) [221.778156] Starting dynamic subtest: engine [222.454541] Dynamic subtest engine: SUCCESS (0.687s) [222.462089] Starting dynamic subtest: timelines [226.341946] Dynamic subtest timelines: SUCCESS (3.884s) [226.351955] Starting dynamic subtest: requests [229.960174] Dynamic subtest requests: SUCCESS (3.588s) [229.970877] Starting dynamic subtest: objects [230.717015] Dynamic subtest objects: SUCCESS (0.784s) [230.726434] Starting dynamic subtest: phys [231.537900] Dynamic subtest phys: SUCCESS (0.818s) [231.551035] Starting dynamic subtest: dmabuf [232.336069] Dynamic subtest dmabuf: SUCCESS (0.796s) [232.343643] Starting dynamic subtest: vma [238.198048] Dynamic subtest vma: SUCCESS (5.859s) [238.207557] Starting dynamic subtest: evict [239.665755] Dynamic subtest evict: SUCCESS (1.466s) [239.679783] Starting dynamic subtest: gtt [243.052707] Dynamic subtest gtt: SUCCESS (3.385s) [243.062769] Starting dynamic subtest: hugepages [243.960573] Dynamic subtest hugepages: SUCCESS (0.907s) [243.970306] Starting dynamic subtest: memory_region [246.559335] Dynamic subtest memory_region: SUCCESS (2.596s) [246.562297] Subtest mock: SUCCESS (40.769s) [246.591288] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [246.592055] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true [246.595213] [046/134] (778s left) kms_pm_rpm (cursor-dpms) [249.646730] Starting subtest: cursor-dpms [249.651715] Subtest cursor-dpms: SKIP (0.000s) [250.373224] [FACT kms_pm_rpm (cursor-dpms)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [250.374559] [FACT kms_pm_rpm (cursor-dpms)] new: kernel.kmod_is_loaded.i915: true [250.379040] [047/134] (774s left) gem_mmap_gtt (fault-concurrent-y) [250.441724] Subtest fault-concurrent-Y: SKIP (0.000s) [250.501045] [048/134] (774s left) gem_render_copy (x-tiled-to-vebox-y-tiled) [250.562985] Starting subtest: x-tiled-to-vebox-y-tiled [250.567691] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s) [250.761019] [049/134] (774s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render) [250.864910] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render [250.869247] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [250.971241] [050/134] (773s left) kms_cursor_edge_walk (64x64-top-bottom) [251.075910] Starting subtest: 64x64-top-bottom [251.078542] Starting dynamic subtest: pipe-A-eDP-1 [254.517105] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.442s) [254.527069] Starting dynamic subtest: pipe-D-eDP-1 [257.631248] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.113s) [257.633480] Subtest 64x64-top-bottom: SUCCESS (6.558s) [258.481490] [051/134] (766s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [258.570292] Starting subtest: nonblocking-crc-frame-sequence [258.572629] Starting dynamic subtest: pipe-A-eDP-1 [259.326623] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.755s) [259.336614] Starting dynamic subtest: pipe-B-eDP-1 [260.787958] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.460s) [260.798592] Starting dynamic subtest: pipe-C-eDP-1 [262.184849] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.396s) [262.193864] Starting dynamic subtest: pipe-D-eDP-1 [263.607556] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.421s) [263.609848] Subtest nonblocking-crc-frame-sequence: SUCCESS (5.037s) [264.486944] [052/134] (760s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu) [264.586168] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu [271.174945] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.592s) [271.289753] [053/134] (753s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180) [271.383472] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180 [271.387673] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s) [271.477904] [054/134] (753s left) kms_plane_cursor (viewport) [271.565571] Starting subtest: viewport [271.570113] Starting dynamic subtest: pipe-A-eDP-1-size-64 [274.307285] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.742s) [274.368431] Starting dynamic subtest: pipe-A-eDP-1-size-128 [277.076070] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.716s) [277.133256] Starting dynamic subtest: pipe-A-eDP-1-size-256 [279.809175] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.683s) [280.173460] Starting dynamic subtest: pipe-B-eDP-1-size-64 [283.529076] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.367s) [283.588251] Starting dynamic subtest: pipe-B-eDP-1-size-128 [286.272866] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.694s) [286.333678] Starting dynamic subtest: pipe-B-eDP-1-size-256 [289.019408] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.694s) [289.379043] Starting dynamic subtest: pipe-C-eDP-1-size-64 [292.393418] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.024s) [292.430139] Starting dynamic subtest: pipe-C-eDP-1-size-128 [294.782525] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.358s) [294.821516] Starting dynamic subtest: pipe-C-eDP-1-size-256 [297.170706] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.359s) [297.508215] Starting dynamic subtest: pipe-D-eDP-1-size-64 [300.575332] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (3.081s) [300.613283] Starting dynamic subtest: pipe-D-eDP-1-size-128 [302.964857] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.359s) [303.001896] Starting dynamic subtest: pipe-D-eDP-1-size-256 [305.353408] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.359s) [305.673615] Subtest viewport: SUCCESS (34.109s) [306.561864] [055/134] (718s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy) [306.629832] Starting subtest: map-fixed-invalidate-overlap-busy [306.634050] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s) [306.770425] [056/134] (718s left) kms_psr (fbc-psr2-sprite-plane-move) [306.868117] Starting subtest: fbc-psr2-sprite-plane-move [306.870341] Starting dynamic subtest: eDP-1 [306.874413] Dynamic subtest eDP-1: SKIP (0.000s) [306.878473] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s) [306.943691] [057/134] (718s left) gem_exec_whisper (basic-contexts-priority) [307.005885] Starting subtest: basic-contexts-priority [331.652037] Subtest basic-contexts-priority: SUCCESS (24.645s) [331.835867] [058/134] (693s left) perf_pmu (rc6) [331.888586] Starting subtest: rc6 [331.890736] Starting dynamic subtest: gt0 [338.264172] Dynamic subtest gt0: SUCCESS (6.377s) [338.277065] Starting dynamic subtest: runtime-pm-gt0 [346.034089] Dynamic subtest runtime-pm-gt0: SUCCESS (7.766s) [346.044241] Starting dynamic subtest: runtime-pm-long-gt0 [358.518463] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.484s) [358.531375] Starting dynamic subtest: other-idle-gt0 [364.864128] Dynamic subtest other-idle-gt0: SUCCESS (6.343s) [364.876584] Starting dynamic subtest: gt1 [371.206379] Dynamic subtest gt1: SUCCESS (6.340s) [371.218838] Starting dynamic subtest: runtime-pm-gt1 [378.647070] Dynamic subtest runtime-pm-gt1: SUCCESS (7.437s) [378.659945] Starting dynamic subtest: runtime-pm-long-gt1 [391.071971] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.422s) [391.084820] Starting dynamic subtest: other-idle-gt1 [397.415915] Dynamic subtest other-idle-gt1: SUCCESS (6.341s) [397.419843] Subtest rc6: SUCCESS (65.528s) [398.593658] [059/134] (626s left) kms_vblank (query-idle-hang) [398.700222] Starting subtest: query-idle-hang [398.702064] Starting dynamic subtest: pipe-A-eDP-1 [425.093063] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.392s) [425.107380] Starting dynamic subtest: pipe-D-eDP-1 [450.047927] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.952s) [450.050704] Subtest query-idle-hang: SUCCESS (51.349s) [450.832890] [060/134] (574s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite) [450.934198] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite [450.938572] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [451.011863] [061/134] (574s left) gem_mmap_gtt (big-copy-xy) [451.076816] Subtest big-copy-XY: SKIP (0.000s) [451.134378] [062/134] (574s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi [451.192490] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted [451.299840] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.108s) [451.355865] [063/134] (574s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted) [451.422655] Starting subtest: etime-single-wait-all-available-unsubmitted [451.531886] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.107s) [451.588332] [064/134] (574s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling) [451.676619] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling [451.681167] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s) [451.726746] [065/134] (573s left) gem_exec_reloc (basic-wc-read-active) [451.795487] Subtest basic-wc-read-active: SKIP (0.000s) [451.894209] [066/134] (573s left) gem_partial_pwrite_pread (writes-after-reads-display) [451.951360] Subtest writes-after-reads-display: SKIP (0.000s) [452.016344] [067/134] (573s left) syncobj_timeline (multi-wait-all-for-submit-signaled) [452.075055] Starting subtest: multi-wait-all-for-submit-signaled [452.077400] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s) [452.157158] [068/134] (573s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu) [452.245526] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu [452.249636] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [452.315930] [069/134] (573s left) gem_exec_balancer (sliced) [452.376999] Starting subtest: sliced [452.381670] Subtest sliced: SKIP (0.000s) [452.675240] [070/134] (573s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs) [452.774477] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs [452.776882] Starting dynamic subtest: pipe-A-eDP-1 [453.098866] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.292s) [453.112820] Starting dynamic subtest: pipe-B-eDP-1 [454.368579] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.269s) [454.380796] Starting dynamic subtest: pipe-C-eDP-1 [455.592528] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.224s) [455.604110] Starting dynamic subtest: pipe-D-eDP-1 [456.827150] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.233s) [456.829617] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (4.022s) [458.012572] [071/134] (567s left) kms_big_fb (4-tiled-addfb-size-overflow) [458.116623] Starting subtest: 4-tiled-addfb-size-overflow [458.118960] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s) [458.189937] [072/134] (567s left) kms_addfb_basic (addfb25-x-tiled-legacy) [458.287244] Subtest addfb25-x-tiled-legacy: SKIP (0.000s) [458.352550] [073/134] (567s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu) [458.453229] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu [458.457597] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [458.537668] [074/134] (567s left) prime_busy (after-wait) [458.588692] Starting subtest: after-wait [458.590845] Starting dynamic subtest: rcs0 [458.620106] Dynamic subtest rcs0: SUCCESS (0.030s) [458.630500] Starting dynamic subtest: bcs0 [458.676460] Dynamic subtest bcs0: SUCCESS (0.054s) [458.686747] Starting dynamic subtest: vcs0 [458.714750] Dynamic subtest vcs0: SUCCESS (0.039s) [458.724115] Starting dynamic subtest: vcs1 [458.755751] Dynamic subtest vcs1: SUCCESS (0.040s) [458.765035] Starting dynamic subtest: vecs0 [458.795695] Dynamic subtest vecs0: SUCCESS (0.039s) [458.804775] Starting dynamic subtest: ccs0 [458.836160] Dynamic subtest ccs0: SUCCESS (0.040s) [458.946544] Subtest after-wait: SUCCESS (0.358s) [459.002300] [075/134] (567s left) api_intel_bb (add-remove-objects) [459.047513] Starting subtest: add-remove-objects [459.052476] Subtest add-remove-objects: SUCCESS (0.007s) [459.147544] [076/134] (566s left) kms_feature_discovery (display-2x) [459.241350] Starting subtest: display-2x [459.245415] Subtest display-2x: SKIP (0.000s) [459.290750] [077/134] (566s left) gem_ctx_persistence (userptr) [459.353768] Starting subtest: userptr [459.536807] Subtest userptr: SUCCESS (0.183s) [459.593709] [078/134] (566s left) kms_plane_multiple (tiling-none) [459.683754] Starting subtest: tiling-none [459.686074] Starting dynamic subtest: pipe-A-eDP-1 [463.388411] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.702s) [463.398850] Starting dynamic subtest: pipe-B-eDP-1 [467.841602] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.453s) [467.851650] Starting dynamic subtest: pipe-C-eDP-1 [472.183427] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.339s) [472.194160] Starting dynamic subtest: pipe-D-eDP-1 [476.546486] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.362s) [476.549114] Subtest tiling-none: SUCCESS (16.862s) [477.337073] [079/134] (548s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted) [477.391435] Starting subtest: multi-wait-for-submit-unsubmitted-submitted [477.500420] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.108s) [477.556989] [080/134] (548s left) syncobj_wait (multi-wait-for-submit-submitted-signaled) [477.602553] Starting subtest: multi-wait-for-submit-submitted-signaled [477.604793] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s) [477.663094] [081/134] (548s left) kms_getfb (getfb-repeated-different-handles) [477.753323] Starting subtest: getfb-repeated-different-handles [477.755617] Subtest getfb-repeated-different-handles: SUCCESS (0.000s) [477.825916] [082/134] (548s left) gem_pxp (create-regular-buffer) [477.933762] Starting subtest: create-regular-buffer [477.935933] Subtest create-regular-buffer: SUCCESS (0.000s) [478.018784] [083/134] (548s left) gem_workarounds (suspend-resume-context) [478.080412] Starting subtest: suspend-resume-context [494.043760] Subtest suspend-resume-context: SUCCESS (1.312s) [494.176756] [084/134] (532s left) gem_eio (wait-immediate) [494.423703] Starting subtest: wait-immediate [494.813696] Subtest wait-immediate: SUCCESS (0.384s) [494.944383] [085/134] (531s left) prime_vgem (basic-fence-blt) [495.028505] Starting subtest: basic-fence-blt [495.125659] Subtest basic-fence-blt: SUCCESS (0.096s) [495.247928] [086/134] (531s left) kms_big_fb (linear-32bpp-rotate-0) [495.348445] Starting subtest: linear-32bpp-rotate-0 [496.978010] Subtest linear-32bpp-rotate-0: SUCCESS (1.605s) [497.095843] [087/134] (529s left) gem_render_copy_redux (interruptible) [497.171890] Starting subtest: interruptible [497.544361] Subtest interruptible: SUCCESS (0.370s) [497.633405] [088/134] (528s left) kms_vblank (wait-busy-hang) [497.737539] Starting subtest: wait-busy-hang [497.739490] Starting dynamic subtest: pipe-A-eDP-1 [523.712407] Dynamic subtest pipe-A-eDP-1: SUCCESS (25.873s) [523.728953] Starting dynamic subtest: pipe-D-eDP-1 [538.683260] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.969s) [538.685648] Subtest wait-busy-hang: SUCCESS (40.846s) [539.502029] [089/134] (487s left) sw_sync (timeline_closed_signaled) [539.544270] Starting subtest: timeline_closed_signaled [539.546534] Subtest timeline_closed_signaled: SUCCESS (0.000s) [539.587247] [090/134] (487s left) gem_exec_flush (basic-wb-set-default) [539.649337] Starting subtest: basic-wb-set-default [545.111445] Subtest basic-wb-set-default: SUCCESS (5.461s) [545.281382] [091/134] (481s left) gem_mmap_offset (pf-nonblock) [545.333323] Starting subtest: pf-nonblock [545.338807] Subtest pf-nonblock: SUCCESS (0.007s) [545.444056] [092/134] (481s left) gem_exec_balancer (fairslice) [545.507031] Starting subtest: fairslice [548.461988] Subtest fairslice: SUCCESS (2.954s) [548.752382] [093/134] (478s left) kms_dsc (dsc-fractional-bpp-with-bpc-bigjoiner) [548.850311] Starting subtest: dsc-fractional-bpp-with-bpc-bigjoiner [548.880522] Subtest dsc-fractional-bpp-with-bpc-bigjoiner: SKIP (0.001s) [548.924677] [094/134] (477s left) gem_exec_suspend (basic-s3) [548.989300] Starting subtest: basic-S3 [548.991525] Starting dynamic subtest: smem [569.987691] Dynamic subtest smem: SUCCESS (6.941s) [569.990778] Subtest basic-S3: SUCCESS (6.943s) [570.152878] [095/134] (456s left) gem_exec_params (invalid-bsd2-flag-on-blt) [570.212770] Starting subtest: invalid-bsd2-flag-on-blt [570.214708] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s) [570.294752] [096/134] (456s left) kms_getfb (getfb-handle-valid) [570.389719] Starting subtest: getfb-handle-valid [570.392068] Subtest getfb-handle-valid: SUCCESS (0.000s) [570.469954] [097/134] (456s left) gem_exec_reloc (basic-gtt-noreloc) [570.536089] Subtest basic-gtt-noreloc: SKIP (0.000s) [570.611843] [098/134] (456s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs) [570.701674] Starting subtest: crc-primary-suspend-yf-tiled-ccs [570.703951] Starting dynamic subtest: pipe-A-eDP-1 [570.713534] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [570.728695] Starting dynamic subtest: pipe-B-eDP-1 [570.737550] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [570.749038] Starting dynamic subtest: pipe-C-eDP-1 [570.757672] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [570.769115] Starting dynamic subtest: pipe-D-eDP-1 [570.778045] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [570.782440] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.005s) [573.016260] [099/134] (454s left) gem_create (create-ext-set-pat) [573.182054] Starting subtest: create-ext-set-pat [573.184320] Subtest create-ext-set-pat: SUCCESS (0.001s) [573.257019] [100/134] (453s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling) [573.351742] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling [573.356012] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s) [573.405781] [101/134] (453s left) i915_pm_rpm (system-suspend) [575.138231] Starting subtest: system-suspend [592.832141] Subtest system-suspend: SUCCESS (2.841s) [593.208136] [102/134] (434s left) kms_psr (psr2-sprite-mmap-cpu) [593.307573] Starting subtest: psr2-sprite-mmap-cpu [593.309954] Starting dynamic subtest: eDP-1 [595.030694] Dynamic subtest eDP-1: SUCCESS (1.694s) [595.032954] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.695s) [595.897372] [103/134] (431s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c) [595.962049] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s) [596.023502] [104/134] (431s left) gem_userptr_blits (vma-merge) [596.094076] Starting subtest: vma-merge [596.136913] Subtest vma-merge: SUCCESS (0.044s) [596.235285] [105/134] (431s left) gem_ctx_persistence (engines-cleanup) [596.295980] Starting subtest: engines-cleanup [596.298365] Starting dynamic subtest: rcs0 [596.382625] Dynamic subtest rcs0: SUCCESS (0.085s) [596.398131] Starting dynamic subtest: bcs0 [596.426518] Dynamic subtest bcs0: SUCCESS (0.039s) [596.438984] Starting dynamic subtest: vcs0 [596.465937] Dynamic subtest vcs0: SUCCESS (0.039s) [596.479000] Starting dynamic subtest: vcs1 [596.504935] Dynamic subtest vcs1: SUCCESS (0.038s) [596.516134] Starting dynamic subtest: vecs0 [596.560988] Dynamic subtest vecs0: SUCCESS (0.053s) [596.572585] Starting dynamic subtest: ccs0 [596.602932] Dynamic subtest ccs0: SUCCESS (0.039s) [596.605222] Subtest engines-cleanup: SUCCESS (0.305s) [596.662020] [106/134] (430s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt) [596.762159] Starting subtest: fbc-farfromfence-mmap-gtt [596.766145] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s) [596.839809] [107/134] (430s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area) [596.947931] Starting subtest: psr2-plane-move-sf-dmg-area [596.949918] Starting dynamic subtest: pipe-A-eDP-1 [601.514523] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.530s) [601.527726] Starting dynamic subtest: pipe-B-eDP-1 [606.850099] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.310s) [606.852333] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.843s) [607.708077] [108/134] (419s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite) [607.810575] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite [607.814656] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [607.884733] [109/134] (419s left) kms_selftest (drm_dp_mst_helper) [607.919191] Starting subtest: drm_dp_mst_helper [607.983675] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode [608.100434] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.114s) [608.112784] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div [608.209274] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.108s) [608.221927] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode [608.326965] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.116s) [608.329129] Subtest drm_dp_mst_helper: SUCCESS (0.406s) [608.473229] [110/134] (419s left) gem_mmap_gtt (medium-copy-odd) [608.536990] Subtest medium-copy-odd: SKIP (0.000s) [608.608291] [111/134] (419s left) kms_psr (psr2-primary-mmap-gtt) [608.708798] Starting subtest: psr2-primary-mmap-gtt [608.711137] Starting dynamic subtest: eDP-1 [610.129294] Dynamic subtest eDP-1: SKIP (1.414s) [610.134668] Subtest psr2-primary-mmap-gtt: SKIP (1.416s) [610.276975] [112/134] (417s left) kms_plane_scaling (invalid-num-scalers) [610.364599] Starting subtest: invalid-num-scalers [610.366891] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers [610.386264] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.020s) [610.400411] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers [610.421716] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.035s) [610.433030] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers [610.457259] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.035s) [610.468471] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers [610.493916] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.035s) [610.496152] Subtest invalid-num-scalers: SUCCESS (0.131s) [610.577528] [113/134] (417s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180) [610.676855] Starting subtest: linear-max-hw-stride-32bpp-rotate-180 [611.849252] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.168s) [611.917857] [114/134] (415s left) perf_pmu (busy-hang) [611.956669] Starting subtest: busy-hang [611.958396] Starting dynamic subtest: rcs0 [613.234770] Dynamic subtest rcs0: SUCCESS (1.276s) [613.248714] Starting dynamic subtest: bcs0 [614.477660] Dynamic subtest bcs0: SUCCESS (1.239s) [614.492500] Starting dynamic subtest: vcs0 [616.308757] Dynamic subtest vcs0: SUCCESS (1.827s) [616.322524] Starting dynamic subtest: vcs1 [618.290808] Dynamic subtest vcs1: SUCCESS (1.978s) [618.304637] Starting dynamic subtest: vecs0 [620.342778] Dynamic subtest vecs0: SUCCESS (2.048s) [620.356328] Starting dynamic subtest: ccs0 [621.608229] Dynamic subtest ccs0: SUCCESS (1.259s) [621.610651] Subtest busy-hang: SUCCESS (9.638s) [621.697829] [115/134] (406s left) i915_hangman (engine-engine-error) [621.762111] Starting subtest: engine-engine-error [621.764298] Starting dynamic subtest: rcs0 [623.767105] Dynamic subtest rcs0: SUCCESS (2.002s) [623.781391] Starting dynamic subtest: bcs0 [625.746183] Dynamic subtest bcs0: SUCCESS (1.977s) [625.759909] Starting dynamic subtest: vcs0 [627.793743] Dynamic subtest vcs0: SUCCESS (2.046s) [627.807171] Starting dynamic subtest: vcs1 [629.778025] Dynamic subtest vcs1: SUCCESS (1.982s) [629.792180] Starting dynamic subtest: vecs0 [631.761538] Dynamic subtest vecs0: SUCCESS (1.982s) [631.774810] Starting dynamic subtest: ccs0 [633.746301] Dynamic subtest ccs0: SUCCESS (1.982s) [633.749118] Subtest engine-engine-error: SUCCESS (11.988s) [633.810915] [116/134] (394s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt) [633.915615] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt [633.919822] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [633.997415] [117/134] (393s left) kms_getfb (getfb2-into-addfb2) [634.098391] Starting subtest: getfb2-into-addfb2 [634.100704] Subtest getfb2-into-addfb2: SUCCESS (0.000s) [634.186154] [118/134] (393s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode) [634.594847] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s) [635.392765] [119/134] (392s left) kms_joiner (basic-force-ultra-joiner) [635.489971] Starting subtest: basic-force-ultra-joiner [635.494542] Subtest basic-force-ultra-joiner: SKIP (0.000s) [635.538701] [120/134] (392s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled) [635.600814] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [635.603135] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s) [635.695185] [121/134] (392s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [635.802123] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip [636.492976] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.692s) [636.648525] [122/134] (391s left) kms_content_protection (lic-type-0) [636.790267] Starting subtest: lic-type-0 [636.794973] Subtest lic-type-0: SKIP (0.000s) [636.903809] [123/134] (391s left) kms_async_flips (test-cursor) [636.995570] Starting subtest: test-cursor [637.392068] Starting dynamic subtest: pipe-A-eDP-1 [638.205205] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.813s) [638.592525] Starting dynamic subtest: pipe-B-eDP-1 [639.333981] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.752s) [639.716693] Starting dynamic subtest: pipe-C-eDP-1 [640.461377] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.754s) [640.844659] Starting dynamic subtest: pipe-D-eDP-1 [641.600216] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.765s) [641.602563] Subtest test-cursor: SUCCESS (4.607s) [642.754560] [124/134] (385s left) prime_mmap (test_refcounting) [642.809262] Starting subtest: test_refcounting [642.811418] Starting dynamic subtest: test_refcounting-smem [642.840808] Dynamic subtest test_refcounting-smem: SUCCESS (0.033s) [642.843218] Subtest test_refcounting: SUCCESS (0.033s) [642.935995] [125/134] (385s left) sysfs_preempt_timeout (timeout) [642.995747] Starting subtest: timeout [642.997659] Starting dynamic subtest: vecs0 [652.781425] Dynamic subtest vecs0: SUCCESS (9.783s) [652.793934] Starting dynamic subtest: ccs0 [654.113472] Dynamic subtest ccs0: SUCCESS (1.331s) [654.126540] Starting dynamic subtest: vcs0 [663.791434] Dynamic subtest vcs0: SUCCESS (9.672s) [663.804510] Starting dynamic subtest: bcs0 [665.088658] Dynamic subtest bcs0: SUCCESS (1.297s) [665.102801] Starting dynamic subtest: rcs0 [666.351158] Dynamic subtest rcs0: SUCCESS (1.259s) [666.364807] Starting dynamic subtest: vcs1 [675.821109] Dynamic subtest vcs1: SUCCESS (9.463s) [675.824185] Subtest timeout: SUCCESS (32.820s) [675.879348] [126/134] (352s left) kms_frontbuffer_tracking (fbc-2p-rte) [675.972124] Starting subtest: fbc-2p-rte [675.976635] Subtest fbc-2p-rte: SKIP (0.000s) [676.043927] [127/134] (352s left) gem_exec_schedule (deep) [676.221507] Starting subtest: deep [676.224281] Starting dynamic subtest: rcs0 [681.973988] Dynamic subtest rcs0: SKIP (5.746s) [681.987720] Starting dynamic subtest: vcs0 [693.142016] Dynamic subtest vcs0: SUCCESS (11.167s) [693.159440] Starting dynamic subtest: vcs1 [704.973647] Dynamic subtest vcs1: SUCCESS (11.834s) [704.987649] Starting dynamic subtest: vecs0 [716.581872] Dynamic subtest vecs0: SUCCESS (11.607s) [716.596620] Starting dynamic subtest: ccs0 [729.170095] Dynamic subtest ccs0: SUCCESS (12.586s) [729.175157] Subtest deep: SUCCESS (52.948s) [731.202221] [128/134] (297s left) kms_flip (2x-flip-vs-absolute-wf_vblank) [731.297080] Starting subtest: 2x-flip-vs-absolute-wf_vblank [731.305768] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.011s) [731.407511] [129/134] (297s left) kms_chamelium_audio (dp-audio) [731.805359] Subtest dp-audio: SKIP (0.000s) [732.594979] [130/134] (295s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite) [732.699499] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite [732.703624] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [732.783427] [131/134] (295s left) gem_ringfill (engines-basic) [738.895280] Starting subtest: engines-basic [738.897733] Starting dynamic subtest: rcs0 [739.076393] Dynamic subtest rcs0: SUCCESS (0.180s) [739.092776] Starting dynamic subtest: bcs0 [739.163838] Dynamic subtest bcs0: SUCCESS (0.085s) [739.179220] Starting dynamic subtest: vcs0 [739.284013] Dynamic subtest vcs0: SUCCESS (0.117s) [739.299036] Starting dynamic subtest: vcs1 [739.392567] Dynamic subtest vcs1: SUCCESS (0.107s) [739.406850] Starting dynamic subtest: vecs0 [739.497097] Dynamic subtest vecs0: SUCCESS (0.102s) [739.511977] Starting dynamic subtest: ccs0 [739.546497] Dynamic subtest ccs0: SUCCESS (0.047s) [739.548937] Subtest engines-basic: SUCCESS (0.653s) [739.617031] [132/134] (288s left) kms_cursor_legacy (cursorb-vs-flipa-atomic) [739.759913] Starting subtest: cursorB-vs-flipA-atomic [739.764413] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s) [739.923058] [133/134] (288s left) perf (per-context-mode-unprivileged) [740.027247] Starting subtest: per-context-mode-unprivileged [740.032109] Subtest per-context-mode-unprivileged: SKIP (0.000s) [740.081567] [134/134] (288s left) kms_psr (fbc-pr-primary-mmap-cpu) [740.180292] Starting subtest: fbc-pr-primary-mmap-cpu [740.184371] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s) [740.231278] Closing watchdogs results: parsing output: 0/ for test: kms_psr results: parsing output: 1/ for test: i915_drm_fdinfo results: parsing output: 2/ for test: dumb_buffer results: parsing output: 3/ for test: kms_cursor_legacy results: parsing output: 4/ for test: kms_ccs results: parsing output: 5/ for test: kms_cursor_legacy results: parsing output: 6/ for test: kms_frontbuffer_tracking results: parsing output: 7/ for test: gem_mmap_wc results: parsing output: 8/ for test: kms_psr2_sf results: parsing output: 9/ for test: kms_pm_rpm results: parsing output: 10/ for test: kms_frontbuffer_tracking results: parsing output: 11/ for test: kms_chamelium_frames results: parsing output: 12/ for test: gem_ccs results: parsing output: 13/ for test: gem_gtt_cpu_tlb results: parsing output: 14/ for test: syncobj_timeline results: parsing output: 15/ for test: kms_plane_scaling results: parsing output: 16/ for test: api_intel_bb results: parsing output: 17/ for test: gem_ctx_shared results: parsing output: 18/ for test: gem_exec_reloc results: parsing output: 19/ for test: syncobj_wait results: parsing output: 20/ for test: gen9_exec_parse results: parsing output: 21/ for test: kms_color results: parsing output: 22/ for test: kms_big_fb results: parsing output: 23/ for test: kms_big_fb results: parsing output: 24/ for test: gem_exec_schedule results: parsing output: 25/ for test: gem_huc_copy results: parsing output: 26/ for test: kms_frontbuffer_tracking results: parsing output: 27/ for test: kms_dp_linktrain_fallback results: parsing output: 28/ for test: gem_exec_schedule results: parsing output: 29/ for test: kms_plane results: parsing output: 30/ for test: gem_softpin results: parsing output: 31/ for test: gem_ctx_bad_destroy results: parsing output: 32/ for test: gem_exec_fence results: parsing output: 33/ for test: kms_cursor_crc results: parsing output: 34/ for test: kms_frontbuffer_tracking results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: kms_flip results: parsing output: 37/ for test: gem_exec_params results: parsing output: 38/ for test: syncobj_timeline results: parsing output: 39/ for test: kms_cursor_crc results: parsing output: 40/ for test: gem_mmap results: parsing output: 41/ for test: gem_mmap_gtt results: parsing output: 42/ for test: kms_cursor_legacy results: parsing output: 43/ for test: kms_ccs results: parsing output: 44/ for test: i915_selftest results: parsing output: 45/ for test: kms_pm_rpm results: parsing output: 46/ for test: gem_mmap_gtt results: parsing output: 47/ for test: gem_render_copy results: parsing output: 48/ for test: kms_frontbuffer_tracking results: parsing output: 49/ for test: kms_cursor_edge_walk results: parsing output: 50/ for test: kms_pipe_crc_basic results: parsing output: 51/ for test: kms_frontbuffer_tracking results: parsing output: 52/ for test: kms_big_fb results: parsing output: 53/ for test: kms_plane_cursor results: parsing output: 54/ for test: gem_userptr_blits results: parsing output: 55/ for test: kms_psr results: parsing output: 56/ for test: gem_exec_whisper results: parsing output: 57/ for test: perf_pmu results: parsing output: 58/ for test: kms_vblank results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: gem_mmap_gtt results: parsing output: 61/ for test: syncobj_timeline results: parsing output: 62/ for test: syncobj_timeline results: parsing output: 63/ for test: kms_flip_scaled_crc results: parsing output: 64/ for test: gem_exec_reloc results: parsing output: 65/ for test: gem_partial_pwrite_pread results: parsing output: 66/ for test: syncobj_timeline results: parsing output: 67/ for test: kms_frontbuffer_tracking results: parsing output: 68/ for test: gem_exec_balancer results: parsing output: 69/ for test: kms_ccs results: parsing output: 70/ for test: kms_big_fb results: parsing output: 71/ for test: kms_addfb_basic results: parsing output: 72/ for test: kms_frontbuffer_tracking results: parsing output: 73/ for test: prime_busy results: parsing output: 74/ for test: api_intel_bb results: parsing output: 75/ for test: kms_feature_discovery results: parsing output: 76/ for test: gem_ctx_persistence results: parsing output: 77/ for test: kms_plane_multiple results: parsing output: 78/ for test: syncobj_wait results: parsing output: 79/ for test: syncobj_wait results: parsing output: 80/ for test: kms_getfb results: parsing output: 81/ for test: gem_pxp results: parsing output: 82/ for test: gem_workarounds results: parsing output: 83/ for test: gem_eio results: parsing output: 84/ for test: prime_vgem results: parsing output: 85/ for test: kms_big_fb results: parsing output: 86/ for test: gem_render_copy_redux results: parsing output: 87/ for test: kms_vblank results: parsing output: 88/ for test: sw_sync results: parsing output: 89/ for test: gem_exec_flush results: parsing output: 90/ for test: gem_mmap_offset results: parsing output: 91/ for test: gem_exec_balancer results: parsing output: 92/ for test: kms_dsc results: parsing output: 93/ for test: gem_exec_suspend results: parsing output: 94/ for test: gem_exec_params results: parsing output: 95/ for test: kms_getfb results: parsing output: 96/ for test: gem_exec_reloc results: parsing output: 97/ for test: kms_ccs results: parsing output: 98/ for test: gem_create results: parsing output: 99/ for test: kms_flip_scaled_crc results: parsing output: 100/ for test: i915_pm_rpm results: parsing output: 101/ for test: kms_psr results: parsing output: 102/ for test: kms_pipe_b_c_ivb results: parsing output: 103/ for test: gem_userptr_blits results: parsing output: 104/ for test: gem_ctx_persistence results: parsing output: 105/ for test: kms_frontbuffer_tracking results: parsing output: 106/ for test: kms_psr2_sf results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: kms_selftest results: parsing output: 109/ for test: gem_mmap_gtt results: parsing output: 110/ for test: kms_psr results: parsing output: 111/ for test: kms_plane_scaling results: parsing output: 112/ for test: kms_big_fb results: parsing output: 113/ for test: perf_pmu results: parsing output: 114/ for test: i915_hangman results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: kms_getfb results: parsing output: 117/ for test: kms_chamelium_hpd results: parsing output: 118/ for test: kms_joiner results: parsing output: 119/ for test: syncobj_wait results: parsing output: 120/ for test: kms_big_fb results: parsing output: 121/ for test: kms_content_protection results: parsing output: 122/ for test: kms_async_flips results: parsing output: 123/ for test: prime_mmap results: parsing output: 124/ for test: sysfs_preempt_timeout results: parsing output: 125/ for test: kms_frontbuffer_tracking results: parsing output: 126/ for test: gem_exec_schedule results: parsing output: 127/ for test: kms_flip results: parsing output: 128/ for test: kms_chamelium_audio results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: gem_ringfill results: parsing output: 131/ for test: kms_cursor_legacy results: parsing output: 132/ for test: perf results: parsing output: 133/ for test: kms_psr Done.