[57.550529] Initializing watchdogs [57.550574] /dev/watchdog0 [57.565037] [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] [57.569189] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.571438] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.574685] [001/155] (960s left) kms_addfb_basic (legacy-format) [57.650771] Starting subtest: legacy-format [57.674158] Subtest legacy-format: SUCCESS (0.023s) [57.825928] [002/155] (960s left) gem_create (create-size-update) [57.882851] Starting subtest: create-size-update [57.885039] Subtest create-size-update: SUCCESS (0.000s) [58.109588] [003/155] (960s left) kms_psr (fbc-pr-cursor-mmap-cpu) [58.205239] Starting subtest: fbc-pr-cursor-mmap-cpu [58.209052] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s) [58.278082] [004/155] (959s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move) [58.389245] Starting subtest: psr-2p-primscrn-spr-indfb-move [58.393503] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [58.507404] [005/155] (959s left) gem_exec_parallel (fds) [58.559360] Starting subtest: fds [58.561843] Starting dynamic subtest: rcs0 [60.872033] Dynamic subtest rcs0: SUCCESS (2.340s) [60.880616] Starting dynamic subtest: bcs0 [63.992865] Dynamic subtest bcs0: SUCCESS (3.147s) [64.003227] Starting dynamic subtest: vcs0 [67.557524] Dynamic subtest vcs0: SUCCESS (3.584s) [67.565493] Starting dynamic subtest: vcs1 [71.471956] Dynamic subtest vcs1: SUCCESS (3.927s) [71.482285] Starting dynamic subtest: vecs0 [75.533782] Dynamic subtest vecs0: SUCCESS (4.068s) [75.543236] Starting dynamic subtest: ccs0 [79.132056] Dynamic subtest ccs0: SUCCESS (3.601s) [79.134624] Subtest fds: SUCCESS (20.675s) [79.324864] [006/155] (938s left) kms_cursor_legacy (cursora-vs-flipb-atomic) [79.465192] Starting subtest: cursorA-vs-flipB-atomic [79.469662] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s) [79.609713] [007/155] (938s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu) [79.708236] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu [79.712738] Subtest psrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [79.789447] [008/155] (938s left) gem_ctx_persistence (engines-hang) [79.840559] Starting subtest: engines-hang [79.842803] Starting dynamic subtest: rcs0 [79.957884] Dynamic subtest rcs0: SUCCESS (0.117s) [79.969621] Starting dynamic subtest: bcs0 [80.045544] Dynamic subtest bcs0: SUCCESS (0.086s) [80.056663] Starting dynamic subtest: vcs0 [80.137835] Dynamic subtest vcs0: SUCCESS (0.091s) [80.148520] Starting dynamic subtest: vcs1 [80.223737] Dynamic subtest vcs1: SUCCESS (0.086s) [80.235468] Starting dynamic subtest: vecs0 [80.311479] Dynamic subtest vecs0: SUCCESS (0.087s) [80.321776] Starting dynamic subtest: ccs0 [80.402208] Dynamic subtest ccs0: SUCCESS (0.090s) [80.404412] Subtest engines-hang: SUCCESS (0.564s) [80.478141] [009/155] (937s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc) [80.570148] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc [80.573870] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [80.653737] [010/155] (937s left) kms_psr (fbc-psr2-cursor-mmap-cpu) [80.736228] Starting subtest: fbc-psr2-cursor-mmap-cpu [80.738064] Starting dynamic subtest: eDP-1 [80.741657] Dynamic subtest eDP-1: SKIP (0.000s) [80.745219] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.000s) [80.800961] [011/155] (937s left) drm_read (fault-buffer) [80.986436] Starting subtest: fault-buffer [80.988491] Subtest fault-buffer: SUCCESS (0.000s) [81.102187] [012/155] (937s left) sriov_basic (enable-vfs-autoprobe-off) [81.152848] Starting subtest: enable-vfs-autoprobe-off [81.155220] Starting dynamic subtest: numvfs-1 [81.159356] Dynamic subtest numvfs-1: SKIP (0.000s) [81.168834] Starting dynamic subtest: numvfs-2 [81.172578] Dynamic subtest numvfs-2: SKIP (0.000s) [81.180244] Starting dynamic subtest: numvfs-3 [81.183858] Dynamic subtest numvfs-3: SKIP (0.000s) [81.191796] Starting dynamic subtest: numvfs-4 [81.195267] Dynamic subtest numvfs-4: SKIP (0.000s) [81.202097] Starting dynamic subtest: numvfs-5 [81.205500] Dynamic subtest numvfs-5: SKIP (0.000s) [81.212340] Starting dynamic subtest: numvfs-6 [81.215826] Dynamic subtest numvfs-6: SKIP (0.000s) [81.222514] Starting dynamic subtest: numvfs-7 [81.225892] Dynamic subtest numvfs-7: SKIP (0.000s) [81.233050] Starting dynamic subtest: numvfs-random [81.236474] Dynamic subtest numvfs-random: SKIP (0.000s) [81.243474] Starting dynamic subtest: numvfs-all [81.247475] Dynamic subtest numvfs-all: SKIP (0.000s) [81.251170] Subtest enable-vfs-autoprobe-off: SKIP (0.008s) [81.284684] [013/155] (937s left) kms_big_fb (4-tiled-16bpp-rotate-0) [81.386697] Starting subtest: 4-tiled-16bpp-rotate-0 [82.689271] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.304s) [82.841697] [014/155] (935s left) syncobj_timeline (etime-multi-wait-submitted) [82.888265] Starting subtest: etime-multi-wait-submitted [82.991464] Subtest etime-multi-wait-submitted: SUCCESS (0.101s) [83.076647] [015/155] (935s left) kms_chamelium_hpd (dp-hpd) [83.454594] Subtest dp-hpd: SKIP (0.000s) [84.285480] [016/155] (934s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-move) [84.381167] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-move [84.385534] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [84.501970] [017/155] (934s left) syncobj_wait (multi-wait-for-submit-unsubmitted) [84.550615] Starting subtest: multi-wait-for-submit-unsubmitted [84.655492] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.103s) [84.728979] [018/155] (934s left) gem_mmap_gtt (basic-small-bo-tiledx) [84.783097] Subtest basic-small-bo-tiledX: SKIP (0.000s) [84.837311] [019/155] (933s left) gem_partial_pwrite_pread (write-snoop) [84.894982] Subtest write-snoop: SKIP (0.000s) [84.964950] [020/155] (933s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping) [85.058099] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping [85.062182] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s) [85.126302] [021/155] (933s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled) [85.172848] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled [85.279219] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.104s) [85.351718] [022/155] (933s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc) [85.443800] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc [85.447822] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [85.541975] [023/155] (933s left) kms_cursor_crc (cursor-rapid-movement-32x10) [85.712761] Starting subtest: cursor-rapid-movement-32x10 [85.767264] Subtest cursor-rapid-movement-32x10: SKIP (0.051s) [86.026694] [024/155] (932s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-pwrite) [86.128604] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-pwrite [86.133198] Subtest hdr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [86.235105] [025/155] (932s left) i915_pm_freq_mult (media-freq) [86.284157] Starting subtest: media-freq [86.286417] Starting dynamic subtest: gt0 [86.290621] Dynamic subtest gt0: SKIP (0.000s) [86.298059] Starting dynamic subtest: gt1 [86.301530] Dynamic subtest gt1: SKIP (0.000s) [86.304919] Subtest media-freq: SKIP (0.002s) [86.383781] [026/155] (932s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-indfb-plflip-blt) [86.487452] Starting subtest: fbchdr-2p-primscrn-indfb-plflip-blt [86.491077] Subtest fbchdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [86.579348] [027/155] (932s left) prime_vgem (fence-write-hang) [86.762653] Subtest fence-write-hang: SKIP (0.000s) [86.857543] [FACT prime_vgem (fence-write-hang)] new: kernel.kmod_is_loaded.vgem: true [86.860710] [028/155] (932s left) gem_pxp (protected-raw-src-copy-not-readible) [86.986194] Starting subtest: protected-raw-src-copy-not-readible [87.050087] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.066s) [87.149785] [029/155] (932s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu) [87.251694] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu [91.853085] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.606s) [93.069511] [030/155] (926s left) kms_psr (fbc-psr-dpms) [93.169897] Starting subtest: fbc-psr-dpms [93.172252] Starting dynamic subtest: eDP-1 [93.176595] Dynamic subtest eDP-1: SKIP (0.000s) [93.181192] Subtest fbc-psr-dpms: SKIP (0.001s) [93.240827] [031/155] (925s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs) [93.341018] Starting subtest: missing-ccs-buffer-yf-tiled-ccs [93.343347] Starting dynamic subtest: pipe-A-eDP-1 [93.366298] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [93.375875] Starting dynamic subtest: pipe-B-eDP-1 [93.397369] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [93.405088] Starting dynamic subtest: pipe-C-eDP-1 [93.426527] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [93.434158] Starting dynamic subtest: pipe-D-eDP-1 [93.455803] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [93.460158] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.003s) [95.621788] [032/155] (923s left) syncobj_timeline (wait-all-interrupted) [95.673081] Starting subtest: wait-all-interrupted [95.773734] Subtest wait-all-interrupted: SUCCESS (0.101s) [95.861131] [033/155] (923s left) i915_drm_fdinfo (most-busy-idle-check-all) [95.903670] Starting subtest: most-busy-idle-check-all [95.905830] Starting dynamic subtest: rcs0 [95.910309] Dynamic subtest rcs0: SKIP (0.003s) [95.918270] Starting dynamic subtest: bcs0 [95.922570] Dynamic subtest bcs0: SKIP (0.000s) [95.930318] Starting dynamic subtest: vcs0 [95.934298] Dynamic subtest vcs0: SKIP (0.000s) [95.941640] Starting dynamic subtest: vcs1 [95.945914] Dynamic subtest vcs1: SKIP (0.000s) [95.955167] Starting dynamic subtest: vecs0 [95.959218] Dynamic subtest vecs0: SKIP (0.000s) [95.966657] Starting dynamic subtest: ccs0 [95.971116] Dynamic subtest ccs0: SKIP (0.000s) [95.975178] Subtest most-busy-idle-check-all: SKIP (0.007s) [96.009121] [034/155] (923s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-mmap-wc) [96.139592] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-mmap-wc [96.143704] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [96.231947] [035/155] (923s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-mmap-gtt) [96.328666] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-mmap-gtt [96.333227] Subtest hdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [96.419467] [036/155] (922s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [96.515304] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu [96.519736] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [96.627972] [037/155] (922s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-pri-indfb-multidraw) [96.715073] Starting subtest: fbcpsrhdr-1p-pri-indfb-multidraw [96.718603] Subtest fbcpsrhdr-1p-pri-indfb-multidraw: SKIP (0.000s) [96.805805] [038/155] (922s left) kms_flip (flip-vs-dpms-on-nop-interruptible) [96.909307] Starting subtest: flip-vs-dpms-on-nop-interruptible [96.911316] Starting dynamic subtest: A-eDP1 [98.803587] Dynamic subtest A-eDP1: SUCCESS (1.892s) [98.813744] Starting dynamic subtest: B-eDP1 [100.642354] Dynamic subtest B-eDP1: SUCCESS (1.837s) [100.654670] Starting dynamic subtest: C-eDP1 [102.447840] Dynamic subtest C-eDP1: SUCCESS (1.804s) [102.458610] Starting dynamic subtest: D-eDP1 [104.271349] Dynamic subtest D-eDP1: SUCCESS (1.822s) [104.273716] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.366s) [105.470499] [039/155] (914s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled) [105.531257] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled [105.533639] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s) [105.628983] [040/155] (913s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-mmap-wc) [105.732464] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-mmap-wc [105.736703] Subtest hdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [105.837626] [041/155] (913s left) perf_pmu (invalid-open) [105.877535] Starting subtest: invalid-open [105.879727] Subtest invalid-open: SUCCESS (0.000s) [106.015375] [042/155] (913s left) kms_flip (2x-dpms-vs-vblank-race-interruptible) [106.103305] Starting subtest: 2x-dpms-vs-vblank-race-interruptible [106.115566] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.010s) [106.191957] [043/155] (913s left) gem_exec_flush (basic-batch-kernel-default-uc) [106.259347] Starting subtest: basic-batch-kernel-default-uc [113.096449] Subtest basic-batch-kernel-default-uc: SUCCESS (6.838s) [113.280489] [044/155] (906s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip) [113.391259] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip [114.349916] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (0.961s) [114.469202] [045/155] (905s left) device_reset (cold-reset-bound) [114.522413] Starting subtest: cold-reset-bound [114.527059] Subtest cold-reset-bound: SKIP (0.000s) [114.620376] [046/155] (905s left) gem_exec_schedule (preempt-self) [114.682890] Starting subtest: preempt-self [114.684851] Starting dynamic subtest: rcs0 [114.697983] Dynamic subtest rcs0: SUCCESS (0.020s) [114.707142] Starting dynamic subtest: bcs0 [114.714964] Dynamic subtest bcs0: SUCCESS (0.016s) [114.726400] Starting dynamic subtest: vcs0 [114.732384] Dynamic subtest vcs0: SUCCESS (0.017s) [114.741107] Starting dynamic subtest: vcs1 [114.751806] Dynamic subtest vcs1: SUCCESS (0.019s) [114.759689] Starting dynamic subtest: vecs0 [114.767756] Dynamic subtest vecs0: SUCCESS (0.016s) [114.775568] Starting dynamic subtest: ccs0 [114.791127] Dynamic subtest ccs0: SUCCESS (0.023s) [114.793153] Subtest preempt-self: SUCCESS (0.114s) [116.376351] [047/155] (903s left) kms_psr (pr-primary-mmap-gtt) [116.466221] Starting subtest: pr-primary-mmap-gtt [116.470607] Subtest pr-primary-mmap-gtt: SKIP (0.000s) [116.535937] [048/155] (903s left) gem_exec_fence (basic-wait) [116.721476] Starting subtest: basic-wait [116.724062] Starting dynamic subtest: rcs0 [116.803362] Dynamic subtest rcs0: SUCCESS (0.082s) [116.816816] Starting dynamic subtest: bcs0 [116.857213] Dynamic subtest bcs0: SUCCESS (0.052s) [116.868792] Starting dynamic subtest: vcs0 [116.915091] Dynamic subtest vcs0: SUCCESS (0.056s) [116.925888] Starting dynamic subtest: vcs1 [116.978273] Dynamic subtest vcs1: SUCCESS (0.061s) [116.989971] Starting dynamic subtest: vecs0 [117.045540] Dynamic subtest vecs0: SUCCESS (0.065s) [117.056458] Starting dynamic subtest: ccs0 [117.107615] Dynamic subtest ccs0: SUCCESS (0.060s) [117.110106] Subtest basic-wait: SUCCESS (0.388s) [119.385486] [049/155] (900s left) gem_eio (create-ext) [119.620048] Starting subtest: create-ext [119.972350] Subtest create-ext: SUCCESS (0.351s) [120.116611] [050/155] (899s left) i915_power (sanity) [120.166133] Starting subtest: sanity [124.208700] Subtest sanity: SUCCESS (4.036s) [125.340808] [051/155] (894s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt) [125.441020] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt [125.445253] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [125.523714] [052/155] (894s left) kms_hdmi_inject (inject-4k) [125.878644] Starting subtest: inject-4k [126.224342] Subtest inject-4k: SUCCESS (0.348s) [126.714473] [053/155] (893s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area) [126.812323] Starting subtest: pr-primary-plane-update-sf-dmg-area [126.816338] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s) [126.883751] [054/155] (893s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt) [126.993070] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt [134.345797] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.356s) [134.484171] [055/155] (885s left) syncobj_basic (bad-destroy) [134.540617] Starting subtest: bad-destroy [134.542657] Subtest bad-destroy: SUCCESS (0.000s) [134.659393] [056/155] (885s left) syncobj_wait (wait-all-for-submit-complex) [134.711412] Starting subtest: wait-all-for-submit-complex [134.926785] Subtest wait-all-for-submit-complex: SUCCESS (0.214s) [135.003497] [057/155] (885s left) gem_softpin (allocator-nopin) [135.063047] Starting subtest: allocator-nopin [135.154734] Subtest allocator-nopin: SUCCESS (0.094s) [135.285199] [058/155] (885s left) kms_frontbuffer_tracking (fbchdr-modesetfrombusy) [135.387860] Starting subtest: fbchdr-modesetfrombusy [135.392330] Subtest fbchdr-modesetfrombusy: SKIP (0.000s) [135.468877] [059/155] (884s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-move) [135.572341] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-move [135.576764] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [135.690076] [060/155] (884s left) kms_psr (psr-no-drrs) [135.802822] Starting subtest: psr-no-drrs [135.805568] Starting dynamic subtest: eDP-1 [137.430548] Dynamic subtest eDP-1: SUCCESS (1.630s) [137.432957] Subtest psr-no-drrs: SUCCESS (1.631s) [138.277195] [061/155] (882s left) kms_flip (modeset-vs-vblank-race) [138.372370] Starting subtest: modeset-vs-vblank-race [138.374539] Starting dynamic subtest: A-eDP1 [143.079098] Dynamic subtest A-eDP1: SUCCESS (4.708s) [143.093374] Starting dynamic subtest: B-eDP1 [147.769430] Dynamic subtest B-eDP1: SUCCESS (4.688s) [147.784195] Starting dynamic subtest: C-eDP1 [152.689396] Dynamic subtest C-eDP1: SUCCESS (4.917s) [152.704121] Starting dynamic subtest: D-eDP1 [157.355706] Dynamic subtest D-eDP1: SUCCESS (4.663s) [157.361109] Subtest modeset-vs-vblank-race: SUCCESS (18.990s) [158.595948] [062/155] (861s left) i915_pm_rps (min-max-config-loaded) [158.660263] Starting subtest: min-max-config-loaded [158.664556] Subtest min-max-config-loaded: SKIP (0.001s) [158.761607] [063/155] (861s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu) [158.860964] Starting subtest: psr-rgb565-draw-mmap-cpu [165.872631] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (7.015s) [165.961271] [064/155] (854s left) kms_invalid_mode (bad-hsync-start) [166.055363] Starting subtest: bad-hsync-start [166.057657] Starting dynamic subtest: pipe-A-eDP-1 [166.340772] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s) [166.350751] Starting dynamic subtest: pipe-B-eDP-1 [166.353043] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [166.361835] Starting dynamic subtest: pipe-C-eDP-1 [166.364174] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [166.379633] Starting dynamic subtest: pipe-D-eDP-1 [166.382023] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [166.384709] Subtest bad-hsync-start: SUCCESS (0.292s) [167.175719] [065/155] (853s left) syncobj_wait (multi-wait-submitted-signaled) [167.232543] Starting subtest: multi-wait-submitted-signaled [167.234510] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s) [167.348075] [066/155] (853s left) kms_chamelium_audio (hdmi-audio-edid) [167.741308] Subtest hdmi-audio-edid: SKIP (0.000s) [168.564775] [067/155] (852s left) kms_tv_load_detect (load-detect) [168.619947] Subtest load-detect: SKIP (0.000s) [168.678591] [068/155] (852s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs) [168.767318] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs [168.769583] Starting dynamic subtest: pipe-A-eDP-1 [168.792205] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [168.802362] Starting dynamic subtest: pipe-B-eDP-1 [168.822275] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [168.830713] Starting dynamic subtest: pipe-C-eDP-1 [168.851255] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [168.859706] Starting dynamic subtest: pipe-D-eDP-1 [168.881332] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [168.885645] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.006s) [170.987396] [069/155] (849s left) syncobj_wait (multi-wait-all-for-submit-signaled) [171.039721] Starting subtest: multi-wait-all-for-submit-signaled [171.041907] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s) [171.152120] [070/155] (849s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt) [171.247138] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt [171.251496] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [171.324255] [071/155] (849s left) gem_render_copy_redux (interruptible) [171.377273] Starting subtest: interruptible [171.677511] Subtest interruptible: SUCCESS (0.301s) [171.789500] [072/155] (849s left) gem_fenced_exec_thrash (no-spare-fences) [171.846663] Subtest no-spare-fences: SKIP (0.000s) [171.923954] [073/155] (849s left) syncobj_timeline (multi-wait-all-for-submit-signaled) [171.992091] Starting subtest: multi-wait-all-for-submit-signaled [171.993894] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s) [172.108221] [074/155] (848s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt) [172.204766] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt [172.208244] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [172.315321] [075/155] (848s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-fullscreen) [172.412776] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-fullscreen [172.416263] Subtest fbchdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [172.520159] [076/155] (848s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs) [172.612855] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs [172.614725] Starting dynamic subtest: pipe-A-eDP-1 [172.671897] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.060s) [172.681352] Starting dynamic subtest: pipe-B-eDP-1 [172.734718] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.061s) [172.744767] Starting dynamic subtest: pipe-C-eDP-1 [172.793936] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.059s) [172.802844] Starting dynamic subtest: pipe-D-eDP-1 [172.854975] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.059s) [172.856922] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.244s) [175.078415] [077/155] (846s left) kms_frontbuffer_tracking (fbcpsrhdr-farfromfence-mmap-gtt) [175.179339] Starting subtest: fbcpsrhdr-farfromfence-mmap-gtt [175.184056] Subtest fbcpsrhdr-farfromfence-mmap-gtt: SKIP (0.000s) [175.272375] [078/155] (845s left) gem_exec_reloc (basic-active) [175.334323] Subtest basic-active: SKIP (0.000s) [175.410372] [079/155] (845s left) gem_exec_params (invalid-bsd1-flag-on-blt) [175.465534] Starting subtest: invalid-bsd1-flag-on-blt [175.467903] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s) [175.569885] [080/155] (845s left) kms_frontbuffer_tracking (psrhdr-indfb-scaledprimary) [175.667494] Starting subtest: psrhdr-indfb-scaledprimary [175.671618] Subtest psrhdr-indfb-scaledprimary: SKIP (0.000s) [175.761795] [081/155] (845s left) syncobj_wait (single-wait-submitted) [175.815513] Starting subtest: single-wait-submitted [175.919223] Subtest single-wait-submitted: SUCCESS (0.103s) [175.995492] [082/155] (845s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-shrfb-pgflip-blt) [176.096558] Starting subtest: fbcpsrhdr-1p-primscrn-shrfb-pgflip-blt [176.100624] Subtest fbcpsrhdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [176.227409] [083/155] (845s left) kms_big_fb (yf-tiled-64bpp-rotate-0) [176.330455] Starting subtest: yf-tiled-64bpp-rotate-0 [176.334710] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s) [176.437036] [084/155] (844s left) vgem_basic (dmabuf-fence) [176.488730] Starting subtest: dmabuf-fence [176.491043] Subtest dmabuf-fence: SUCCESS (0.001s) [176.545212] [085/155] (844s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc) [176.653462] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc [176.657662] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [176.772213] [086/155] (844s left) gem_exec_params (invalid-ring2) [176.828138] Starting subtest: invalid-ring2 [176.830469] Subtest invalid-ring2: SUCCESS (0.000s) [176.924989] [087/155] (844s left) kms_cursor_legacy (single-bo) [177.044101] Starting subtest: single-bo [177.045848] Starting dynamic subtest: pipe-A [182.426943] Dynamic subtest pipe-A: SUCCESS (5.379s) [182.439235] Starting dynamic subtest: pipe-B [187.809698] Dynamic subtest pipe-B: SUCCESS (5.380s) [187.821032] Starting dynamic subtest: pipe-C [193.191770] Dynamic subtest pipe-C: SUCCESS (5.378s) [193.203667] Starting dynamic subtest: pipe-D [198.573783] Dynamic subtest pipe-D: SUCCESS (5.379s) [198.584579] Starting dynamic subtest: all-pipes [203.962715] Dynamic subtest all-pipes: SUCCESS (5.386s) [203.965544] Subtest single-bo: SUCCESS (26.916s) [204.108437] [088/155] (817s left) gem_exec_balancer (bonded-true-hang) [204.373953] Starting subtest: bonded-true-hang [204.378967] Subtest bonded-true-hang: SKIP (0.000s) [204.499799] [089/155] (817s left) gem_exec_whisper (basic-queues-forked-all) [204.561740] Starting subtest: basic-queues-forked-all [226.540687] Subtest basic-queues-forked-all: SUCCESS (21.974s) [226.730717] [090/155] (794s left) kms_lease (multimaster-lease) [226.818301] Starting subtest: multimaster-lease [226.820680] Subtest multimaster-lease: SUCCESS (0.003s) [226.931479] [091/155] (794s left) kms_pm_rpm (modeset-non-lpsp-stress) [228.453238] Starting subtest: modeset-non-lpsp-stress [229.615337] Subtest modeset-non-lpsp-stress: SKIP (1.159s) [230.001579] [092/155] (791s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-blt) [230.098625] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-blt [230.102875] Subtest fbchdr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [230.208393] [093/155] (791s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25) [230.303403] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25 [230.305666] Starting dynamic subtest: pipe-A [230.366735] Dynamic subtest pipe-A: SUCCESS (0.065s) [230.376162] Starting dynamic subtest: pipe-B [231.572673] Dynamic subtest pipe-B: SUCCESS (1.205s) [231.584271] Starting dynamic subtest: pipe-C [232.659719] Dynamic subtest pipe-C: SUCCESS (1.086s) [232.669068] Starting dynamic subtest: pipe-D [233.747345] Dynamic subtest pipe-D: SUCCESS (1.087s) [233.749678] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.447s) [234.994643] [094/155] (786s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping) [235.089364] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping [235.093713] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.000s) [235.162195] [095/155] (786s left) gen9_exec_parse (bb-start-cmd) [235.232847] Subtest bb-start-cmd: SKIP (0.000s) [235.303483] [096/155] (786s left) kms_flip (flip-vs-dpms-off-vs-modeset) [235.396194] Starting subtest: flip-vs-dpms-off-vs-modeset [235.398079] Starting dynamic subtest: A-eDP1 [239.021914] Dynamic subtest A-eDP1: SUCCESS (3.624s) [239.031645] Starting dynamic subtest: B-eDP1 [242.320771] Dynamic subtest B-eDP1: SUCCESS (3.299s) [242.331166] Starting dynamic subtest: C-eDP1 [245.611515] Dynamic subtest C-eDP1: SUCCESS (3.287s) [245.621422] Starting dynamic subtest: D-eDP1 [248.915147] Dynamic subtest D-eDP1: SUCCESS (3.302s) [248.917074] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.521s) [249.774864] [097/155] (772s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc) [249.874895] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc [249.877659] Starting dynamic subtest: pipe-A-eDP-1 [249.904866] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [249.914564] Starting dynamic subtest: pipe-B-eDP-1 [249.935226] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [249.943819] Starting dynamic subtest: pipe-C-eDP-1 [249.964774] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [249.973695] Starting dynamic subtest: pipe-D-eDP-1 [249.995370] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [249.999801] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [252.086097] [098/155] (769s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines) [252.628020] Starting subtest: syncobj-stationary-timeline-chain-engines [252.755485] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.130s) [254.365822] [099/155] (767s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite) [254.465032] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite [254.469423] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [254.556544] [100/155] (767s left) gem_exec_whisper (basic-contexts-forked) [254.621766] Starting subtest: basic-contexts-forked [277.812032] Subtest basic-contexts-forked: SUCCESS (23.186s) [277.995704] [101/155] (744s left) kms_invalid_mode (clock-too-high) [278.107196] Starting subtest: clock-too-high [278.109476] Starting dynamic subtest: pipe-A-eDP-1 [278.389740] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s) [278.401489] Starting dynamic subtest: pipe-B-eDP-1 [278.405688] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [278.415429] Starting dynamic subtest: pipe-C-eDP-1 [278.419800] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [278.429344] Starting dynamic subtest: pipe-D-eDP-1 [278.433849] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [278.436043] Subtest clock-too-high: SUCCESS (0.291s) [279.273311] [102/155] (742s left) kms_psr (psr-sprite-mmap-gtt) [279.371171] Starting subtest: psr-sprite-mmap-gtt [279.373442] Starting dynamic subtest: eDP-1 [280.840568] Dynamic subtest eDP-1: SKIP (1.466s) [280.845017] Subtest psr-sprite-mmap-gtt: SKIP (1.468s) [281.012520] [103/155] (741s left) gem_ppgtt (blt-vs-render-ctxn) [281.071969] Starting subtest: blt-vs-render-ctxN [314.060619] Subtest blt-vs-render-ctxN: SUCCESS (32.984s) [314.189207] [104/155] (708s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff) [314.334295] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff [314.338478] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [314.436140] [105/155] (707s left) kms_plane (plane-position-hole) [314.539284] Starting subtest: plane-position-hole [315.055316] Starting dynamic subtest: pipe-A-plane-1 [316.287699] Dynamic subtest pipe-A-plane-1: SUCCESS (1.234s) [316.298839] Starting dynamic subtest: pipe-A-plane-2 [317.650043] Dynamic subtest pipe-A-plane-2: SUCCESS (1.363s) [317.661556] Starting dynamic subtest: pipe-A-plane-3 [318.887107] Dynamic subtest pipe-A-plane-3: SUCCESS (1.233s) [318.897874] Starting dynamic subtest: pipe-A-plane-4 [320.178391] Dynamic subtest pipe-A-plane-4: SUCCESS (1.293s) [320.190025] Starting dynamic subtest: pipe-A-plane-5 [320.203366] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s) [321.422767] Starting dynamic subtest: pipe-B-plane-1 [322.703053] Dynamic subtest pipe-B-plane-1: SUCCESS (1.287s) [322.713078] Starting dynamic subtest: pipe-B-plane-2 [323.975288] Dynamic subtest pipe-B-plane-2: SUCCESS (1.271s) [323.985812] Starting dynamic subtest: pipe-B-plane-3 [325.174831] Dynamic subtest pipe-B-plane-3: SUCCESS (1.201s) [325.185378] Starting dynamic subtest: pipe-B-plane-4 [326.471213] Dynamic subtest pipe-B-plane-4: SUCCESS (1.296s) [326.482728] Starting dynamic subtest: pipe-B-plane-5 [326.499538] Dynamic subtest pipe-B-plane-5: SUCCESS (0.026s) [326.501862] Subtest plane-position-hole: SUCCESS (11.960s) [327.283005] [106/155] (695s left) gem_barrier_race (remote-request) [327.362403] Starting subtest: remote-request [327.364772] Starting dynamic subtest: rcs0 [332.541071] Dynamic subtest rcs0: SUCCESS (5.179s) [332.547348] Subtest remote-request: SUCCESS (5.182s) [332.684812] [107/155] (689s left) kms_cursor_crc (cursor-sliding-64x64) [332.873518] Starting subtest: cursor-sliding-64x64 [332.878482] Starting dynamic subtest: pipe-A-eDP-1 [336.149979] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.270s) [336.178844] Starting dynamic subtest: pipe-D-eDP-1 [340.042139] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.870s) [340.044392] Subtest cursor-sliding-64x64: SUCCESS (7.166s) [340.873619] [108/155] (681s left) kms_addfb_basic (clobberred-modifier) [340.935587] Starting subtest: clobberred-modifier [340.940120] Subtest clobberred-modifier: SKIP (0.000s) [341.095643] [109/155] (681s left) kms_chamelium_edid (dp-edid-change-during-suspend) [341.474887] Subtest dp-edid-change-during-suspend: SKIP (0.000s) [342.261905] [110/155] (680s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt) [342.379082] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt [349.136279] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.762s) [349.248156] [111/155] (673s left) kms_vrr (negative-basic) [349.350217] Starting subtest: negative-basic [349.357330] Starting dynamic subtest: pipe-A-eDP-1 [354.778016] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.419s) [355.090224] Subtest negative-basic: SUCCESS (5.741s) [355.969218] [112/155] (666s left) gem_exec_schedule (preempt-other-chain) [356.045759] Starting subtest: preempt-other-chain [356.047691] Starting dynamic subtest: rcs0 [356.128689] Dynamic subtest rcs0: SUCCESS (0.087s) [356.144470] Starting dynamic subtest: bcs0 [356.207128] Dynamic subtest bcs0: SUCCESS (0.078s) [356.218417] Starting dynamic subtest: vcs0 [356.286383] Dynamic subtest vcs0: SUCCESS (0.078s) [356.296684] Starting dynamic subtest: vcs1 [356.370500] Dynamic subtest vcs1: SUCCESS (0.083s) [356.380633] Starting dynamic subtest: vecs0 [356.453301] Dynamic subtest vecs0: SUCCESS (0.082s) [356.465804] Starting dynamic subtest: ccs0 [356.535176] Dynamic subtest ccs0: SUCCESS (0.081s) [356.537487] Subtest preempt-other-chain: SUCCESS (0.495s) [357.408744] [113/155] (665s left) kms_plane_alpha_blend (constant-alpha-min) [357.502087] Starting subtest: constant-alpha-min [357.777494] Starting dynamic subtest: pipe-A-eDP-1 [358.485554] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.707s) [358.496934] Starting dynamic subtest: pipe-D-eDP-1 [359.995461] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.507s) [359.997913] Subtest constant-alpha-min: SUCCESS (2.495s) [360.873179] [114/155] (661s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-blt) [360.979271] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-blt [360.983423] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [361.079865] [115/155] (661s left) gem_mmap_offset (clear-via-pagefault) [361.139464] Starting subtest: clear-via-pagefault [361.141410] Starting dynamic subtest: smem0 [397.324310] Dynamic subtest smem0: SUCCESS (36.179s) [397.326976] Subtest clear-via-pagefault: SUCCESS (36.181s) [397.424872] [116/155] (625s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu) [397.539339] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu [397.543638] Subtest psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [397.647468] [117/155] (625s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-blt) [397.741789] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-blt [397.746261] Subtest hdr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [397.842966] [118/155] (624s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-blt) [397.942824] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-blt [397.946775] Subtest hdr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s) [398.034479] [119/155] (624s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff) [398.124623] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff [398.128906] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [398.220633] [120/155] (624s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling) [398.326569] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling [398.330668] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s) [398.398692] [121/155] (624s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-pwrite) [398.493927] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-pwrite [398.497517] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [398.615461] [122/155] (624s left) gem_userptr_blits (sd-probe) [398.672084] Starting subtest: sd-probe [398.673611] Subtest sd-probe: SUCCESS (0.000s) [398.797178] [123/155] (624s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [398.902180] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [398.905881] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [399.000916] [124/155] (624s left) gem_create (create-invalid-size) [399.047364] Starting subtest: create-invalid-size [399.049023] Subtest create-invalid-size: SUCCESS (0.000s) [399.235601] [125/155] (623s left) syncobj_wait (multi-wait-all-signaled) [399.307650] Starting subtest: multi-wait-all-signaled [399.310734] Subtest multi-wait-all-signaled: SUCCESS (0.000s) [399.431159] [126/155] (623s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff) [399.529114] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff [406.405056] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.881s) [406.517802] [127/155] (616s left) gem_ctx_persistence (heartbeat-hang) [406.574587] Starting subtest: heartbeat-hang [406.579146] Subtest heartbeat-hang: SKIP (0.000s) [406.675557] [128/155] (616s left) gem_mmap_gtt (cpuset-medium-copy-xy) [406.739762] Subtest cpuset-medium-copy-XY: SKIP (0.000s) [406.806434] [129/155] (616s left) api_intel_bb (object-noreloc-keep-cache-simple) [406.854040] Starting subtest: object-noreloc-keep-cache-simple [406.856457] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.005s) [406.971260] [130/155] (616s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf) [407.067419] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf [407.071736] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s) [407.141860] [131/155] (616s left) kms_content_protection (mei-interface) [407.291577] Starting subtest: mei-interface [407.296082] Subtest mei-interface: SKIP (0.001s) [407.397332] [132/155] (615s left) gem_eio (wait-immediate) [407.613272] Starting subtest: wait-immediate [407.987295] Subtest wait-immediate: SUCCESS (0.373s) [408.126705] [133/155] (615s left) gem_mmap_wc (write-wc-read-gtt) [408.193512] Subtest write-wc-read-gtt: SKIP (0.000s) [408.267172] [134/155] (615s left) kms_feature_discovery (chamelium) [408.346505] Starting subtest: chamelium [408.350291] Subtest chamelium: SKIP (0.000s) [408.431984] [135/155] (615s left) kms_flip (plain-flip-ts-check-interruptible) [408.527288] Starting subtest: plain-flip-ts-check-interruptible [408.529198] Starting dynamic subtest: A-eDP1 [417.422366] Dynamic subtest A-eDP1: SUCCESS (8.894s) [417.433665] Starting dynamic subtest: B-eDP1 [426.238603] Dynamic subtest B-eDP1: SUCCESS (8.814s) [426.252287] Starting dynamic subtest: C-eDP1 [435.103521] Dynamic subtest C-eDP1: SUCCESS (8.864s) [435.115878] Starting dynamic subtest: D-eDP1 [443.908400] Dynamic subtest D-eDP1: SUCCESS (8.803s) [443.913421] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.386s) [445.164696] [136/155] (578s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip) [445.263953] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip [445.268523] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s) [445.367411] [137/155] (578s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0) [445.468871] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0 [446.425958] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (0.957s) [446.535775] [138/155] (577s left) kms_sequence (get-busy) [446.625081] Starting subtest: get-busy [446.627189] Starting dynamic subtest: pipe-A-eDP-1 [448.537071] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.912s) [448.547797] Starting dynamic subtest: pipe-B-eDP-1 [451.125123] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.587s) [451.136765] Starting dynamic subtest: pipe-C-eDP-1 [453.701055] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.571s) [453.711666] Starting dynamic subtest: pipe-D-eDP-1 [456.309380] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.610s) [456.311742] Subtest get-busy: SUCCESS (9.685s) [457.155471] [139/155] (566s left) gem_exec_reloc (basic-gtt-cpu) [457.225337] Subtest basic-gtt-cpu: SKIP (0.000s) [457.301776] [140/155] (566s left) kms_pm_rpm (fences) [459.525395] Starting subtest: fences [459.530278] Subtest fences: SKIP (0.000s) [459.917211] [141/155] (563s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-pwrite) [460.023855] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-pwrite [460.027940] Subtest hdr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [460.131172] [142/155] (563s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [460.232566] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [461.034598] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.803s) [461.195275] [143/155] (562s left) kms_setmode (basic) [461.249099] Starting subtest: basic [461.567166] Starting dynamic subtest: pipe-A-eDP-1 [463.642039] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.070s) [463.988032] Starting dynamic subtest: pipe-B-eDP-1 [466.047167] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.065s) [466.364645] Subtest basic: SUCCESS (5.112s) [467.263377] [144/155] (556s left) sysfs_timeslice_duration (timeout) [467.319800] Starting subtest: timeout [467.322062] Starting dynamic subtest: vecs0 [477.312966] Dynamic subtest vecs0: SUCCESS (9.989s) [477.326592] Starting dynamic subtest: ccs0 [478.577249] Dynamic subtest ccs0: SUCCESS (1.263s) [478.590065] Starting dynamic subtest: vcs0 [488.342167] Dynamic subtest vcs0: SUCCESS (9.735s) [488.355596] Starting dynamic subtest: bcs0 [488.908699] Dynamic subtest bcs0: SUCCESS (0.594s) [488.919153] Starting dynamic subtest: rcs0 [490.133620] Dynamic subtest rcs0: SUCCESS (1.223s) [490.144289] Starting dynamic subtest: vcs1 [499.326910] Dynamic subtest vcs1: SUCCESS (9.189s) [499.329998] Subtest timeout: SUCCESS (32.004s) [499.409910] [145/155] (524s left) kms_cursor_crc (cursor-onscreen-64x64) [499.577554] Starting subtest: cursor-onscreen-64x64 [499.582696] Starting dynamic subtest: pipe-A-eDP-1 [502.221978] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.640s) [502.257320] Starting dynamic subtest: pipe-D-eDP-1 [505.572554] Dynamic subtest pipe-D-eDP-1: FAIL (2.826s) [505.574186] Subtest cursor-onscreen-64x64: FAIL (5.498s) [506.470607] [146/155] (517s left) gem_render_copy (yf-tiled-to-vebox-x-tiled) [506.530359] Starting subtest: yf-tiled-to-vebox-x-tiled [506.534462] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s) [506.712886] [147/155] (517s left) gem_caching (read-writes) [506.767525] Subtest read-writes: SKIP (0.000s) [506.863408] [148/155] (517s left) gem_userptr_blits (map-fixed-invalidate) [506.918891] Starting subtest: map-fixed-invalidate [506.923498] Subtest map-fixed-invalidate: SKIP (0.000s) [507.031385] [149/155] (517s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc) [507.120357] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc [507.122553] Starting dynamic subtest: pipe-A-eDP-1 [507.145474] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [507.159262] Starting dynamic subtest: pipe-B-eDP-1 [507.180886] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [507.191931] Starting dynamic subtest: pipe-C-eDP-1 [507.213716] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [507.223606] Starting dynamic subtest: pipe-D-eDP-1 [507.246261] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [507.250245] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s) [509.356124] [150/155] (514s left) gem_render_copy (y-tiled-ccs-to-x-tiled) [509.421846] Starting subtest: y-tiled-ccs-to-x-tiled [509.426448] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s) [509.614961] [151/155] (514s left) perf (global-sseu-config-invalid) [509.710972] Starting subtest: global-sseu-config-invalid [509.715227] Subtest global-sseu-config-invalid: SKIP (0.000s) [509.761447] [152/155] (514s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt) [509.854575] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt [509.858833] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [509.956105] [153/155] (514s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt) [510.046055] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt [510.050310] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [510.142299] [154/155] (514s left) kms_color (invalid-degamma-lut-sizes) [510.239344] Starting subtest: invalid-degamma-lut-sizes [510.241641] Starting dynamic subtest: pipe-A [510.524184] Dynamic subtest pipe-A: SUCCESS (0.286s) [510.537997] Starting dynamic subtest: pipe-B [510.540264] Dynamic subtest pipe-B: SUCCESS (0.000s) [510.550630] Starting dynamic subtest: pipe-C [510.552896] Dynamic subtest pipe-C: SUCCESS (0.000s) [510.563349] Starting dynamic subtest: pipe-D [510.565219] Dynamic subtest pipe-D: SUCCESS (0.000s) [510.567061] Subtest invalid-degamma-lut-sizes: SUCCESS (0.289s) [511.347546] [155/155] (513s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu) [511.455396] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu [511.459470] Subtest psrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [511.575279] Closing watchdogs results: parsing output: 0/ for test: kms_addfb_basic results: parsing output: 1/ for test: gem_create results: parsing output: 2/ for test: kms_psr results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: gem_exec_parallel 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_ctx_persistence results: parsing output: 8/ for test: kms_frontbuffer_tracking results: parsing output: 9/ for test: kms_psr results: parsing output: 10/ for test: drm_read results: parsing output: 11/ for test: sriov_basic results: parsing output: 12/ for test: kms_big_fb results: parsing output: 13/ for test: syncobj_timeline results: parsing output: 14/ for test: kms_chamelium_hpd results: parsing output: 15/ for test: kms_frontbuffer_tracking results: parsing output: 16/ for test: syncobj_wait results: parsing output: 17/ for test: gem_mmap_gtt results: parsing output: 18/ for test: gem_partial_pwrite_pread results: parsing output: 19/ for test: kms_plane results: parsing output: 20/ for test: syncobj_timeline results: parsing output: 21/ for test: kms_frontbuffer_tracking results: parsing output: 22/ for test: kms_cursor_crc results: parsing output: 23/ for test: kms_frontbuffer_tracking results: parsing output: 24/ for test: i915_pm_freq_mult results: parsing output: 25/ for test: kms_frontbuffer_tracking results: parsing output: 26/ for test: prime_vgem results: parsing output: 27/ for test: gem_pxp results: parsing output: 28/ for test: kms_frontbuffer_tracking results: parsing output: 29/ for test: kms_psr results: parsing output: 30/ for test: kms_ccs results: parsing output: 31/ for test: syncobj_timeline results: parsing output: 32/ for test: i915_drm_fdinfo results: parsing output: 33/ for test: kms_frontbuffer_tracking 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_frontbuffer_tracking results: parsing output: 37/ for test: kms_flip results: parsing output: 38/ for test: syncobj_timeline results: parsing output: 39/ for test: kms_frontbuffer_tracking results: parsing output: 40/ for test: perf_pmu results: parsing output: 41/ for test: kms_flip results: parsing output: 42/ for test: gem_exec_flush results: parsing output: 43/ for test: kms_big_fb results: parsing output: 44/ for test: device_reset results: parsing output: 45/ for test: gem_exec_schedule results: parsing output: 46/ for test: kms_psr results: parsing output: 47/ for test: gem_exec_fence results: parsing output: 48/ for test: gem_eio results: parsing output: 49/ for test: i915_power results: parsing output: 50/ for test: kms_frontbuffer_tracking results: parsing output: 51/ for test: kms_hdmi_inject results: parsing output: 52/ for test: kms_psr2_sf results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: syncobj_basic results: parsing output: 55/ for test: syncobj_wait results: parsing output: 56/ for test: gem_softpin results: parsing output: 57/ for test: kms_frontbuffer_tracking results: parsing output: 58/ for test: kms_frontbuffer_tracking results: parsing output: 59/ for test: kms_psr results: parsing output: 60/ for test: kms_flip results: parsing output: 61/ for test: i915_pm_rps results: parsing output: 62/ for test: kms_frontbuffer_tracking results: parsing output: 63/ for test: kms_invalid_mode results: parsing output: 64/ for test: syncobj_wait results: parsing output: 65/ for test: kms_chamelium_audio results: parsing output: 66/ for test: kms_tv_load_detect results: parsing output: 67/ for test: kms_ccs results: parsing output: 68/ for test: syncobj_wait results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: gem_render_copy_redux results: parsing output: 71/ for test: gem_fenced_exec_thrash results: parsing output: 72/ for test: syncobj_timeline results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: kms_ccs results: parsing output: 76/ for test: kms_frontbuffer_tracking results: parsing output: 77/ for test: gem_exec_reloc results: parsing output: 78/ for test: gem_exec_params results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: syncobj_wait results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: kms_big_fb results: parsing output: 83/ for test: vgem_basic results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: gem_exec_params results: parsing output: 86/ for test: kms_cursor_legacy results: parsing output: 87/ for test: gem_exec_balancer results: parsing output: 88/ for test: gem_exec_whisper results: parsing output: 89/ for test: kms_lease results: parsing output: 90/ for test: kms_pm_rpm results: parsing output: 91/ for test: kms_frontbuffer_tracking results: parsing output: 92/ for test: kms_plane_scaling results: parsing output: 93/ for test: kms_plane results: parsing output: 94/ for test: gen9_exec_parse results: parsing output: 95/ for test: kms_flip results: parsing output: 96/ for test: kms_ccs results: parsing output: 97/ for test: gem_exec_fence results: parsing output: 98/ for test: kms_frontbuffer_tracking results: parsing output: 99/ for test: gem_exec_whisper results: parsing output: 100/ for test: kms_invalid_mode results: parsing output: 101/ for test: kms_psr results: parsing output: 102/ for test: gem_ppgtt results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: kms_plane results: parsing output: 105/ for test: gem_barrier_race results: parsing output: 106/ for test: kms_cursor_crc results: parsing output: 107/ for test: kms_addfb_basic results: parsing output: 108/ for test: kms_chamelium_edid results: parsing output: 109/ for test: kms_frontbuffer_tracking results: parsing output: 110/ for test: kms_vrr results: parsing output: 111/ for test: gem_exec_schedule results: parsing output: 112/ for test: kms_plane_alpha_blend results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: gem_mmap_offset results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: kms_frontbuffer_tracking results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: kms_frontbuffer_tracking results: parsing output: 119/ for test: kms_flip_scaled_crc results: parsing output: 120/ for test: kms_frontbuffer_tracking results: parsing output: 121/ for test: gem_userptr_blits results: parsing output: 122/ for test: kms_big_fb results: parsing output: 123/ for test: gem_create results: parsing output: 124/ for test: syncobj_wait results: parsing output: 125/ for test: kms_frontbuffer_tracking results: parsing output: 126/ for test: gem_ctx_persistence results: parsing output: 127/ for test: gem_mmap_gtt results: parsing output: 128/ for test: api_intel_bb results: parsing output: 129/ for test: kms_psr2_sf results: parsing output: 130/ for test: kms_content_protection results: parsing output: 131/ for test: gem_eio results: parsing output: 132/ for test: gem_mmap_wc results: parsing output: 133/ for test: kms_feature_discovery results: parsing output: 134/ for test: kms_flip results: parsing output: 135/ for test: kms_big_fb results: parsing output: 136/ for test: kms_big_fb results: parsing output: 137/ for test: kms_sequence results: parsing output: 138/ for test: gem_exec_reloc results: parsing output: 139/ for test: kms_pm_rpm results: parsing output: 140/ for test: kms_frontbuffer_tracking results: parsing output: 141/ for test: kms_big_fb results: parsing output: 142/ for test: kms_setmode results: parsing output: 143/ for test: sysfs_timeslice_duration results: parsing output: 144/ for test: kms_cursor_crc results: parsing output: 145/ for test: gem_render_copy results: parsing output: 146/ for test: gem_caching results: parsing output: 147/ for test: gem_userptr_blits results: parsing output: 148/ for test: kms_ccs results: parsing output: 149/ for test: gem_render_copy results: parsing output: 150/ for test: perf results: parsing output: 151/ for test: kms_frontbuffer_tracking results: parsing output: 152/ for test: kms_frontbuffer_tracking results: parsing output: 153/ for test: kms_color results: parsing output: 154/ for test: kms_frontbuffer_tracking Done.