[58.458523] Initializing watchdogs [58.458573] /dev/watchdog0 [58.474981] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [58.479422] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.481966] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.485540] [001/155] (960s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-pwrite) [58.611230] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-pwrite [58.615420] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [58.703573] [002/155] (960s left) prime_busy (after-wait) [58.762223] Starting subtest: after-wait [58.766811] Starting dynamic subtest: rcs0 [58.791271] Dynamic subtest rcs0: SUCCESS (0.026s) [58.798405] Starting dynamic subtest: bcs0 [58.830988] Dynamic subtest bcs0: SUCCESS (0.039s) [58.838261] Starting dynamic subtest: vcs0 [58.871742] Dynamic subtest vcs0: SUCCESS (0.040s) [58.881609] Starting dynamic subtest: vcs1 [58.912558] Dynamic subtest vcs1: SUCCESS (0.040s) [58.921102] Starting dynamic subtest: vecs0 [58.953089] Dynamic subtest vecs0: SUCCESS (0.040s) [58.962064] Starting dynamic subtest: ccs0 [58.993062] Dynamic subtest ccs0: SUCCESS (0.040s) [59.101651] Subtest after-wait: SUCCESS (0.338s) [59.174280] [003/155] (959s left) i915_pm_freq_api (freq-reset) [59.228509] Starting subtest: freq-reset [59.230916] Starting dynamic subtest: gt0 [59.381492] Dynamic subtest gt0: SUCCESS (0.151s) [59.389296] Starting dynamic subtest: gt1 [59.515030] Dynamic subtest gt1: SUCCESS (0.133s) [59.517968] Subtest freq-reset: SUCCESS (0.285s) [59.587739] [004/155] (959s left) kms_getfb (getfb2-handle-closed) [59.680006] Starting subtest: getfb2-handle-closed [59.682367] Subtest getfb2-handle-closed: SUCCESS (0.000s) [59.800518] [005/155] (959s left) gem_exec_fence (invalid-timeline-fence-array) [60.350268] Starting subtest: invalid-timeline-fence-array [60.353087] Subtest invalid-timeline-fence-array: SUCCESS (0.006s) [61.425775] [FACT gem_exec_fence (invalid-timeline-fence-array)] new: kernel.kmod_is_loaded.vgem: true [61.428871] [006/155] (957s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping) [61.525093] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping [61.566137] Starting dynamic subtest: pipe-A-plane-0 [61.866705] Dynamic subtest pipe-A-plane-0: SUCCESS (0.301s) [61.877615] Starting dynamic subtest: pipe-A-plane-3 [62.102707] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s) [63.260133] Starting dynamic subtest: pipe-B-plane-0 [63.554204] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s) [63.563524] Starting dynamic subtest: pipe-B-plane-3 [63.787755] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s) [64.099942] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.574s) [64.939203] [007/155] (954s left) gem_vm_create (create-ext) [64.994971] Starting subtest: create-ext [64.999539] Subtest create-ext: SUCCESS (0.005s) [65.125759] [008/155] (954s left) kms_psr (psr-cursor-plane-onoff) [65.214899] Starting subtest: psr-cursor-plane-onoff [65.217233] Starting dynamic subtest: eDP-1 [66.943700] Dynamic subtest eDP-1: SUCCESS (1.730s) [66.946135] Subtest psr-cursor-plane-onoff: SUCCESS (1.730s) [67.820842] [009/155] (951s left) gem_ctx_bad_destroy (invalid-ctx) [67.888869] Starting subtest: invalid-ctx [67.891600] Subtest invalid-ctx: SUCCESS (0.000s) [67.965208] [010/155] (951s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt) [68.063214] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt [68.067420] Subtest psrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [68.141137] [011/155] (951s left) gem_exec_reloc (basic-cpu-noreloc) [68.202142] Subtest basic-cpu-noreloc: SKIP (0.000s) [68.265773] [012/155] (951s left) gem_mmap_gtt (cpuset-medium-copy) [68.326305] Subtest cpuset-medium-copy: SKIP (0.000s) [68.393477] [013/155] (951s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-fullscreen) [68.496234] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-fullscreen [68.500645] Subtest fbchdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [68.609763] [014/155] (950s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180) [68.718851] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180 [68.722821] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s) [68.814677] [015/155] (950s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-shrfb-pgflip-blt) [68.916265] Starting subtest: psrhdr-1p-primscrn-shrfb-pgflip-blt [68.919971] Subtest psrhdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [69.023210] [016/155] (950s left) gem_exercise_blt (fast-copy) [69.089328] Starting subtest: fast-copy [69.091161] Starting dynamic subtest: linear-smem-smem [69.114290] Dynamic subtest linear-smem-smem: SUCCESS (0.025s) [69.123198] Starting dynamic subtest: xmajor-smem-smem [69.132886] Dynamic subtest xmajor-smem-smem: SUCCESS (0.018s) [69.140633] Starting dynamic subtest: tile4-smem-smem [69.157297] Dynamic subtest tile4-smem-smem: SUCCESS (0.024s) [69.168576] Starting dynamic subtest: tile64-smem-smem [69.174531] Dynamic subtest tile64-smem-smem: SUCCESS (0.017s) [69.176473] Subtest fast-copy: SUCCESS (0.085s) [69.300747] [017/155] (950s left) i915_pm_rpm (debugfs-read) [71.445067] Starting subtest: debugfs-read [72.603539] Subtest debugfs-read: SUCCESS (1.157s) [73.030371] [018/155] (946s left) vgem_slow (nohang) [73.096484] Starting subtest: nohang [83.453985] Subtest nohang: SUCCESS (10.359s) [83.519939] [019/155] (936s left) gem_eio (wait-10ms) [83.730335] Starting subtest: wait-10ms [84.070347] Subtest wait-10ms: SUCCESS (0.340s) [84.213775] [020/155] (935s left) prime_mmap_coherency (write) [84.263888] Starting subtest: write [89.643373] Subtest write: SUCCESS (5.378s) [89.797060] [021/155] (930s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-mmap-cpu) [89.898907] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-mmap-cpu [89.903453] Subtest hdr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [90.027267] [022/155] (929s left) gem_userptr_blits (forbidden-operations) [90.093774] Starting subtest: forbidden-operations [90.097837] Subtest forbidden-operations: SKIP (0.000s) [90.224671] [023/155] (929s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [90.323263] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt [90.327272] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [90.423957] [024/155] (929s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75) [90.513189] Starting subtest: planes-unity-scaling-downscale-factor-0-75 [90.515545] Starting dynamic subtest: pipe-A [90.577469] Dynamic subtest pipe-A: SUCCESS (0.064s) [90.586326] Starting dynamic subtest: pipe-B [91.707489] Dynamic subtest pipe-B: SUCCESS (1.129s) [91.717134] Starting dynamic subtest: pipe-C [92.828619] Dynamic subtest pipe-C: SUCCESS (1.120s) [92.838168] Starting dynamic subtest: pipe-D [93.958579] Dynamic subtest pipe-D: SUCCESS (1.129s) [93.961050] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.445s) [95.194683] [025/155] (924s left) kms_vblank (query-idle) [95.297773] Starting subtest: query-idle [95.300063] Starting dynamic subtest: pipe-A-eDP-1 [97.044522] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.747s) [97.060726] Starting dynamic subtest: pipe-D-eDP-1 [99.459081] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.413s) [99.461398] Subtest query-idle: SUCCESS (4.163s) [100.305963] [026/155] (919s left) kms_flip (blocking-wf_vblank) [100.393602] Starting subtest: blocking-wf_vblank [100.396062] Starting dynamic subtest: A-eDP1 [109.341533] Dynamic subtest A-eDP1: SUCCESS (8.947s) [109.352490] Starting dynamic subtest: B-eDP1 [118.267669] Dynamic subtest B-eDP1: SUCCESS (8.925s) [118.276862] Starting dynamic subtest: C-eDP1 [127.193416] Dynamic subtest C-eDP1: SUCCESS (8.924s) [127.202141] Starting dynamic subtest: D-eDP1 [136.125462] Dynamic subtest D-eDP1: SUCCESS (8.930s) [136.130606] Subtest blocking-wf_vblank: SUCCESS (35.738s) [137.344152] [027/155] (882s left) gem_userptr_blits (process-exit) [137.410089] Starting subtest: process-exit [137.415215] Subtest process-exit: SUCCESS (0.007s) [137.544811] [028/155] (882s left) kms_vblank (wait-idle-hang) [137.627165] Starting subtest: wait-idle-hang [137.629403] Starting dynamic subtest: pipe-A-eDP-1 [164.125355] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.495s) [164.141516] Starting dynamic subtest: pipe-D-eDP-1 [179.110925] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.981s) [179.113140] Subtest wait-idle-hang: SUCCESS (41.481s) [179.939650] [029/155] (840s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [180.038355] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [180.040644] Starting dynamic subtest: pipe-A-default-mode [181.180942] Dynamic subtest pipe-A-default-mode: SKIP (1.138s) [181.186602] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.139s) [181.335848] [030/155] (838s left) kms_big_fb (x-tiled-8bpp-rotate-90) [181.434381] Starting subtest: x-tiled-8bpp-rotate-90 [181.454823] Subtest x-tiled-8bpp-rotate-90: SKIP (0.020s) [181.581211] [031/155] (838s left) kms_feature_discovery (display-1x) [181.672962] Starting subtest: display-1x [181.675371] Subtest display-1x: SUCCESS (0.000s) [181.745946] [032/155] (838s left) gem_pwrite (basic-exhaustion) [181.794101] Subtest basic-exhaustion: SKIP (0.000s) [181.849051] [033/155] (838s left) kms_big_fb (y-tiled-addfb) [181.943252] Starting subtest: y-tiled-addfb [181.947531] Subtest y-tiled-addfb: SKIP (0.000s) [182.049609] [034/155] (838s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-mmap-wc) [182.154036] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-mmap-wc [182.157711] Subtest hdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [182.252977] [035/155] (838s left) i915_drm_fdinfo (isolation) [182.296578] Starting subtest: isolation [182.298721] Starting dynamic subtest: rcs0 [182.324352] Dynamic subtest rcs0: SKIP (0.026s) [182.334739] Starting dynamic subtest: bcs0 [182.338180] Dynamic subtest bcs0: SKIP (0.001s) [182.346536] Starting dynamic subtest: vcs0 [182.350132] Dynamic subtest vcs0: SKIP (0.001s) [182.358280] Starting dynamic subtest: vcs1 [182.361727] Dynamic subtest vcs1: SKIP (0.000s) [182.370509] Starting dynamic subtest: vecs0 [182.373893] Dynamic subtest vecs0: SKIP (0.000s) [182.383793] Starting dynamic subtest: ccs0 [182.387334] Dynamic subtest ccs0: SKIP (0.000s) [182.390714] Subtest isolation: SKIP (0.032s) [182.425842] [036/155] (838s left) kms_psr (pr-basic) [182.518068] Starting subtest: pr-basic [182.521851] Subtest pr-basic: SKIP (0.000s) [182.590065] [037/155] (837s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area) [182.682963] Starting subtest: psr2-primary-plane-update-sf-dmg-area [182.685073] Starting dynamic subtest: pipe-A-eDP-1 [188.662159] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.982s) [188.672782] Starting dynamic subtest: pipe-B-eDP-1 [195.329016] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.665s) [195.331356] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.649s) [196.206254] [038/155] (824s left) gem_mmap_gtt (basic-copy) [196.264517] Subtest basic-copy: SKIP (0.000s) [196.321523] [039/155] (824s left) gem_partial_pwrite_pread (writes-after-reads-display) [196.377083] Subtest writes-after-reads-display: SKIP (0.000s) [196.442778] [040/155] (824s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-indfb-msflip-blt) [196.533594] Starting subtest: psrhdr-2p-scndscrn-indfb-msflip-blt [196.537853] Subtest psrhdr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s) [196.635035] [041/155] (824s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled) [196.682053] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled [196.684511] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.001s) [196.778393] [042/155] (823s left) prime_mmap (test_correct_cpu_write) [196.827717] Starting subtest: test_correct_cpu_write [196.829656] Starting dynamic subtest: test_correct_cpu_write-smem [196.831583] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s) [196.833531] Subtest test_correct_cpu_write: SUCCESS (0.001s) [196.906076] [043/155] (823s left) kms_setmode (invalid-clone-exclusive-crtc) [196.960828] Starting subtest: invalid-clone-exclusive-crtc [196.967533] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s) [197.047849] [044/155] (823s left) gem_exec_params (invalid-fence-in-submit) [197.113489] Starting subtest: invalid-fence-in-submit [197.118102] Subtest invalid-fence-in-submit: SUCCESS (0.005s) [197.246874] [045/155] (823s left) kms_cursor_crc (cursor-random-64x64) [197.428223] Starting subtest: cursor-random-64x64 [197.432741] Starting dynamic subtest: pipe-A-eDP-1 [200.797474] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.365s) [200.832298] Starting dynamic subtest: pipe-D-eDP-1 [204.813452] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.989s) [204.815614] Subtest cursor-random-64x64: SUCCESS (7.384s) [205.676054] [046/155] (815s left) kms_cdclk (mode-transition) [205.773138] Starting subtest: mode-transition [205.775491] Starting dynamic subtest: pipe-A-eDP-1 [206.075360] Dynamic subtest pipe-A-eDP-1: SKIP (0.301s) [206.084933] Starting dynamic subtest: pipe-B-eDP-1 [206.089850] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [206.100505] Starting dynamic subtest: pipe-C-eDP-1 [206.105319] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [206.114197] Starting dynamic subtest: pipe-D-eDP-1 [206.118933] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [206.123511] Subtest mode-transition: SKIP (0.308s) [206.904275] [047/155] (814s left) perf_pmu (event-wait) [206.941686] Starting subtest: event-wait [206.943965] Starting dynamic subtest: rcs0 [206.948147] Dynamic subtest rcs0: SKIP (0.000s) [206.952200] Subtest event-wait: SKIP (0.000s) [207.044642] [048/155] (813s left) syncobj_timeline (multi-wait-available-submitted-signaled) [207.103237] Starting subtest: multi-wait-available-submitted-signaled [207.105543] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.001s) [207.201778] [049/155] (813s left) gem_pxp (protected-encrypted-src-copy-not-readible) [207.325947] Starting subtest: protected-encrypted-src-copy-not-readible [207.437815] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.112s) [207.556329] [050/155] (813s left) gem_exec_balancer (hog) [207.626876] Starting subtest: hog [207.631852] Subtest hog: SKIP (0.000s) [207.932273] [051/155] (813s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen) [208.035994] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen [208.040072] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [208.146483] [052/155] (813s left) kms_frontbuffer_tracking (hdr-2p-primscrn-indfb-plflip-blt) [208.252670] Starting subtest: hdr-2p-primscrn-indfb-plflip-blt [208.256692] Subtest hdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [208.337344] [053/155] (812s left) gem_exec_balancer (parallel-out-fence) [208.602186] Starting subtest: parallel-out-fence [209.770307] Subtest parallel-out-fence: SUCCESS (1.169s) [209.874958] [054/155] (811s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt) [209.972643] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt [209.977310] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [210.063563] [055/155] (811s left) gem_ctx_persistence (engines-mixed-process) [210.126066] Starting subtest: engines-mixed-process [210.128488] Starting dynamic subtest: rcs0 [211.357184] Dynamic subtest rcs0: SUCCESS (1.228s) [211.368668] Starting dynamic subtest: bcs0 [213.341823] Dynamic subtest bcs0: SUCCESS (1.986s) [213.352467] Starting dynamic subtest: vcs0 [215.357976] Dynamic subtest vcs0: SUCCESS (2.015s) [215.368873] Starting dynamic subtest: vcs1 [217.309718] Dynamic subtest vcs1: SUCCESS (1.950s) [217.320669] Starting dynamic subtest: vecs0 [219.309756] Dynamic subtest vecs0: SUCCESS (1.999s) [219.321313] Starting dynamic subtest: ccs0 [221.346845] Dynamic subtest ccs0: SUCCESS (2.036s) [221.349233] Subtest engines-mixed-process: SUCCESS (11.221s) [221.442074] [056/155] (799s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs) [221.545149] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs [221.549759] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s) [222.649980] [057/155] (798s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt) [222.753811] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt [222.758224] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [222.845485] [058/155] (798s left) api_intel_allocator (reopen-fork) [222.894834] Starting subtest: reopen-fork [226.379185] Subtest reopen-fork: SUCCESS (3.484s) [226.454629] [059/155] (794s left) gem_exec_suspend (basic-s4-devices) [226.503303] Starting subtest: basic-S4-devices [226.505666] Starting dynamic subtest: smem [239.329568] Dynamic subtest smem: SUCCESS (12.824s) [239.332542] Subtest basic-S4-devices: SUCCESS (12.826s) [248.542694] [060/155] (781s left) kms_color (ctm-red-to-blue) [248.660060] Starting subtest: ctm-red-to-blue [248.662248] Starting dynamic subtest: pipe-A-eDP-1 [249.372238] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.711s) [249.382831] Starting dynamic subtest: pipe-B-eDP-1 [250.794637] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.422s) [250.804937] Starting dynamic subtest: pipe-C-eDP-1 [252.158620] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.362s) [252.169707] Starting dynamic subtest: pipe-D-eDP-1 [253.590747] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.431s) [253.593051] Subtest ctm-red-to-blue: SUCCESS (4.931s) [254.415531] [061/155] (776s left) gem_ccs (block-copy-uncompressed) [254.474410] Starting subtest: block-copy-uncompressed [254.476763] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem [254.497876] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.023s) [254.508065] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem [254.515687] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s) [254.525680] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem [254.533086] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s) [254.543155] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem [254.550870] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s) [254.553295] Subtest block-copy-uncompressed: SUCCESS (0.077s) [254.685998] [062/155] (775s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-onoff) [254.789990] Starting subtest: psrhdr-1p-primscrn-cur-indfb-onoff [254.794465] Subtest psrhdr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s) [254.885230] [063/155] (775s left) gem_ctx_shared (q-smoketest-all) [254.950502] Starting subtest: Q-smoketest-all [287.325983] Subtest Q-smoketest-all: SUCCESS (32.328s) [288.456872] [064/155] (742s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc) [288.552306] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc [288.554614] Starting dynamic subtest: pipe-A-eDP-1 [288.576655] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [288.588155] Starting dynamic subtest: pipe-B-eDP-1 [288.609181] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [288.618998] Starting dynamic subtest: pipe-C-eDP-1 [288.641336] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [288.650849] Starting dynamic subtest: pipe-D-eDP-1 [288.672421] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [288.676735] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [290.871520] [065/155] (739s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt) [290.975797] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt [298.307201] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.336s) [298.445517] [066/155] (732s left) kms_psr (fbc-psr2-dpms) [298.553114] Starting subtest: fbc-psr2-dpms [298.555279] Starting dynamic subtest: eDP-1 [298.559184] Dynamic subtest eDP-1: SKIP (0.000s) [298.563175] Subtest fbc-psr2-dpms: SKIP (0.001s) [298.630782] [067/155] (732s left) kms_pm_rpm (dpms-lpsp) [300.455788] Starting subtest: dpms-lpsp [300.864958] Subtest dpms-lpsp: SUCCESS (0.412s) [300.989899] [068/155] (729s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs) [301.079999] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs [301.082307] Starting dynamic subtest: pipe-A-eDP-1 [301.105329] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [301.117928] Starting dynamic subtest: pipe-B-eDP-1 [301.139255] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [301.150288] Starting dynamic subtest: pipe-C-eDP-1 [301.171989] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [301.183058] Starting dynamic subtest: pipe-D-eDP-1 [301.204494] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [301.208866] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.004s) [303.415229] [069/155] (727s left) perf_pmu (rc6) [303.456919] Starting subtest: rc6 [303.459108] Starting dynamic subtest: gt0 [309.811808] Dynamic subtest gt0: SUCCESS (6.353s) [309.825267] Starting dynamic subtest: runtime-pm-gt0 [317.533304] Dynamic subtest runtime-pm-gt0: SUCCESS (7.719s) [317.547068] Starting dynamic subtest: runtime-pm-long-gt0 [329.972784] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.437s) [329.985825] Starting dynamic subtest: other-idle-gt0 [336.317072] Dynamic subtest other-idle-gt0: SUCCESS (6.342s) [336.329887] Starting dynamic subtest: gt1 [342.659494] Dynamic subtest gt1: SUCCESS (6.339s) [342.673027] Starting dynamic subtest: runtime-pm-gt1 [350.147995] Dynamic subtest runtime-pm-gt1: SUCCESS (7.487s) [350.160698] Starting dynamic subtest: runtime-pm-long-gt1 [362.586931] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.436s) [362.600896] Starting dynamic subtest: other-idle-gt1 [368.930723] Dynamic subtest other-idle-gt1: SUCCESS (6.341s) [368.933605] Subtest rc6: SUCCESS (65.471s) [370.084669] [070/155] (660s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt) [370.189167] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt [377.714691] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.530s) [377.830329] [071/155] (653s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling) [377.923146] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling [377.927225] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s) [377.973311] [072/155] (653s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc) [378.073862] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc [384.740082] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.670s) [384.839277] [073/155] (646s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled) [384.901160] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled [384.905240] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s) [385.065314] [074/155] (646s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-mmap-cpu) [385.161525] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-mmap-cpu [385.165701] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [385.238780] [075/155] (645s left) kms_async_flips (test-time-stamp-atomic) [385.324956] Starting subtest: test-time-stamp-atomic [385.712402] Starting dynamic subtest: pipe-A-eDP-1 [386.504100] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.790s) [386.899215] Starting dynamic subtest: pipe-B-eDP-1 [387.742426] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.853s) [388.117051] Starting dynamic subtest: pipe-C-eDP-1 [388.896892] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.786s) [389.275932] Starting dynamic subtest: pipe-D-eDP-1 [390.037102] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.768s) [390.039479] Subtest test-time-stamp-atomic: SUCCESS (4.712s) [391.196051] [076/155] (639s left) gem_softpin (evict-snoop-interruptible) [391.260415] Starting subtest: evict-snoop-interruptible [391.264978] Subtest evict-snoop-interruptible: SKIP (0.000s) [391.349437] [077/155] (639s left) kms_lease (empty-lease) [391.438088] Starting subtest: empty-lease [391.440590] Starting dynamic subtest: pipe-A-eDP-1 [391.442976] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [391.456268] Starting dynamic subtest: pipe-B-eDP-1 [391.458460] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [391.469737] Starting dynamic subtest: pipe-C-eDP-1 [391.472026] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [391.482442] Starting dynamic subtest: pipe-D-eDP-1 [391.484639] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [391.486867] Subtest empty-lease: SUCCESS (0.010s) [391.535882] [078/155] (639s left) kms_lease (lessee-list) [391.633626] Starting subtest: lessee-list [391.636098] Starting dynamic subtest: pipe-A-eDP-1 [391.638475] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [391.649544] Starting dynamic subtest: pipe-B-eDP-1 [391.651770] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [391.662275] Starting dynamic subtest: pipe-C-eDP-1 [391.664481] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [391.674928] Starting dynamic subtest: pipe-D-eDP-1 [391.677147] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [391.679316] Subtest lessee-list: SUCCESS (0.009s) [391.725204] [079/155] (639s left) kms_content_protection (dp-mst-type-1-suspend-resume) [391.864624] Starting subtest: dp-mst-type-1-suspend-resume [391.868761] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s) [391.973738] [080/155] (639s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [392.064034] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [392.068210] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s) [392.114263] [081/155] (639s left) perf (gen12-group-concurrent-oa-buffer-read) [392.223541] Starting subtest: gen12-group-concurrent-oa-buffer-read [402.263635] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.039s) [402.314555] [082/155] (629s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle) [402.443389] Starting subtest: short-busy-flip-before-cursor-toggle [402.447898] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s) [402.584150] [083/155] (628s left) vgem_basic (sysfs) [402.634954] Starting subtest: sysfs [402.637265] Subtest sysfs: SUCCESS (0.001s) [402.676557] [084/155] (628s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-blt) [402.783693] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-blt [402.787950] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [402.852590] [085/155] (628s left) kms_cursor_crc (cursor-offscreen-256x256) [403.082846] Starting subtest: cursor-offscreen-256x256 [403.088291] Starting dynamic subtest: pipe-A-eDP-1 [405.032173] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.945s) [405.063125] Starting dynamic subtest: pipe-D-eDP-1 [407.611259] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.557s) [407.613606] Subtest cursor-offscreen-256x256: SUCCESS (4.528s) [408.458156] [086/155] (623s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move) [408.564756] Starting subtest: fbc-2p-scndscrn-cur-indfb-move [408.568768] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [408.635565] [087/155] (623s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render) [408.724069] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render [415.615164] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.896s) [415.737805] [088/155] (615s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf) [415.851240] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf [415.853415] Starting dynamic subtest: pipe-A-eDP-1 [426.834126] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.986s) [426.846983] Starting dynamic subtest: pipe-B-eDP-1 [438.519079] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.682s) [438.521361] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (22.671s) [439.349627] [089/155] (592s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite) [439.457565] Starting subtest: fbc-rgb565-draw-pwrite [444.149306] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.699s) [445.287280] [090/155] (586s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe) [445.675972] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s) [446.512410] [091/155] (585s left) api_intel_bb (object-reloc-keep-cache) [446.573146] Starting subtest: object-reloc-keep-cache [446.577307] Subtest object-reloc-keep-cache: SKIP (0.003s) [446.667395] [092/155] (585s left) gem_partial_pwrite_pread (reads) [446.722508] Subtest reads: SKIP (0.000s) [446.798245] [093/155] (585s left) gem_softpin (evict-active) [446.860144] Starting subtest: evict-active [446.866058] Subtest evict-active: SUCCESS (0.006s) [446.969590] [094/155] (585s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [447.073916] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt [447.077983] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [447.151617] [095/155] (584s left) i915_query (engine-info-invalid) [447.211302] Starting subtest: engine-info-invalid [447.213727] Subtest engine-info-invalid: SUCCESS (0.000s) [447.290766] [096/155] (584s left) kms_chamelium_frames (dp-crc-multiple) [447.674305] Subtest dp-crc-multiple: SKIP (0.000s) [448.542378] [097/155] (583s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-render) [448.639655] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-render [448.643765] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [448.714910] [098/155] (583s left) kms_setmode (basic-clone-single-crtc) [448.767691] Starting subtest: basic-clone-single-crtc [448.774830] Subtest basic-clone-single-crtc: SKIP (0.000s) [448.856278] [099/155] (583s left) kms_frontbuffer_tracking (hdr-1p-primscrn-indfb-msflip-blt) [448.953798] Starting subtest: hdr-1p-primscrn-indfb-msflip-blt [448.957830] Subtest hdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s) [449.016506] [100/155] (583s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers) [449.098154] Starting subtest: plane-downscale-factor-0-75-with-modifiers [449.100314] Starting dynamic subtest: pipe-A [449.437262] Dynamic subtest pipe-A: SUCCESS (0.341s) [449.448601] Starting dynamic subtest: pipe-B [450.858213] Dynamic subtest pipe-B: SUCCESS (1.420s) [450.869461] Starting dynamic subtest: pipe-C [452.292378] Dynamic subtest pipe-C: SUCCESS (1.433s) [452.304377] Starting dynamic subtest: pipe-D [453.750866] Dynamic subtest pipe-D: SUCCESS (1.458s) [453.753206] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.656s) [454.890704] [101/155] (577s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-wc) [454.995130] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-wc [454.999162] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [455.081127] [102/155] (577s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-render) [455.182555] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-render [455.186672] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s) [455.245635] [103/155] (577s left) kms_big_fb (yf-tiled-16bpp-rotate-270) [455.357373] Starting subtest: yf-tiled-16bpp-rotate-270 [455.361791] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s) [455.446344] [104/155] (576s left) gem_eio (in-flight-1us) [455.676049] Starting subtest: in-flight-1us [464.188774] Subtest in-flight-1us: SUCCESS (8.510s) [464.284973] [105/155] (568s left) kms_big_fb (4-tiled-32bpp-rotate-180) [464.392558] Starting subtest: 4-tiled-32bpp-rotate-180 [465.784949] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.392s) [465.900120] [106/155] (566s left) syncobj_timeline (multi-wait-all-available-signaled) [465.955966] Starting subtest: multi-wait-all-available-signaled [465.958019] Subtest multi-wait-all-available-signaled: SUCCESS (0.000s) [466.031887] [107/155] (566s left) syncobj_eventfd (timeline-wait) [466.085437] Starting subtest: timeline-wait [466.094880] Subtest timeline-wait: SUCCESS (0.010s) [466.145861] [108/155] (566s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt) [466.245728] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt [466.249048] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [466.317612] [109/155] (566s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render) [466.410211] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render [466.413815] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [466.488818] [110/155] (566s left) gem_mmap_offset (bad-object) [466.542180] Starting subtest: bad-object [466.543991] Subtest bad-object: SUCCESS (0.001s) [466.607129] [111/155] (566s left) kms_prop_blob (blob-prop-validate) [466.655435] Starting subtest: blob-prop-validate [466.657403] Subtest blob-prop-validate: SUCCESS (0.000s) [466.741987] [112/155] (566s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu) [466.842292] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu [466.845830] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [466.903746] [113/155] (565s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-indfb-pgflip-blt) [467.004117] Starting subtest: fbchdr-2p-scndscrn-indfb-pgflip-blt [467.007497] Subtest fbchdr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [467.074600] [114/155] (565s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping) [467.171636] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping [467.175038] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping: SKIP (0.000s) [467.222744] [115/155] (565s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-render) [467.332184] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-render [467.336100] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [467.412889] [116/155] (565s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt) [467.520909] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt [471.220668] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.706s) [472.380409] [117/155] (560s left) gem_create (hog-create) [472.436923] Starting subtest: hog-create [472.439089] Starting dynamic subtest: smem0 [506.338579] Dynamic subtest smem0: SUCCESS (33.899s) [506.341232] Subtest hog-create: SUCCESS (33.901s) [506.507474] [118/155] (526s left) kms_psr (pr-primary-mmap-gtt) [506.612856] Starting subtest: pr-primary-mmap-gtt [506.617276] Subtest pr-primary-mmap-gtt: SKIP (0.000s) [506.674758] [119/155] (526s left) gem_exec_schedule (u-semaphore-codependency) [506.746287] Starting subtest: u-semaphore-codependency [506.751632] Subtest u-semaphore-codependency: SUCCESS (0.012s) [507.063297] [120/155] (526s left) gem_flink_basic (bad-open) [507.110076] Starting subtest: bad-open [507.111999] Subtest bad-open: SUCCESS (0.000s) [507.192466] [121/155] (525s left) dumb_buffer (map-uaf) [507.240918] Starting subtest: map-uaf [507.245461] Subtest map-uaf: SUCCESS (0.005s) [507.323815] [122/155] (525s left) gem_ctx_param (invalid-param-get) [507.377974] Starting subtest: invalid-param-get [507.380346] Subtest invalid-param-get: SUCCESS (0.001s) [507.465337] [123/155] (525s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-move) [507.556842] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-move [507.560836] Subtest psrhdr-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [507.635091] [124/155] (525s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-mmap-wc) [507.726564] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-mmap-wc [507.730768] Subtest hdr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [507.806203] [125/155] (525s left) gem_ctx_param (get-priority-new-ctx) [507.858598] Starting subtest: get-priority-new-ctx [507.860955] Subtest get-priority-new-ctx: SUCCESS (0.001s) [507.943512] [126/155] (525s left) perf (non-system-wide-paranoid) [508.012806] Starting subtest: non-system-wide-paranoid [508.035204] Subtest non-system-wide-paranoid: SUCCESS (0.026s) [508.088922] [127/155] (525s left) gem_exec_store (pages) [508.146048] Starting subtest: pages [508.147817] Starting dynamic subtest: rcs0 [508.242618] Dynamic subtest rcs0: SUCCESS (0.098s) [508.255616] Starting dynamic subtest: bcs0 [508.309102] Dynamic subtest bcs0: SUCCESS (0.065s) [508.320559] Starting dynamic subtest: vcs0 [508.382882] Dynamic subtest vcs0: SUCCESS (0.072s) [508.395273] Starting dynamic subtest: vcs1 [508.458942] Dynamic subtest vcs1: SUCCESS (0.075s) [508.472604] Starting dynamic subtest: vecs0 [508.535481] Dynamic subtest vecs0: SUCCESS (0.076s) [508.546969] Starting dynamic subtest: ccs0 [508.602160] Dynamic subtest ccs0: SUCCESS (0.065s) [508.604339] Subtest pages: SUCCESS (0.459s) [508.768416] [128/155] (524s left) kms_properties (colorop-properties-atomic) [508.869466] Starting subtest: colorop-properties-atomic [508.871393] Starting dynamic subtest: pipe-A-eDP-1 [509.229176] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.360s) [509.240325] Starting dynamic subtest: pipe-B-eDP-1 [510.362345] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.131s) [510.374090] Starting dynamic subtest: pipe-C-eDP-1 [511.411224] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.047s) [511.422897] Starting dynamic subtest: pipe-D-eDP-1 [512.547396] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.135s) [512.549326] Subtest colorop-properties-atomic: SUCCESS (3.678s) [513.341069] [129/155] (520s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-move) [513.447053] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-move [513.450992] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-move: SKIP (0.000s) [513.510058] [130/155] (520s left) gem_exec_suspend (basic-s3) [513.576953] Starting subtest: basic-S3 [513.579439] Starting dynamic subtest: smem [533.935152] Dynamic subtest smem: SUCCESS (7.732s) [533.938173] Subtest basic-S3: SUCCESS (7.734s) [540.117689] [131/155] (499s left) sysfs_heartbeat_interval (mixed) [540.191916] Starting subtest: mixed [540.194241] Starting dynamic subtest: vecs0 [545.399332] Dynamic subtest vecs0: SUCCESS (5.203s) [545.411908] Starting dynamic subtest: ccs0 [550.598843] Dynamic subtest ccs0: SUCCESS (5.194s) [550.611628] Starting dynamic subtest: vcs0 [555.810479] Dynamic subtest vcs0: SUCCESS (5.208s) [555.824279] Starting dynamic subtest: bcs0 [561.001276] Dynamic subtest bcs0: SUCCESS (5.187s) [561.016355] Starting dynamic subtest: rcs0 [566.221046] Dynamic subtest rcs0: SUCCESS (5.215s) [566.235222] Starting dynamic subtest: vcs1 [571.423453] Dynamic subtest vcs1: SUCCESS (5.199s) [571.425877] Subtest mixed: SUCCESS (31.218s) [571.479420] [132/155] (468s left) kms_plane_alpha_blend (alpha-basic) [571.570355] Starting subtest: alpha-basic [571.859708] Starting dynamic subtest: pipe-A-eDP-1 [573.799780] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.938s) [573.830952] Starting dynamic subtest: pipe-D-eDP-1 [576.505699] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.684s) [576.507936] Subtest alpha-basic: SUCCESS (4.937s) [577.366862] [133/155] (462s left) kms_pwrite_crc (basic) [577.466344] Starting subtest: basic [578.141564] Subtest basic: SUCCESS (0.676s) [579.006900] [134/155] (460s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-mmap-wc) [579.106121] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-mmap-wc [579.110521] Subtest hdr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [579.180850] [135/155] (460s left) kms_properties (invalid-properties-legacy) [579.275139] Starting subtest: invalid-properties-legacy [579.378049] Subtest invalid-properties-legacy: SUCCESS (0.103s) [579.431838] [136/155] (460s left) gem_softpin (full) [579.501050] Starting subtest: full [579.508662] Subtest full: SUCCESS (0.007s) [579.614363] [137/155] (460s left) gen7_exec_parse (bitmasks) [579.662891] Subtest bitmasks: SKIP (0.000s) [579.736568] [138/155] (460s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt) [579.838245] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt [587.393576] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.559s) [587.521729] [139/155] (452s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip) [587.625453] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip [587.629933] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [587.695647] [140/155] (452s left) syncobj_timeline (single-wait-all-for-submit-available-submitted) [587.744846] Starting subtest: single-wait-all-for-submit-available-submitted [587.747224] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s) [587.816726] [141/155] (452s left) gem_eio (wait-1us) [588.035124] Starting subtest: wait-1us [588.356651] Subtest wait-1us: SUCCESS (0.323s) [588.479056] [142/155] (451s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size) [588.595702] Starting subtest: basic-busy-flip-before-cursor-varying-size [588.599322] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s) [588.721929] [143/155] (451s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs) [588.813244] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs [588.815046] Starting dynamic subtest: pipe-A-eDP-1 [588.822278] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [588.833969] Starting dynamic subtest: pipe-B-eDP-1 [588.841254] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [588.852088] Starting dynamic subtest: pipe-C-eDP-1 [588.858818] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [588.869127] Starting dynamic subtest: pipe-D-eDP-1 [588.875816] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [588.879039] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.005s) [591.120841] [144/155] (449s left) syncobj_timeline (etime-single-wait-all-submitted) [591.176896] Starting subtest: etime-single-wait-all-submitted [591.282079] Subtest etime-single-wait-all-submitted: SUCCESS (0.104s) [591.339532] [145/155] (448s left) gem_exec_reloc (basic-wc-noreloc) [591.407196] Subtest basic-wc-noreloc: SKIP (0.000s) [591.493402] [146/155] (448s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [591.594018] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip [592.407721] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.815s) [592.553474] [147/155] (447s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes) [592.606819] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s) [592.678004] [148/155] (447s left) gem_ctx_persistence (smoketest) [592.747917] Starting subtest: smoketest [632.846975] Subtest smoketest: SUCCESS (40.089s) [632.910127] [149/155] (407s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff) [633.015479] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff [633.019422] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [633.096579] [150/155] (407s left) kms_draw_crc (fill-fb) [633.190551] Starting subtest: fill-fb [633.698701] Subtest fill-fb: SUCCESS (0.509s) [633.778782] [151/155] (406s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt) [633.875725] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt [633.879212] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [633.948845] [152/155] (406s left) gem_exec_schedule (preempt-other-chain) [634.013100] Starting subtest: preempt-other-chain [634.015005] Starting dynamic subtest: rcs0 [634.093071] Dynamic subtest rcs0: SUCCESS (0.083s) [634.107125] Starting dynamic subtest: bcs0 [634.174050] Dynamic subtest bcs0: SUCCESS (0.080s) [634.190167] Starting dynamic subtest: vcs0 [634.257356] Dynamic subtest vcs0: SUCCESS (0.083s) [634.269225] Starting dynamic subtest: vcs1 [634.346875] Dynamic subtest vcs1: SUCCESS (0.088s) [634.359311] Starting dynamic subtest: vecs0 [634.430587] Dynamic subtest vecs0: SUCCESS (0.082s) [634.445916] Starting dynamic subtest: ccs0 [634.512491] Dynamic subtest ccs0: SUCCESS (0.082s) [634.514944] Subtest preempt-other-chain: SUCCESS (0.503s) [636.015667] [153/155] (404s left) gem_exec_await (wide-all) [636.230553] Starting subtest: wide-all [659.898028] Subtest wide-all: SUCCESS (23.670s) [660.078354] [154/155] (380s left) kms_async_flips (crc) [660.227974] Starting subtest: crc [660.601253] Starting dynamic subtest: pipe-A-eDP-1 [663.558293] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.956s) [663.941313] Starting dynamic subtest: pipe-B-eDP-1 [666.894757] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.969s) [667.268383] Starting dynamic subtest: pipe-C-eDP-1 [670.212385] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.955s) [670.597060] Starting dynamic subtest: pipe-D-eDP-1 [673.465760] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.885s) [673.468002] Subtest crc: SUCCESS (13.241s) [674.615208] [155/155] (366s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt) [674.721093] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt [674.725527] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [674.800398] Closing watchdogs results: parsing output: 0/ for test: kms_frontbuffer_tracking results: parsing output: 1/ for test: prime_busy results: parsing output: 2/ for test: i915_pm_freq_api results: parsing output: 3/ for test: kms_getfb results: parsing output: 4/ for test: gem_exec_fence results: parsing output: 5/ for test: kms_plane results: parsing output: 6/ for test: gem_vm_create results: parsing output: 7/ for test: kms_psr results: parsing output: 8/ for test: gem_ctx_bad_destroy results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: gem_exec_reloc results: parsing output: 11/ for test: gem_mmap_gtt results: parsing output: 12/ for test: kms_frontbuffer_tracking results: parsing output: 13/ for test: kms_big_fb results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: gem_exercise_blt results: parsing output: 16/ for test: i915_pm_rpm results: parsing output: 17/ for test: vgem_slow results: parsing output: 18/ for test: gem_eio results: parsing output: 19/ for test: prime_mmap_coherency results: parsing output: 20/ for test: kms_frontbuffer_tracking results: parsing output: 21/ for test: gem_userptr_blits results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: kms_plane_scaling results: parsing output: 24/ for test: kms_vblank results: parsing output: 25/ for test: kms_flip results: parsing output: 26/ for test: gem_userptr_blits results: parsing output: 27/ for test: kms_vblank results: parsing output: 28/ for test: kms_flip_scaled_crc results: parsing output: 29/ for test: kms_big_fb results: parsing output: 30/ for test: kms_feature_discovery results: parsing output: 31/ for test: gem_pwrite results: parsing output: 32/ for test: kms_big_fb results: parsing output: 33/ for test: kms_frontbuffer_tracking results: parsing output: 34/ for test: i915_drm_fdinfo results: parsing output: 35/ for test: kms_psr results: parsing output: 36/ for test: kms_psr2_sf results: parsing output: 37/ for test: gem_mmap_gtt results: parsing output: 38/ for test: gem_partial_pwrite_pread results: parsing output: 39/ for test: kms_frontbuffer_tracking results: parsing output: 40/ for test: syncobj_wait results: parsing output: 41/ for test: prime_mmap results: parsing output: 42/ for test: kms_setmode results: parsing output: 43/ for test: gem_exec_params results: parsing output: 44/ for test: kms_cursor_crc results: parsing output: 45/ for test: kms_cdclk results: parsing output: 46/ for test: perf_pmu results: parsing output: 47/ for test: syncobj_timeline results: parsing output: 48/ for test: gem_pxp results: parsing output: 49/ for test: gem_exec_balancer results: parsing output: 50/ for test: kms_frontbuffer_tracking results: parsing output: 51/ for test: kms_frontbuffer_tracking results: parsing output: 52/ for test: gem_exec_balancer results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: gem_ctx_persistence results: parsing output: 55/ for test: kms_ccs results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: api_intel_allocator results: parsing output: 58/ for test: gem_exec_suspend results: parsing output: 59/ for test: kms_color results: parsing output: 60/ for test: gem_ccs results: parsing output: 61/ for test: kms_frontbuffer_tracking results: parsing output: 62/ for test: gem_ctx_shared results: parsing output: 63/ for test: kms_ccs results: parsing output: 64/ for test: kms_frontbuffer_tracking results: parsing output: 65/ for test: kms_psr results: parsing output: 66/ for test: kms_pm_rpm results: parsing output: 67/ for test: kms_ccs results: parsing output: 68/ for test: perf_pmu results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: kms_flip_scaled_crc results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: gem_render_copy results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: kms_async_flips results: parsing output: 75/ for test: gem_softpin results: parsing output: 76/ for test: kms_lease results: parsing output: 77/ for test: kms_lease results: parsing output: 78/ for test: kms_content_protection results: parsing output: 79/ for test: kms_flip_scaled_crc results: parsing output: 80/ for test: perf results: parsing output: 81/ for test: kms_cursor_legacy results: parsing output: 82/ for test: vgem_basic results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: kms_cursor_crc results: parsing output: 85/ for test: kms_frontbuffer_tracking results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: kms_psr2_sf results: parsing output: 88/ for test: kms_frontbuffer_tracking results: parsing output: 89/ for test: kms_chamelium_hpd results: parsing output: 90/ for test: api_intel_bb results: parsing output: 91/ for test: gem_partial_pwrite_pread results: parsing output: 92/ for test: gem_softpin results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: i915_query results: parsing output: 95/ for test: kms_chamelium_frames results: parsing output: 96/ for test: kms_frontbuffer_tracking results: parsing output: 97/ for test: kms_setmode results: parsing output: 98/ for test: kms_frontbuffer_tracking results: parsing output: 99/ for test: kms_plane_scaling results: parsing output: 100/ for test: kms_frontbuffer_tracking results: parsing output: 101/ for test: kms_frontbuffer_tracking results: parsing output: 102/ for test: kms_big_fb results: parsing output: 103/ for test: gem_eio results: parsing output: 104/ for test: kms_big_fb results: parsing output: 105/ for test: syncobj_timeline results: parsing output: 106/ for test: syncobj_eventfd results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: gem_mmap_offset results: parsing output: 110/ for test: kms_prop_blob results: parsing output: 111/ for test: kms_frontbuffer_tracking results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: kms_plane results: parsing output: 114/ for test: kms_frontbuffer_tracking results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: gem_create results: parsing output: 117/ for test: kms_psr results: parsing output: 118/ for test: gem_exec_schedule results: parsing output: 119/ for test: gem_flink_basic results: parsing output: 120/ for test: dumb_buffer results: parsing output: 121/ for test: gem_ctx_param results: parsing output: 122/ for test: kms_frontbuffer_tracking results: parsing output: 123/ for test: kms_frontbuffer_tracking results: parsing output: 124/ for test: gem_ctx_param results: parsing output: 125/ for test: perf results: parsing output: 126/ for test: gem_exec_store results: parsing output: 127/ for test: kms_properties results: parsing output: 128/ for test: kms_frontbuffer_tracking results: parsing output: 129/ for test: gem_exec_suspend results: parsing output: 130/ for test: sysfs_heartbeat_interval results: parsing output: 131/ for test: kms_plane_alpha_blend results: parsing output: 132/ for test: kms_pwrite_crc results: parsing output: 133/ for test: kms_frontbuffer_tracking results: parsing output: 134/ for test: kms_properties results: parsing output: 135/ for test: gem_softpin results: parsing output: 136/ for test: gen7_exec_parse results: parsing output: 137/ for test: kms_frontbuffer_tracking results: parsing output: 138/ for test: kms_big_fb results: parsing output: 139/ for test: syncobj_timeline results: parsing output: 140/ for test: gem_eio results: parsing output: 141/ for test: kms_cursor_legacy results: parsing output: 142/ for test: kms_ccs results: parsing output: 143/ for test: syncobj_timeline results: parsing output: 144/ for test: gem_exec_reloc results: parsing output: 145/ for test: kms_big_fb results: parsing output: 146/ for test: kms_pipe_b_c_ivb results: parsing output: 147/ for test: gem_ctx_persistence results: parsing output: 148/ for test: kms_frontbuffer_tracking results: parsing output: 149/ for test: kms_draw_crc results: parsing output: 150/ for test: kms_frontbuffer_tracking results: parsing output: 151/ for test: gem_exec_schedule results: parsing output: 152/ for test: gem_exec_await results: parsing output: 153/ for test: kms_async_flips results: parsing output: 154/ for test: kms_frontbuffer_tracking Done.