[78.562773] Initializing watchdogs
[78.562879]   /dev/watchdog0
[78.578287] [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]
[78.582718] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[78.585176] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[78.588529] [001/156] (960s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-indfb-plflip-blt)
[78.721120] Starting subtest: fbcpsrhdr-2p-primscrn-indfb-plflip-blt
[78.725372] Subtest fbcpsrhdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[78.822120] [002/156] (960s left) gem_ctx_persistence (engines-persistence)
[78.881792] Starting subtest: engines-persistence
[78.884058] Starting dynamic subtest: rcs0
[79.698069] Dynamic subtest rcs0: SUCCESS (0.818s)
[79.709497] Starting dynamic subtest: bcs0
[80.448518] Dynamic subtest bcs0: SUCCESS (0.750s)
[80.460485] Starting dynamic subtest: vcs0
[81.228415] Dynamic subtest vcs0: SUCCESS (0.779s)
[81.239388] Starting dynamic subtest: vcs1
[81.984088] Dynamic subtest vcs1: SUCCESS (0.754s)
[81.995683] Starting dynamic subtest: vecs0
[82.757695] Dynamic subtest vecs0: SUCCESS (0.773s)
[82.767994] Starting dynamic subtest: ccs0
[83.518934] Dynamic subtest ccs0: SUCCESS (0.760s)
[83.521674] Subtest engines-persistence: SUCCESS (4.638s)
[83.605884] [003/156] (955s left) i915_query (query-topology-kernel-writes)
[83.653799] Starting subtest: query-topology-kernel-writes
[83.655773] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[83.764866] [004/156] (955s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[83.871105] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[83.875210] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[83.960029] [005/156] (955s left) kms_cursor_crc (cursor-offscreen-128x128)
[84.168832] Starting subtest: cursor-offscreen-128x128
[84.184085] Starting dynamic subtest: pipe-A-eDP-1
[86.173684] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.988s)
[86.201846] Starting dynamic subtest: pipe-D-eDP-1
[88.778854] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.580s)
[88.781068] Subtest cursor-offscreen-128x128: SUCCESS (4.606s)
[89.663070] [006/156] (949s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-mmap-gtt)
[89.762621] Starting subtest: psrhdr-rgb101010-draw-mmap-gtt
[89.766789] Subtest psrhdr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[89.859321] [007/156] (949s left) kms_content_protection (legacy-hdcp14)
[89.996780] Starting subtest: legacy-hdcp14
[90.001332] Subtest legacy-hdcp14: SKIP (0.000s)
[90.119611] [008/156] (949s left) kms_plane_lowres (tiling-yf)
[90.210067] Starting subtest: tiling-yf
[90.214335] Subtest tiling-yf: SKIP (0.000s)
[90.280968] [009/156] (949s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[90.385836] Starting subtest: psr-rgb101010-draw-mmap-gtt
[90.390235] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[90.474358] [010/156] (948s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[90.569253] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[90.573463] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[90.654928] [011/156] (948s left) perf (enable-disable)
[90.772791] Starting subtest: enable-disable
[90.774866] Starting dynamic subtest: 0-rcs0
[93.030687] Dynamic subtest 0-rcs0: SUCCESS (2.257s)
[93.040104] Starting dynamic subtest: 1-vecs0
[97.492332] Dynamic subtest 1-vecs0: SUCCESS (4.461s)
[97.494889] Subtest enable-disable: SUCCESS (6.718s)
[97.537880] [012/156] (941s left) gem_userptr_blits (nohangcheck)
[97.611561] Starting subtest: nohangcheck
[97.953772] Subtest nohangcheck: SUCCESS (0.339s)
[98.079611] [013/156] (941s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-blt)
[98.189313] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-blt
[98.193746] Subtest fbchdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[98.296116] [014/156] (941s left) perf (oa-formats)
[98.386075] Starting subtest: oa-formats
[98.388467] Starting dynamic subtest: 0-rcs0
[98.397664] Dynamic subtest 0-rcs0: SUCCESS (0.012s)
[98.405935] Starting dynamic subtest: 1-vcs1
[98.420387] Dynamic subtest 1-vcs1: SUCCESS (0.022s)
[98.422710] Subtest oa-formats: SUCCESS (0.035s)
[98.458519] [015/156] (941s left) kms_psr (fbc-psr-primary-mmap-cpu)
[98.554135] Starting subtest: fbc-psr-primary-mmap-cpu
[98.556132] Starting dynamic subtest: eDP-1
[98.560380] Dynamic subtest eDP-1: SKIP (0.000s)
[98.564656] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.000s)
[98.625357] [016/156] (941s left) kms_plane (plane-position-hole-dpms)
[98.717882] Starting subtest: plane-position-hole-dpms
[99.235274] Starting dynamic subtest: pipe-A-plane-1
[101.645036] Dynamic subtest pipe-A-plane-1: SUCCESS (2.410s)
[101.653691] Starting dynamic subtest: pipe-A-plane-2
[104.009492] Dynamic subtest pipe-A-plane-2: SUCCESS (2.365s)
[104.018823] Starting dynamic subtest: pipe-A-plane-3
[106.430082] Dynamic subtest pipe-A-plane-3: SUCCESS (2.421s)
[106.438827] Starting dynamic subtest: pipe-A-plane-4
[108.768083] Dynamic subtest pipe-A-plane-4: SUCCESS (2.335s)
[108.777639] Starting dynamic subtest: pipe-A-plane-5
[108.794196] Dynamic subtest pipe-A-plane-5: SUCCESS (0.026s)
[109.927197] Starting dynamic subtest: pipe-B-plane-1
[112.285993] Dynamic subtest pipe-B-plane-1: SUCCESS (2.366s)
[112.295913] Starting dynamic subtest: pipe-B-plane-2
[114.630535] Dynamic subtest pipe-B-plane-2: SUCCESS (2.343s)
[114.639356] Starting dynamic subtest: pipe-B-plane-3
[116.905503] Dynamic subtest pipe-B-plane-3: SUCCESS (2.274s)
[116.914202] Starting dynamic subtest: pipe-B-plane-4
[119.185287] Dynamic subtest pipe-B-plane-4: SUCCESS (2.279s)
[119.194790] Starting dynamic subtest: pipe-B-plane-5
[119.209508] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s)
[119.211774] Subtest plane-position-hole-dpms: SUCCESS (20.488s)
[119.991071] [017/156] (919s left) kms_frontbuffer_tracking (fbc-tiling-4)
[120.098213] Starting subtest: fbc-tiling-4
[124.507607] Subtest fbc-tiling-4: SUCCESS (4.415s)
[125.744741] [018/156] (913s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[125.842139] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[125.846189] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[125.940217] [019/156] (913s left) kms_setmode (basic)
[126.000261] Starting subtest: basic
[126.321229] Starting dynamic subtest: pipe-A-eDP-1
[128.447738] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.121s)
[128.789930] Starting dynamic subtest: pipe-B-eDP-1
[130.877301] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.088s)
[131.184126] Subtest basic: SUCCESS (5.180s)
[132.031892] [020/156] (907s left) kms_pm_backlight (fade-with-suspend)
[132.119423] Starting subtest: fade-with-suspend
[147.880974] Starting dynamic subtest: eDP-1
[150.932043] Dynamic subtest eDP-1: SUCCESS (2.952s)
[150.934507] Subtest fade-with-suspend: SUCCESS (4.256s)
[151.817830] [021/156] (888s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-pri-indfb-multidraw)
[151.938850] Starting subtest: fbcpsrhdr-1p-pri-indfb-multidraw
[151.943048] Subtest fbcpsrhdr-1p-pri-indfb-multidraw: SKIP (0.000s)
[152.045742] [022/156] (887s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[152.089526] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[152.091912] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[152.202513] [023/156] (887s left) gem_huc_copy (huc-copy)
[152.260463] Starting subtest: huc-copy
[152.265164] Subtest huc-copy: SUCCESS (0.003s)
[152.394767] [024/156] (887s left) gem_pxp (create-regular-buffer)
[152.513507] Starting subtest: create-regular-buffer
[152.516097] Subtest create-regular-buffer: SUCCESS (0.000s)
[152.640545] [025/156] (887s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[152.727409] Starting subtest: primary-y-tiled-reflect-x-270
[152.731432] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[152.802681] [026/156] (887s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[152.899103] Starting subtest: 4-tiled-8bpp-rotate-270
[152.922546] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.021s)
[153.035223] [027/156] (887s left) kms_vblank (ts-continuation-dpms-rpm)
[153.118738] Starting subtest: ts-continuation-dpms-rpm
[153.120593] Starting dynamic subtest: pipe-A-eDP-1
[155.701282] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.525s)
[155.715528] Starting dynamic subtest: pipe-D-eDP-1
[157.994987] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.256s)
[157.997214] Subtest ts-continuation-dpms-rpm: SUCCESS (4.785s)
[158.903136] [028/156] (881s left) kms_chamelium_color (ctm-red-to-blue)
[159.000183] Subtest ctm-red-to-blue: SKIP (0.000s)
[159.043584] [029/156] (881s left) kms_psr (pr-cursor-plane-onoff)
[159.138197] Starting subtest: pr-cursor-plane-onoff
[159.142522] Subtest pr-cursor-plane-onoff: SKIP (0.000s)
[159.210639] [030/156] (881s left) perf (blocking-parameterized)
[159.299390] Starting subtest: blocking-parameterized
[179.315269] Subtest blocking-parameterized: SUCCESS (19.929s)
[179.367896] [031/156] (860s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[179.476776] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[179.480715] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[179.565473] [032/156] (860s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[179.682946] Starting subtest: 2x-long-flip-vs-cursor-atomic
[179.687601] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[179.828908] [033/156] (860s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[179.917393] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[179.924512] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.010s)
[180.013404] [034/156] (860s left) gem_exec_schedule (pi-ringfull)
[180.191536] Starting subtest: pi-ringfull
[180.193836] Starting dynamic subtest: rcs0
[180.260831] Dynamic subtest rcs0: SUCCESS (0.072s)
[180.274319] Starting dynamic subtest: bcs0
[180.289213] Dynamic subtest bcs0: SUCCESS (0.028s)
[180.302634] Starting dynamic subtest: vcs0
[180.315607] Dynamic subtest vcs0: SUCCESS (0.026s)
[180.329605] Starting dynamic subtest: vcs1
[180.341370] Dynamic subtest vcs1: SUCCESS (0.025s)
[180.354001] Starting dynamic subtest: vecs0
[180.368385] Dynamic subtest vecs0: SUCCESS (0.026s)
[180.381984] Starting dynamic subtest: ccs0
[180.394789] Dynamic subtest ccs0: SUCCESS (0.026s)
[180.396957] Subtest pi-ringfull: SUCCESS (0.207s)
[180.614960] [FACT gem_exec_schedule (pi-ringfull)] new: kernel.kmod_is_loaded.vgem: true
[180.618428] [035/156] (859s left) gem_exec_whisper (basic-fds-priority-all)
[180.680044] Starting subtest: basic-fds-priority-all
[204.150630] Subtest basic-fds-priority-all: SUCCESS (23.458s)
[204.351107] [036/156] (836s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[204.409864] Starting subtest: etime-multi-wait-all-for-submit-submitted
[204.518908] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.108s)
[204.604870] [037/156] (835s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[204.701492] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[204.703951] Starting dynamic subtest: pipe-A-eDP-1
[204.799943] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s)
[204.809614] Starting dynamic subtest: pipe-B-eDP-1
[205.971846] Dynamic subtest pipe-B-eDP-1: SKIP (1.170s)
[205.976659] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.271s)
[207.251035] [038/156] (833s left) vgem_basic (bad-pad)
[207.294335] Starting subtest: bad-pad
[207.296383] Subtest bad-pad: SUCCESS (0.000s)
[207.375457] [039/156] (833s left) api_intel_allocator (fork-simple-once)
[207.424586] Starting subtest: fork-simple-once
[207.440812] Subtest fork-simple-once: SUCCESS (0.017s)
[207.564885] [040/156] (833s left) gem_exec_schedule (u-submit-early-slice)
[207.633056] Starting subtest: u-submit-early-slice
[207.635454] Starting dynamic subtest: rcs0
[207.675635] Dynamic subtest rcs0: SUCCESS (0.047s)
[207.689353] Starting dynamic subtest: bcs0
[207.712756] Dynamic subtest bcs0: SUCCESS (0.036s)
[207.722667] Starting dynamic subtest: vcs0
[207.748841] Dynamic subtest vcs0: SUCCESS (0.036s)
[207.758660] Starting dynamic subtest: vcs1
[207.783157] Dynamic subtest vcs1: SUCCESS (0.034s)
[207.792884] Starting dynamic subtest: vecs0
[207.824824] Dynamic subtest vecs0: SUCCESS (0.041s)
[207.835551] Starting dynamic subtest: ccs0
[207.863597] Dynamic subtest ccs0: SUCCESS (0.038s)
[207.866194] Subtest u-submit-early-slice: SUCCESS (0.236s)
[208.857335] [041/156] (831s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[208.955158] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[208.959167] Subtest hdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[209.060529] [042/156] (831s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[209.167503] Starting subtest: cursorB-vs-flipB-varying-size
[209.171948] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[209.311354] [043/156] (831s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[209.423628] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[209.547790] [044/156] (831s left) kms_pwrite_crc (basic)
[209.650732] Starting subtest: basic
[210.346406] Subtest basic: SUCCESS (0.695s)
[211.185699] [045/156] (829s left) gem_mmap_wc (invalid-flags)
[211.244013] Subtest invalid-flags: SKIP (0.000s)
[211.306482] [046/156] (829s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[211.411675] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[211.415928] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[211.502300] [047/156] (829s left) gem_mmap_gtt (fault-concurrent-x)
[211.549429] Subtest fault-concurrent-X: SKIP (0.000s)
[211.612623] [048/156] (829s left) gem_exec_balancer (parallel-keep-in-fence)
[211.869630] Starting subtest: parallel-keep-in-fence
[213.016628] Subtest parallel-keep-in-fence: SUCCESS (1.146s)
[213.127324] [049/156] (827s left) kms_rotation_crc (cursor-rotation-180)
[213.215634] Starting subtest: cursor-rotation-180
[214.748318] Subtest cursor-rotation-180: SUCCESS (1.533s)
[215.979336] [050/156] (825s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[216.070740] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-mmap-cpu
[216.075266] Subtest fbchdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[216.174431] [051/156] (824s left) gem_exec_reloc (basic-cpu-noreloc)
[216.238432] Subtest basic-cpu-noreloc: SKIP (0.000s)
[216.311299] [052/156] (824s left) kms_color (invalid-ctm-matrix-sizes)
[216.407534] Starting subtest: invalid-ctm-matrix-sizes
[216.409876] Starting dynamic subtest: pipe-A
[216.412150] Dynamic subtest pipe-A: SUCCESS (0.002s)
[216.421449] Starting dynamic subtest: pipe-B
[216.423717] Dynamic subtest pipe-B: SUCCESS (0.003s)
[216.432773] Starting dynamic subtest: pipe-C
[216.434631] Dynamic subtest pipe-C: SUCCESS (0.003s)
[216.443596] Starting dynamic subtest: pipe-D
[216.445778] Dynamic subtest pipe-D: SUCCESS (0.004s)
[216.448002] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.014s)
[216.489085] [053/156] (824s left) gem_softpin (full)
[216.551085] Starting subtest: full
[216.556737] Subtest full: SUCCESS (0.008s)
[216.689760] [054/156] (824s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[216.781361] Starting subtest: fbc-psr2-primary-mmap-cpu
[216.783546] Starting dynamic subtest: eDP-1
[216.787541] Dynamic subtest eDP-1: SKIP (0.000s)
[216.791593] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[216.852750] [055/156] (824s left) core_getversion (all-cards)
[216.888079] Starting subtest: all-cards
[216.896258] Subtest all-cards: SUCCESS (0.010s)
[216.938170] [056/156] (824s left) gem_eio (reset-stress)
[217.156501] Starting subtest: reset-stress
[217.158407] Starting dynamic subtest: render
[222.274160] Dynamic subtest render: SUCCESS (5.113s)
[222.285624] Starting dynamic subtest: bsd1
[240.284761] Dynamic subtest bsd1: SUCCESS (18.000s)
[240.294464] Starting dynamic subtest: bsd2
[258.347515] Dynamic subtest bsd2: SUCCESS (18.066s)
[258.364271] Starting dynamic subtest: blt
[258.368508] Dynamic subtest blt: SKIP (0.000s)
[258.377748] Starting dynamic subtest: vebox
[276.317446] Dynamic subtest vebox: SUCCESS (17.971s)
[276.319712] Subtest reset-stress: SUCCESS (59.153s)
[277.791844] [057/156] (763s left) prime_busy (before)
[277.851978] Starting subtest: before
[277.856933] Starting dynamic subtest: rcs0
[277.883824] Dynamic subtest rcs0: SUCCESS (0.028s)
[277.894685] Starting dynamic subtest: bcs0
[277.929340] Dynamic subtest bcs0: SUCCESS (0.044s)
[277.938808] Starting dynamic subtest: vcs0
[277.969341] Dynamic subtest vcs0: SUCCESS (0.039s)
[277.978447] Starting dynamic subtest: vcs1
[278.008617] Dynamic subtest vcs1: SUCCESS (0.039s)
[278.017653] Starting dynamic subtest: vecs0
[278.047747] Dynamic subtest vecs0: SUCCESS (0.038s)
[278.056826] Starting dynamic subtest: ccs0
[278.088081] Dynamic subtest ccs0: SUCCESS (0.038s)
[278.196406] Subtest before: SUCCESS (0.342s)
[278.277860] [058/156] (763s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-move)
[278.380050] Starting subtest: fbchdr-1p-primscrn-spr-indfb-move
[278.384330] Subtest fbchdr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[278.488309] [059/156] (762s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping)
[278.586828] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping
[278.614550] Starting dynamic subtest: pipe-A-plane-0
[278.916511] Dynamic subtest pipe-A-plane-0: SUCCESS (0.300s)
[278.926311] Starting dynamic subtest: pipe-A-plane-3
[279.147350] Dynamic subtest pipe-A-plane-3: SUCCESS (0.231s)
[280.229540] Starting dynamic subtest: pipe-B-plane-0
[280.521184] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[280.531569] Starting dynamic subtest: pipe-B-plane-3
[280.754121] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s)
[281.069401] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.482s)
[281.914425] [060/156] (759s left) kms_flip (flip-vs-rmfb)
[282.006949] Starting subtest: flip-vs-rmfb
[282.009312] Starting dynamic subtest: A-eDP1
[290.693538] Dynamic subtest A-eDP1: SUCCESS (8.685s)
[290.705058] Starting dynamic subtest: B-eDP1
[299.333169] Dynamic subtest B-eDP1: SUCCESS (8.636s)
[299.344995] Starting dynamic subtest: C-eDP1
[307.961262] Dynamic subtest C-eDP1: SUCCESS (8.624s)
[307.973275] Starting dynamic subtest: D-eDP1
[316.609208] Dynamic subtest D-eDP1: SUCCESS (8.644s)
[316.614051] Subtest flip-vs-rmfb: SUCCESS (34.599s)
[317.796325] [061/156] (723s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-pwrite)
[317.891189] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-pwrite
[317.895453] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[317.988910] [062/156] (723s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[318.081179] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[323.152894] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (5.076s)
[323.291734] [063/156] (718s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-blt)
[323.388920] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-blt
[323.392933] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[323.487489] [064/156] (718s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-indfb-pgflip-blt)
[323.591518] Starting subtest: fbcpsrhdr-2p-scndscrn-indfb-pgflip-blt
[323.595867] Subtest fbcpsrhdr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[323.695350] [065/156] (717s left) syncobj_timeline (invalid-transfer-illegal-handle)
[323.738836] Starting subtest: invalid-transfer-illegal-handle
[323.740740] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[323.836865] [066/156] (717s left) kms_dp_aux_dev (basic)
[323.883142] Starting subtest: basic
[324.106253] Subtest basic: SUCCESS (0.223s)
[324.177110] [067/156] (717s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[324.446098] Starting subtest: cursor-rapid-movement-256x85
[324.488521] Subtest cursor-rapid-movement-256x85: SKIP (0.041s)
[324.653500] [068/156] (717s left) fbdev (info)
[324.691067] Starting subtest: info
[324.693286] Subtest info: SUCCESS (0.000s)
[324.768513] [069/156] (717s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-pwrite)
[324.856339] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-pwrite
[324.860446] Subtest psrhdr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[324.969792] [070/156] (716s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[325.072385] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf
[325.074180] Starting dynamic subtest: pipe-A-eDP-1
[335.784712] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.712s)
[335.796524] Starting dynamic subtest: pipe-B-eDP-1
[347.179425] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.386s)
[347.181429] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.101s)
[348.047750] [071/156] (693s left) gem_mmap_wc (fault-concurrent)
[348.098715] Subtest fault-concurrent: SKIP (0.000s)
[348.155600] [072/156] (693s left) gem_ctx_persistence (legacy-engines-cleanup)
[348.209324] Starting subtest: legacy-engines-cleanup
[348.211788] Starting dynamic subtest: render
[348.287679] Dynamic subtest render: SUCCESS (0.077s)
[348.300805] Starting dynamic subtest: bsd1
[348.322123] Dynamic subtest bsd1: SUCCESS (0.033s)
[348.333789] Starting dynamic subtest: bsd2
[348.367106] Dynamic subtest bsd2: SUCCESS (0.043s)
[348.380630] Starting dynamic subtest: blt
[348.393111] Dynamic subtest blt: SUCCESS (0.023s)
[348.403029] Starting dynamic subtest: vebox
[348.453219] Dynamic subtest vebox: SUCCESS (0.059s)
[348.455791] Subtest legacy-engines-cleanup: SUCCESS (0.245s)
[348.561935] [073/156] (693s left) kms_properties (get_properties-sanity-atomic)
[348.662621] Starting subtest: get_properties-sanity-atomic
[348.664738] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[348.742171] [074/156] (693s left) kms_flip (2x-flip-vs-suspend)
[348.846384] Starting subtest: 2x-flip-vs-suspend
[348.850872] Subtest 2x-flip-vs-suspend: SKIP (0.002s)
[348.961112] [075/156] (693s left) gem_ctx_create (basic-files)
[349.008714] Starting subtest: basic-files
[351.247629] Subtest basic-files: SUCCESS (2.237s)
[352.802668] [076/156] (689s left) kms_hdmi_inject (inject-audio)
[353.153713] Starting subtest: inject-audio
[353.447811] Subtest inject-audio: SUCCESS (0.296s)
[353.999795] [077/156] (688s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[354.102922] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[361.572294] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.471s)
[361.697477] [078/156] (680s left) kms_psr (psr-cursor-mmap-cpu)
[361.790632] Starting subtest: psr-cursor-mmap-cpu
[361.792828] Starting dynamic subtest: eDP-1
[363.532266] Dynamic subtest eDP-1: SUCCESS (1.738s)
[363.534606] Subtest psr-cursor-mmap-cpu: SUCCESS (1.739s)
[364.376387] [079/156] (677s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[364.483151] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu
[364.487621] Subtest psrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[364.582216] [080/156] (677s left) gem_ctx_param (invalid-size-set)
[364.633671] Starting subtest: invalid-size-set
[364.636058] Subtest invalid-size-set: SUCCESS (0.001s)
[364.717888] [081/156] (677s left) gem_eio (in-flight-external)
[364.942455] Starting subtest: in-flight-external
[366.855081] Subtest in-flight-external: SUCCESS (1.911s)
[366.969540] [082/156] (675s left) sw_sync (sync_merge)
[367.008202] Starting subtest: sync_merge
[367.010275] Subtest sync_merge: SUCCESS (0.000s)
[367.057953] [083/156] (675s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[367.107789] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[367.214961] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.106s)
[367.304455] [084/156] (675s left) kms_plane_alpha_blend (alpha-7efc)
[367.389902] Starting subtest: alpha-7efc
[367.665654] Starting dynamic subtest: pipe-A-eDP-1
[368.281571] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.616s)
[368.310487] Starting dynamic subtest: pipe-D-eDP-1
[369.572823] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.270s)
[369.575333] Subtest alpha-7efc: SUCCESS (2.182s)
[370.386468] [085/156] (672s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[370.487813] Starting subtest: psr-farfromfence-mmap-gtt
[370.492014] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[370.590880] [086/156] (672s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[370.690527] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[371.349252] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.660s)
[371.508571] [087/156] (671s left) i915_power (sanity)
[371.554596] Starting subtest: sanity
[371.558823] Subtest sanity: SKIP (0.000s)
[371.653987] [088/156] (671s left) kms_busy (extended-pageflip-hang-oldfb)
[371.750770] Starting subtest: extended-pageflip-hang-oldfb
[371.753047] Starting dynamic subtest: pipe-A
[372.146140] Dynamic subtest pipe-A: SUCCESS (0.396s)
[372.157585] Starting dynamic subtest: pipe-D
[373.255874] Dynamic subtest pipe-D: SUCCESS (1.107s)
[373.258294] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.507s)
[374.075489] [089/156] (668s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[374.178689] Starting subtest: x-tiled-64bpp-rotate-180
[375.735062] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.557s)
[375.879260] [090/156] (666s left) kms_atomic (plane-primary-legacy)
[375.975656] Starting subtest: plane-primary-legacy
[375.977991] Starting dynamic subtest: pipe-A-eDP-1
[376.405252] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.428s)
[376.407546] Subtest plane-primary-legacy: SUCCESS (0.430s)
[377.275247] [091/156] (665s left) gem_mmap_wc (read-write)
[377.330261] Subtest read-write: SKIP (0.000s)
[377.389788] [092/156] (665s left) gem_ctx_engines (execute-allforone)
[377.444029] Starting subtest: execute-allforone
[377.459832] Subtest execute-allforone: SUCCESS (0.016s)
[378.845440] [093/156] (664s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[378.947365] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-mmap-cpu
[378.951355] Subtest hdr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[379.058315] [094/156] (663s left) gem_softpin (noreloc-s3)
[379.109842] Starting subtest: noreloc-S3
[399.167969] Subtest noreloc-S3: SUCCESS (5.418s)
[399.314318] [095/156] (643s left) kms_joiner (basic-big-joiner)
[399.421157] Starting subtest: basic-big-joiner
[399.425656] Subtest basic-big-joiner: SKIP (0.000s)
[399.510834] [096/156] (643s left) gem_exec_params (no-bsd)
[399.579525] Starting subtest: no-bsd
[399.584312] Subtest no-bsd: SUCCESS (0.003s)
[401.293537] [097/156] (641s left) kms_cursor_crc (cursor-sliding-64x21)
[401.487726] Starting subtest: cursor-sliding-64x21
[401.535175] Subtest cursor-sliding-64x21: SKIP (0.042s)
[401.781362] [098/156] (641s left) kms_psr (fbc-pr-primary-mmap-gtt)
[401.877017] Starting subtest: fbc-pr-primary-mmap-gtt
[401.881099] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[401.954302] [099/156] (641s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[402.066150] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[409.101584] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (6.948s)
[409.228614] [100/156] (633s left) prime_mmap (test_aperture_limit)
[409.282460] Starting subtest: test_aperture_limit
[409.284663] Starting dynamic subtest: test_aperture_limit-smem
[409.289688] Dynamic subtest test_aperture_limit-smem: SKIP (0.008s)
[409.293743] Subtest test_aperture_limit: SKIP (0.008s)
[409.382973] [101/156] (633s left) kms_frontbuffer_tracking (psrhdr-suspend)
[409.476102] Starting subtest: psrhdr-suspend
[409.480464] Subtest psrhdr-suspend: SKIP (0.000s)
[409.591014] [102/156] (633s left) dumb_buffer (map-uaf)
[409.644672] Starting subtest: map-uaf
[409.647179] Subtest map-uaf: SUCCESS (0.005s)
[409.752854] [103/156] (633s left) gem_exec_gttfill (engines)
[409.810425] Starting subtest: engines
[409.812957] Starting dynamic subtest: rcs0
[432.847593] Dynamic subtest rcs0: SUCCESS (22.977s)
[432.858297] Starting dynamic subtest: bcs0
[456.185690] Dynamic subtest bcs0: SUCCESS (23.324s)
[456.199572] Starting dynamic subtest: vcs0
[479.506855] Dynamic subtest vcs0: SUCCESS (23.310s)
[479.517358] Starting dynamic subtest: vcs1
[502.788926] Dynamic subtest vcs1: SUCCESS (23.280s)
[502.799964] Starting dynamic subtest: vecs0
[526.036718] Dynamic subtest vecs0: SUCCESS (23.249s)
[526.046949] Starting dynamic subtest: ccs0
[549.315767] Dynamic subtest ccs0: SUCCESS (23.273s)
[549.318551] Subtest engines: SUCCESS (139.424s)
[549.509979] [104/156] (493s left) kms_flip (blocking-wf_vblank)
[549.671558] Starting subtest: blocking-wf_vblank
[549.673966] Starting dynamic subtest: A-eDP1
[558.647255] Dynamic subtest A-eDP1: SUCCESS (8.976s)
[558.661478] Starting dynamic subtest: B-eDP1
[567.559196] Dynamic subtest B-eDP1: SUCCESS (8.906s)
[567.571468] Starting dynamic subtest: C-eDP1
[576.452948] Dynamic subtest C-eDP1: SUCCESS (8.889s)
[576.465998] Starting dynamic subtest: D-eDP1
[585.358288] Dynamic subtest D-eDP1: SUCCESS (8.901s)
[585.363242] Subtest blocking-wf_vblank: SUCCESS (35.686s)
[586.538252] [105/156] (456s left) kms_vblank (query-forked-busy-hang)
[586.649281] Starting subtest: query-forked-busy-hang
[586.651183] Starting dynamic subtest: pipe-A-eDP-1
[613.022095] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.364s)
[613.038897] Starting dynamic subtest: pipe-D-eDP-1
[627.995467] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.969s)
[627.997339] Subtest query-forked-busy-hang: SUCCESS (41.338s)
[628.845486] [106/156] (414s left) i915_pm_rpm (sysfs-read)
[630.387260] Starting subtest: sysfs-read
[631.556230] Subtest sysfs-read: SUCCESS (1.166s)
[631.942100] [107/156] (411s left) gem_request_retire (retire-vma-not-inactive)
[632.011614] Starting subtest: retire-vma-not-inactive
[632.072276] Subtest retire-vma-not-inactive: SUCCESS (0.058s)
[632.205541] [108/156] (411s left) kms_frontbuffer_tracking (fbchdr-stridechange)
[632.308428] Starting subtest: fbchdr-stridechange
[632.312430] Subtest fbchdr-stridechange: SKIP (0.000s)
[632.424089] [109/156] (411s left) kms_chamelium_frames (dp-frame-dump)
[632.810805] Subtest dp-frame-dump: SKIP (0.000s)
[633.625096] [110/156] (410s left) gem_userptr_blits (stress-mm)
[633.689364] Starting subtest: stress-mm
[639.057751] Subtest stress-mm: SUCCESS (5.369s)
[639.218658] [111/156] (404s left) prime_mmap (test_userptr)
[639.264540] Starting subtest: test_userptr
[639.267002] Starting dynamic subtest: test_userptr-smem
[639.269293] Dynamic subtest test_userptr-smem: SUCCESS (0.001s)
[639.271625] Subtest test_userptr: SUCCESS (0.004s)
[639.391721] [112/156] (404s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[639.483525] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[639.487798] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[639.591394] [113/156] (404s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[639.687098] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[639.689333] Starting dynamic subtest: pipe-A-eDP-1
[639.709656] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[639.722201] Starting dynamic subtest: pipe-B-eDP-1
[639.741387] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[639.751288] Starting dynamic subtest: pipe-C-eDP-1
[639.770674] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[639.780279] Starting dynamic subtest: pipe-D-eDP-1
[639.799699] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[639.801652] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[641.963444] [114/156] (401s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[642.012545] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[642.016691] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[642.208782] [115/156] (401s left) gem_exec_balancer (bonded-pair)
[642.268183] Starting subtest: bonded-pair
[642.272633] Subtest bonded-pair: SKIP (0.000s)
[642.556151] [116/156] (401s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[642.642668] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[642.644877] Starting dynamic subtest: pipe-A-default-mode
[643.766964] Dynamic subtest pipe-A-default-mode: SKIP (1.122s)
[643.771323] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.123s)
[643.905528] [117/156] (400s left) kms_lease (simple-lease)
[644.002174] Starting subtest: simple-lease
[644.004496] Starting dynamic subtest: pipe-A-eDP-1
[644.498876] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.498s)
[644.510781] Starting dynamic subtest: pipe-B-eDP-1
[645.955970] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.454s)
[645.966396] Starting dynamic subtest: pipe-C-eDP-1
[647.444133] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.486s)
[647.454746] Starting dynamic subtest: pipe-D-eDP-1
[648.840228] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.398s)
[648.842560] Subtest simple-lease: SUCCESS (4.841s)
[649.672588] [118/156] (394s left) kms_pm_rpm (system-suspend-modeset)
[651.399961] Starting subtest: system-suspend-modeset
[670.131971] Subtest system-suspend-modeset: SUCCESS (4.260s)
[670.534300] [119/156] (373s left) gem_mmap_gtt (ptrace)
[670.601685] Subtest ptrace: SKIP (0.000s)
[670.664077] [120/156] (373s left) prime_vgem (basic-fence-mmap)
[670.727584] Starting subtest: basic-fence-mmap
[670.732065] Subtest basic-fence-mmap: SKIP (0.000s)
[670.829827] [121/156] (373s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[670.929383] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[670.933835] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[671.046701] [122/156] (373s left) perf_pmu (render-node-busy-idle)
[671.133862] Starting subtest: render-node-busy-idle
[671.136059] Starting dynamic subtest: rcs0
[671.853728] Dynamic subtest rcs0: SUCCESS (0.700s)
[671.867738] Starting dynamic subtest: bcs0
[672.583052] Dynamic subtest bcs0: FAIL (0.654s)
[672.596195] Starting dynamic subtest: vcs0
[673.269587] Dynamic subtest vcs0: FAIL (0.651s)
[673.281801] Starting dynamic subtest: vcs1
[674.325113] Dynamic subtest vcs1: FAIL (1.034s)
[674.337906] Starting dynamic subtest: vecs0
[676.369502] Dynamic subtest vecs0: FAIL (2.001s)
[676.380885] Starting dynamic subtest: ccs0
[678.349641] Dynamic subtest ccs0: FAIL (1.951s)
[678.351941] Subtest render-node-busy-idle: FAIL (6.998s)
[678.396839] [123/156] (365s left) i915_drm_fdinfo (memory-info-active)
[678.438194] Starting subtest: memory-info-active
[678.440515] Starting dynamic subtest: smem0
[681.287180] Dynamic subtest smem0: SUCCESS (2.818s)
[681.289952] Subtest memory-info-active: SUCCESS (2.820s)
[681.376128] [124/156] (362s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-pwrite)
[681.468282] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-pwrite
[681.471762] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[681.570470] [125/156] (362s left) kms_draw_crc (draw-method-mmap-gtt)
[681.661666] Starting subtest: draw-method-mmap-gtt
[681.665314] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[681.774173] [126/156] (362s left) gen7_exec_parse (cmd-crossing-page)
[681.838858] Subtest cmd-crossing-page: SKIP (0.000s)
[681.912106] [127/156] (362s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[681.999226] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc
[682.002725] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[682.089928] [128/156] (362s left) i915_pm_freq_api (freq-basic-api)
[682.152169] Starting subtest: freq-basic-api
[682.154405] Starting dynamic subtest: gt0
[682.156866] Dynamic subtest gt0: SUCCESS (0.003s)
[682.171016] Starting dynamic subtest: gt1
[682.172620] Dynamic subtest gt1: SUCCESS (0.002s)
[682.174161] Subtest freq-basic-api: SUCCESS (0.008s)
[682.287207] [129/156] (362s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[682.388400] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc
[682.391883] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[682.491528] [130/156] (362s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[682.556032] Starting subtest: yf-tiled-ccs-to-x-tiled
[682.559761] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[682.752790] [131/156] (361s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[682.839943] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[682.842290] Starting dynamic subtest: pipe-A-eDP-1
[715.157149] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.829s)
[715.170635] Starting dynamic subtest: pipe-B-eDP-1
[749.074435] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.698s)
[749.087272] Starting dynamic subtest: pipe-C-eDP-1
[782.053825] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.630s)
[782.066774] Starting dynamic subtest: pipe-D-eDP-1
[815.007784] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.593s)
[815.010241] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (13.756s)
[816.254652] [132/156] (228s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-blt)
[816.356678] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-blt
[816.360756] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[816.467466] [133/156] (228s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-mmap-wc)
[816.570003] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-mmap-wc
[816.574560] Subtest hdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[816.666513] [134/156] (228s left) gem_exec_fence (syncobj-timeline-export)
[817.259452] Starting subtest: syncobj-timeline-export
[817.266103] Subtest syncobj-timeline-export: SUCCESS (0.007s)
[818.781040] [135/156] (225s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[818.907339] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[825.656872] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.645s)
[825.774110] [136/156] (219s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[825.863345] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[833.261144] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.354s)
[833.387590] [137/156] (211s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[833.493023] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[833.497404] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s)
[833.578525] [138/156] (211s left) gem_wait (invalid-buf)
[833.635297] Starting subtest: invalid-buf
[833.637213] Subtest invalid-buf: SUCCESS (0.000s)
[833.843703] [139/156] (211s left) syncobj_wait (wait-all-delayed-signal)
[833.901706] Starting subtest: wait-all-delayed-signal
[834.005885] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[834.101481] [140/156] (210s left) kms_pm_rpm (drm-resources-equal)
[835.925197] Starting subtest: drm-resources-equal
[841.020447] Subtest drm-resources-equal: SUCCESS (5.086s)
[841.127918] [141/156] (203s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-blt)
[841.230597] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-blt
[841.234636] Subtest hdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[841.346732] [142/156] (203s left) gem_ctx_shared (q-out-order)
[841.399934] Starting subtest: Q-out-order
[841.402335] Starting dynamic subtest: rcs0
[841.501018] Dynamic subtest rcs0: SUCCESS (0.100s)
[841.519125] Starting dynamic subtest: vcs0
[841.585656] Dynamic subtest vcs0: SUCCESS (0.083s)
[841.605024] Starting dynamic subtest: vcs1
[841.670545] Dynamic subtest vcs1: SUCCESS (0.083s)
[841.690076] Starting dynamic subtest: vecs0
[841.745746] Dynamic subtest vecs0: SUCCESS (0.074s)
[841.764035] Starting dynamic subtest: ccs0
[841.828660] Dynamic subtest ccs0: SUCCESS (0.082s)
[841.831258] Subtest Q-out-order: SUCCESS (0.428s)
[842.786269] [143/156] (202s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[842.891944] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[842.896374] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[842.982345] [144/156] (202s left) gem_exec_reloc (basic-write-gtt-noreloc)
[843.031137] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[843.105145] [145/156] (202s left) gem_mmap_gtt (basic-small-copy)
[843.153041] Subtest basic-small-copy: SKIP (0.000s)
[843.214928] [146/156] (202s left) syncobj_timeline (multi-wait-signaled)
[843.268473] Starting subtest: multi-wait-signaled
[843.270866] Subtest multi-wait-signaled: SUCCESS (0.001s)
[843.381735] [147/156] (201s left) kms_big_fb (linear-8bpp-rotate-180)
[843.482876] Starting subtest: linear-8bpp-rotate-180
[844.719342] Subtest linear-8bpp-rotate-180: SUCCESS (1.235s)
[844.830851] [148/156] (200s left) syncobj_timeline (wait-delayed-signal)
[844.884504] Starting subtest: wait-delayed-signal
[844.985978] Subtest wait-delayed-signal: SUCCESS (0.102s)
[845.067582] [149/156] (200s left) kms_chamelium_hpd (hdmi-hpd)
[845.456259] Subtest hdmi-hpd: SKIP (0.000s)
[846.277883] [150/156] (199s left) kms_rotation_crc (primary-rotation-270)
[846.378753] Starting subtest: primary-rotation-270
[846.383529] Subtest primary-rotation-270: SKIP (0.001s)
[846.474741] [151/156] (199s left) kms_properties (connector-properties-atomic)
[846.575425] Starting subtest: connector-properties-atomic
[846.577742] Starting dynamic subtest: pipe-A-eDP-1
[854.663236] Dynamic subtest pipe-A-eDP-1: SUCCESS (8.087s)
[854.677522] Starting dynamic subtest: pipe-None-DP-1
[854.682083] Dynamic subtest pipe-None-DP-1: SUCCESS (0.002s)
[854.693528] Starting dynamic subtest: pipe-None-HDMI-A-1
[854.697673] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[854.707900] Starting dynamic subtest: pipe-None-DP-2
[854.711973] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[854.722477] Starting dynamic subtest: pipe-None-HDMI-A-2
[854.727099] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[854.737606] Starting dynamic subtest: pipe-None-DP-3
[854.742177] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[854.752107] Starting dynamic subtest: pipe-None-DP-4
[854.756070] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[854.757962] Subtest connector-properties-atomic: SUCCESS (8.099s)
[855.499079] [152/156] (190s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[855.595555] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[860.023770] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.433s)
[861.203009] [153/156] (184s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[861.318729] Starting subtest: 2x-flip-vs-cursor-atomic
[861.323457] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[861.464098] [154/156] (184s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-shrfb-plflip-blt)
[861.559086] Starting subtest: hdr-2p-scndscrn-shrfb-plflip-blt
[861.563039] Subtest hdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[861.649247] [155/156] (184s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[861.745768] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[861.750066] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[862.901222] [156/156] (182s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[862.988965] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[862.991133] Starting dynamic subtest: pipe-A-eDP-1
[863.048548] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[863.059168] Starting dynamic subtest: pipe-B-eDP-1
[863.116060] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[863.128414] Starting dynamic subtest: pipe-C-eDP-1
[863.185600] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[863.197633] Starting dynamic subtest: pipe-D-eDP-1
[863.255492] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[863.259896] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.009s)
[865.294437] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_ctx_persistence
results: parsing output: 2/ for test: i915_query
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: kms_cursor_crc
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_content_protection
results: parsing output: 7/ for test: kms_plane_lowres
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: perf
results: parsing output: 11/ for test: gem_userptr_blits
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: perf
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: kms_plane
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_setmode
results: parsing output: 19/ for test: kms_pm_backlight
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: syncobj_wait
results: parsing output: 22/ for test: gem_huc_copy
results: parsing output: 23/ for test: gem_pxp
results: parsing output: 24/ for test: kms_rotation_crc
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_vblank
results: parsing output: 27/ for test: kms_chamelium_color
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: perf
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_cursor_legacy
results: parsing output: 32/ for test: kms_flip
results: parsing output: 33/ for test: gem_exec_schedule
results: parsing output: 34/ for test: gem_exec_whisper
results: parsing output: 35/ for test: syncobj_timeline
results: parsing output: 36/ for test: kms_psr2_sf
results: parsing output: 37/ for test: vgem_basic
results: parsing output: 38/ for test: api_intel_allocator
results: parsing output: 39/ for test: gem_exec_schedule
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_cursor_legacy
results: parsing output: 42/ for test: kms_addfb_basic
results: parsing output: 43/ for test: kms_pwrite_crc
results: parsing output: 44/ for test: gem_mmap_wc
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: gem_mmap_gtt
results: parsing output: 47/ for test: gem_exec_balancer
results: parsing output: 48/ for test: kms_rotation_crc
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_exec_reloc
results: parsing output: 51/ for test: kms_color
results: parsing output: 52/ for test: gem_softpin
results: parsing output: 53/ for test: kms_psr
results: parsing output: 54/ for test: core_getversion
results: parsing output: 55/ for test: gem_eio
results: parsing output: 56/ for test: prime_busy
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_plane
results: parsing output: 59/ for test: kms_flip
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: syncobj_timeline
results: parsing output: 65/ for test: kms_dp_aux_dev
results: parsing output: 66/ for test: kms_cursor_crc
results: parsing output: 67/ for test: fbdev
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_psr2_sf
results: parsing output: 70/ for test: gem_mmap_wc
results: parsing output: 71/ for test: gem_ctx_persistence
results: parsing output: 72/ for test: kms_properties
results: parsing output: 73/ for test: kms_flip
results: parsing output: 74/ for test: gem_ctx_create
results: parsing output: 75/ for test: kms_hdmi_inject
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_psr
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_ctx_param
results: parsing output: 80/ for test: gem_eio
results: parsing output: 81/ for test: sw_sync
results: parsing output: 82/ for test: syncobj_timeline
results: parsing output: 83/ for test: kms_plane_alpha_blend
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: i915_power
results: parsing output: 87/ for test: kms_busy
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: kms_atomic
results: parsing output: 90/ for test: gem_mmap_wc
results: parsing output: 91/ for test: gem_ctx_engines
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gem_softpin
results: parsing output: 94/ for test: kms_joiner
results: parsing output: 95/ for test: gem_exec_params
results: parsing output: 96/ for test: kms_cursor_crc
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: prime_mmap
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: dumb_buffer
results: parsing output: 102/ for test: gem_exec_gttfill
results: parsing output: 103/ for test: kms_flip
results: parsing output: 104/ for test: kms_vblank
results: parsing output: 105/ for test: i915_pm_rpm
results: parsing output: 106/ for test: gem_request_retire
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_chamelium_frames
results: parsing output: 109/ for test: gem_userptr_blits
results: parsing output: 110/ for test: prime_mmap
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_ccs
results: parsing output: 113/ for test: gem_render_copy
results: parsing output: 114/ for test: gem_exec_balancer
results: parsing output: 115/ for test: kms_flip_scaled_crc
results: parsing output: 116/ for test: kms_lease
results: parsing output: 117/ for test: kms_pm_rpm
results: parsing output: 118/ for test: gem_mmap_gtt
results: parsing output: 119/ for test: prime_vgem
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: perf_pmu
results: parsing output: 122/ for test: i915_drm_fdinfo
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_draw_crc
results: parsing output: 125/ for test: gen7_exec_parse
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: i915_pm_freq_api
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: gem_render_copy
results: parsing output: 130/ for test: kms_ccs
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: gem_exec_fence
results: parsing output: 134/ for test: kms_frontbuffer_tracking
results: parsing output: 135/ for test: kms_frontbuffer_tracking
results: parsing output: 136/ for test: kms_flip_scaled_crc
results: parsing output: 137/ for test: gem_wait
results: parsing output: 138/ for test: syncobj_wait
results: parsing output: 139/ for test: kms_pm_rpm
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: gem_ctx_shared
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: gem_exec_reloc
results: parsing output: 144/ for test: gem_mmap_gtt
results: parsing output: 145/ for test: syncobj_timeline
results: parsing output: 146/ for test: kms_big_fb
results: parsing output: 147/ for test: syncobj_timeline
results: parsing output: 148/ for test: kms_chamelium_hpd
results: parsing output: 149/ for test: kms_rotation_crc
results: parsing output: 150/ for test: kms_properties
results: parsing output: 151/ for test: kms_frontbuffer_tracking
results: parsing output: 152/ for test: kms_cursor_legacy
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: kms_ccs
results: parsing output: 155/ for test: kms_ccs
Done.