[57.635851] Initializing watchdogs
[57.635900]   /dev/watchdog0
[57.652121] [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.656901] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.659143] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.662545] [001/133] (960s left) kms_pm_dc (dc3co-vpb-simulation)
[58.792806] Starting subtest: dc3co-vpb-simulation
[67.885236] Subtest dc3co-vpb-simulation: SKIP (9.042s)
[68.122932] [002/133] (950s left) kms_addfb_basic (bad-pitch-1024)
[68.183164] Starting subtest: bad-pitch-1024
[68.185637] Subtest bad-pitch-1024: SUCCESS (0.000s)
[68.328713] [003/133] (949s left) dmabuf_sync_file (export-wait-after-attach)
[68.404821] Starting subtest: export-wait-after-attach
[68.407074] Subtest export-wait-after-attach: SUCCESS (0.001s)
[68.472535] [FACT dmabuf_sync_file (export-wait-after-attach)] new: kernel.kmod_is_loaded.vgem: true
[68.476163] [004/133] (949s left) kms_flip (2x-plain-flip-fb-recreate)
[68.569339] Starting subtest: 2x-plain-flip-fb-recreate
[68.580900] Subtest 2x-plain-flip-fb-recreate: SKIP (0.011s)
[68.662936] [005/133] (949s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[68.734486] Starting subtest: x-tiled-to-vebox-y-tiled
[68.738688] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[68.925083] [006/133] (949s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[69.043343] Starting subtest: short-flip-after-cursor-atomic-transitions
[70.022964] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.975s)
[70.825361] [007/133] (947s left) gem_workarounds (reset)
[70.896831] Starting subtest: reset
[70.993746] Subtest reset: SUCCESS (0.099s)
[71.121030] [008/133] (947s left) gem_exec_big (single)
[71.178904] Starting subtest: single
[76.031295] Subtest single: SUCCESS (4.844s)
[76.289471] [009/133] (942s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[76.449709] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[76.454304] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[76.554019] [010/133] (941s left) perf_pmu (most-busy-idle-check-all)
[76.599880] Starting subtest: most-busy-idle-check-all
[76.601781] Starting dynamic subtest: rcs0
[77.911994] Dynamic subtest rcs0: SUCCESS (1.310s)
[77.922304] Starting dynamic subtest: bcs0
[79.894674] Dynamic subtest bcs0: SUCCESS (1.979s)
[79.905379] Starting dynamic subtest: vcs0
[81.942656] Dynamic subtest vcs0: SUCCESS (2.045s)
[81.953957] Starting dynamic subtest: vcs1
[83.924835] Dynamic subtest vcs1: SUCCESS (1.981s)
[83.933757] Starting dynamic subtest: vecs0
[85.911173] Dynamic subtest vecs0: SUCCESS (1.982s)
[85.922286] Starting dynamic subtest: ccs0
[87.896879] Dynamic subtest ccs0: SUCCESS (1.982s)
[87.899886] Subtest most-busy-idle-check-all: SUCCESS (11.286s)
[88.008902] [011/133] (930s left) kms_addfb_basic (master-rmfb)
[88.069830] Starting subtest: master-rmfb
[88.072063] Subtest master-rmfb: SUCCESS (0.001s)
[88.213328] [012/133] (930s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[88.302872] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[88.305680] Starting dynamic subtest: pipe-A-eDP-1
[88.327330] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[88.342033] Starting dynamic subtest: pipe-B-eDP-1
[88.361222] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[88.370163] Starting dynamic subtest: pipe-C-eDP-1
[88.389246] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[88.397314] Starting dynamic subtest: pipe-D-eDP-1
[88.418186] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[88.420530] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.004s)
[90.594485] [013/133] (928s left) prime_self_import (basic-with_fd_dup)
[90.634608] Starting subtest: basic-with_fd_dup
[90.671075] Subtest basic-with_fd_dup: SUCCESS (0.038s)
[90.783183] [014/133] (927s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[90.879063] Starting subtest: fbc-rgb565-draw-mmap-gtt
[90.882964] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[90.971852] [015/133] (927s left) gem_exec_balancer (full-late-pulse)
[91.040096] Starting subtest: full-late-pulse
[95.835052] Subtest full-late-pulse: SUCCESS (4.794s)
[96.156166] [016/133] (922s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[96.281605] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[97.162630] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.882s)
[97.333545] [017/133] (921s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[97.432321] Starting subtest: psr2-cursor-plane-update-sf
[97.434673] Starting dynamic subtest: pipe-A-eDP-1
[97.991632] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.563s)
[98.001737] Starting dynamic subtest: pipe-B-eDP-1
[99.270885] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.277s)
[99.273297] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.842s)
[100.145620] [018/133] (918s left) gem_blits (basic)
[100.223675] Starting subtest: basic
[101.662070] Subtest basic: SUCCESS (1.436s)
[101.778213] [019/133] (917s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[101.876143] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[101.880379] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[101.979050] [020/133] (916s left) gem_shrink (reclaim)
[102.045581] Starting subtest: reclaim
[104.485827] Subtest reclaim: SUCCESS (2.439s)
[104.606197] [021/133] (914s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[104.656440] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[104.658529] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[104.755781] [022/133] (914s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[104.855766] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[104.860095] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[104.937815] [023/133] (914s left) syncobj_timeline (invalid-query-zero-handles)
[105.001967] Starting subtest: invalid-query-zero-handles
[105.003947] Subtest invalid-query-zero-handles: SUCCESS (0.000s)
[105.106628] [024/133] (913s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[105.194347] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[105.196587] Starting dynamic subtest: pipe-A-eDP-1
[105.205500] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[105.213972] Starting dynamic subtest: pipe-B-eDP-1
[105.222979] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[105.232466] Starting dynamic subtest: pipe-C-eDP-1
[105.240879] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[105.248810] Starting dynamic subtest: pipe-D-eDP-1
[105.257232] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[105.261274] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.003s)
[107.508858] [025/133] (911s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[107.609704] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[107.614224] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[107.700729] [026/133] (911s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[107.802789] Starting subtest: primary-4-tiled-reflect-x-0
[114.835798] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.033s)
[116.074299] [027/133] (903s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k)
[116.452930] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s)
[117.288532] [028/133] (901s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[117.345920] Starting subtest: legacy-engines-hostile-preempt
[117.348263] Starting dynamic subtest: render
[117.433230] Dynamic subtest render: SUCCESS (0.089s)
[117.443039] Starting dynamic subtest: bsd1
[118.862683] Dynamic subtest bsd1: SUCCESS (1.426s)
[118.879074] Starting dynamic subtest: bsd2
[120.913581] Dynamic subtest bsd2: SUCCESS (2.048s)
[120.925076] Starting dynamic subtest: blt
[120.971772] Dynamic subtest blt: SUCCESS (0.058s)
[120.982472] Starting dynamic subtest: vebox
[122.897595] Dynamic subtest vebox: SUCCESS (1.922s)
[122.900492] Subtest legacy-engines-hostile-preempt: SUCCESS (5.552s)
[122.994173] [029/133] (896s left) gem_ctx_param (non-root-set)
[123.058607] Starting subtest: non-root-set
[123.082981] Subtest non-root-set: SUCCESS (0.024s)
[123.185857] [030/133] (896s left) kms_hdr (bpc-switch)
[123.283784] Starting subtest: bpc-switch
[124.372063] Starting dynamic subtest: pipe-A-eDP-1
[127.870363] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.497s)
[127.872769] Subtest bpc-switch: SUCCESS (4.588s)
[127.997163] [031/133] (891s left) gem_exec_create (madvise)
[128.058880] Starting subtest: madvise
[128.061193] Starting dynamic subtest: smem
[149.972327] Dynamic subtest smem: SUCCESS (21.912s)
[149.975278] Subtest madvise: SUCCESS (21.913s)
[150.825242] [032/133] (868s left) gem_ctx_shared (detached-shared-gtt)
[150.890760] Starting subtest: detached-shared-gtt
[153.047106] Subtest detached-shared-gtt: SUCCESS (2.155s)
[153.323333] [033/133] (866s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[153.441487] Starting subtest: basic-flip-before-cursor-legacy
[154.373723] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.934s)
[155.181052] [034/133] (864s left) api_intel_bb (simple-bb)
[155.235945] Starting subtest: simple-bb
[155.240495] Subtest simple-bb: SUCCESS (0.005s)
[155.369785] [035/133] (864s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[155.463253] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[155.467887] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s)
[155.548746] [036/133] (864s left) gem_exec_reloc (basic-cpu-active)
[155.617030] Subtest basic-cpu-active: SKIP (0.000s)
[155.678210] [037/133] (863s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[155.782708] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[155.786769] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[155.883374] [038/133] (863s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[155.985255] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[155.990103] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[156.073756] [039/133] (863s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[156.121973] Starting subtest: single-wait-all-for-submit-signaled
[156.123971] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[156.216625] [040/133] (863s left) kms_joiner (basic-ultra-joiner)
[156.313806] Starting subtest: basic-ultra-joiner
[156.317306] Subtest basic-ultra-joiner: SKIP (0.000s)
[156.396216] [041/133] (863s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[156.492294] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[156.495890] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[156.603658] [042/133] (863s left) gem_mmap_wc (read-write)
[156.663126] Subtest read-write: SKIP (0.000s)
[156.731065] [043/133] (863s left) gem_exec_flush (basic-wb-ro-default)
[156.789298] Starting subtest: basic-wb-ro-default
[162.243625] Subtest basic-wb-ro-default: SUCCESS (5.453s)
[162.431568] [044/133] (857s left) gem_pxp (display-protected-crc)
[162.566669] Starting subtest: display-protected-crc
[164.226787] Subtest display-protected-crc: SUCCESS (1.663s)
[164.336378] [045/133] (855s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[164.427676] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[165.528148] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.101s)
[165.657030] [046/133] (854s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[166.242070] Starting subtest: syncobj-timeline-invalid-flags
[166.244914] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s)
[167.972477] [047/133] (852s left) kms_prime (basic-modeset-hybrid)
[168.060173] Subtest basic-modeset-hybrid: SKIP (0.000s)
[168.163522] [048/133] (851s left) kms_debugfs (display-on-read-all)
[168.251594] Starting subtest: display-on-read-all
[168.419322] Subtest display-on-read-all: SUCCESS (0.167s)
[168.530682] [049/133] (851s left) sw_sync (alloc_fence_invalid_timeline)
[168.570978] Starting subtest: alloc_fence_invalid_timeline
[168.573181] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[168.630841] [050/133] (851s left) gem_userptr_blits (stress-mm-invalidate-close)
[168.711648] Starting subtest: stress-mm-invalidate-close
[170.859479] Subtest stress-mm-invalidate-close: SUCCESS (2.148s)
[170.987996] [051/133] (849s left) kms_plane_multiple (tiling-yf)
[171.091786] Starting subtest: tiling-yf
[171.096064] Subtest tiling-yf: SKIP (0.000s)
[171.165452] [052/133] (849s left) kms_sequence (queue-idle)
[171.269799] Starting subtest: queue-idle
[171.272017] Starting dynamic subtest: pipe-A-eDP-1
[173.083324] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.813s)
[173.093061] Starting dynamic subtest: pipe-B-eDP-1
[175.541603] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.457s)
[175.550427] Starting dynamic subtest: pipe-C-eDP-1
[177.967334] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.425s)
[177.977639] Starting dynamic subtest: pipe-D-eDP-1
[180.385989] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.417s)
[180.388054] Subtest queue-idle: SUCCESS (9.116s)
[181.195171] [053/133] (839s left) kms_cursor_crc (cursor-sliding-128x128)
[181.397025] Starting subtest: cursor-sliding-128x128
[181.401824] Starting dynamic subtest: pipe-A-eDP-1
[184.644704] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.244s)
[184.678628] Starting dynamic subtest: pipe-D-eDP-1
[188.518090] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.846s)
[188.520487] Subtest cursor-sliding-128x128: SUCCESS (7.119s)
[189.390517] [054/133] (830s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[189.491367] Starting subtest: x-tiled-64bpp-rotate-180
[191.170657] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.679s)
[191.339850] [055/133] (829s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[191.428377] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[191.430399] Starting dynamic subtest: pipe-A-eDP-1
[191.478997] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[191.486723] Starting dynamic subtest: pipe-B-eDP-1
[191.530628] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[191.539040] Starting dynamic subtest: pipe-C-eDP-1
[191.583063] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[191.590678] Starting dynamic subtest: pipe-D-eDP-1
[191.634962] Dynamic subtest pipe-D-eDP-1: SKIP (0.002s)
[191.638266] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.011s)
[193.753957] [056/133] (826s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[193.848476] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[193.852515] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[193.950711] [057/133] (826s left) kms_psr (pr-cursor-blt)
[194.054720] Starting subtest: pr-cursor-blt
[194.059087] Subtest pr-cursor-blt: SKIP (0.000s)
[194.125915] [058/133] (826s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[194.217598] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[194.219810] Starting dynamic subtest: pipe-A-default-mode
[195.412117] Dynamic subtest pipe-A-default-mode: SKIP (1.191s)
[195.416512] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.192s)
[195.554128] [059/133] (825s left) drm_read (short-buffer-nonblock)
[195.701201] Starting subtest: short-buffer-nonblock
[195.703456] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[195.827887] [060/133] (824s left) kms_frontbuffer_tracking (psr-slowdraw)
[195.926846] Starting subtest: psr-slowdraw
[221.360994] Subtest psr-slowdraw: SUCCESS (25.436s)
[221.504394] [061/133] (799s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[221.612782] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[221.617155] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[221.707510] [062/133] (799s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[221.812684] Starting subtest: fbcpsr-tiling-4
[228.992193] Subtest fbcpsr-tiling-4: SUCCESS (7.182s)
[229.138836] [063/133] (791s left) perf (invalid-oa-exponent)
[229.273497] Starting subtest: invalid-oa-exponent
[229.285340] Subtest invalid-oa-exponent: SUCCESS (0.012s)
[229.325753] [064/133] (791s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[229.448107] Starting subtest: basic-busy-flip-before-cursor-legacy
[229.452472] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[229.593473] [065/133] (791s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[229.689779] Starting subtest: fbc-psr2-sprite-mmap-cpu
[229.692101] Starting dynamic subtest: eDP-1
[229.696105] Dynamic subtest eDP-1: SKIP (0.000s)
[229.700134] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[229.762995] [066/133] (791s left) kms_chamelium_color (ctm-max)
[229.849226] Subtest ctm-max: SKIP (0.000s)
[229.894211] [067/133] (791s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[229.993249] Starting subtest: plane-lut1d-ctm3x4
[230.141911] Starting dynamic subtest: pipe-A-plane-0
[230.460970] Dynamic subtest pipe-A-plane-0: FAIL (0.177s)
[230.471081] Starting dynamic subtest: pipe-A-plane-1
[230.669202] Dynamic subtest pipe-A-plane-1: FAIL (0.175s)
[230.678698] Starting dynamic subtest: pipe-A-plane-2
[230.873100] Dynamic subtest pipe-A-plane-2: FAIL (0.177s)
[231.900260] Starting dynamic subtest: pipe-B-plane-0
[232.364056] Dynamic subtest pipe-B-plane-0: FAIL (0.197s)
[232.374778] Starting dynamic subtest: pipe-B-plane-1
[232.693827] Dynamic subtest pipe-B-plane-1: FAIL (0.166s)
[232.704856] Starting dynamic subtest: pipe-B-plane-2
[232.990058] Dynamic subtest pipe-B-plane-2: FAIL (0.177s)
[233.687339] Starting dynamic subtest: pipe-C-plane-0
[234.203966] Dynamic subtest pipe-C-plane-0: FAIL (0.154s)
[234.215058] Starting dynamic subtest: pipe-C-plane-1
[234.612353] Dynamic subtest pipe-C-plane-1: FAIL (0.626s)
[234.622062] Starting dynamic subtest: pipe-C-plane-2
[234.984142] Dynamic subtest pipe-C-plane-2: FAIL (0.164s)
[235.828406] Starting dynamic subtest: pipe-D-plane-0
[236.413623] Dynamic subtest pipe-D-plane-0: FAIL (0.141s)
[236.423545] Starting dynamic subtest: pipe-D-plane-1
[236.870580] Dynamic subtest pipe-D-plane-1: FAIL (0.605s)
[236.881034] Starting dynamic subtest: pipe-D-plane-2
[237.315620] Dynamic subtest pipe-D-plane-2: FAIL (0.557s)
[237.430722] Subtest plane-lut1d-ctm3x4: FAIL (7.437s)
[238.291817] [068/133] (782s left) kms_cursor_edge_walk (256x256-left-edge)
[238.387327] Starting subtest: 256x256-left-edge
[238.389706] Starting dynamic subtest: pipe-A-eDP-1
[241.861992] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.474s)
[241.871722] Starting dynamic subtest: pipe-D-eDP-1
[244.975099] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.111s)
[244.977428] Subtest 256x256-left-edge: SUCCESS (6.588s)
[245.791666] [069/133] (775s left) i915_drm_fdinfo (memory-info-resident)
[245.835095] Starting subtest: memory-info-resident
[245.837507] Starting dynamic subtest: smem0
[248.248232] Dynamic subtest smem0: SUCCESS (2.412s)
[248.250249] Subtest memory-info-resident: SUCCESS (2.413s)
[248.321163] [070/133] (772s left) kms_getfb (getfb-handle-zero)
[248.418613] Starting subtest: getfb-handle-zero
[248.420603] Subtest getfb-handle-zero: SUCCESS (0.000s)
[248.507534] [071/133] (772s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[248.611362] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[248.613271] Starting dynamic subtest: pipe-A
[248.673686] Dynamic subtest pipe-A: SUCCESS (0.064s)
[248.682631] Starting dynamic subtest: pipe-B
[249.813167] Dynamic subtest pipe-B: SUCCESS (1.138s)
[249.823722] Starting dynamic subtest: pipe-C
[250.921079] Dynamic subtest pipe-C: SUCCESS (1.106s)
[250.931402] Starting dynamic subtest: pipe-D
[252.051597] Dynamic subtest pipe-D: SUCCESS (1.130s)
[252.053859] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.442s)
[253.200355] [072/133] (767s left) gem_exec_params (no-blt)
[253.260619] Starting subtest: no-blt
[253.263100] Subtest no-blt: SUCCESS (0.002s)
[253.390319] [073/133] (767s left) gem_ctx_persistence (engines-cleanup)
[253.444314] Starting subtest: engines-cleanup
[253.446736] Starting dynamic subtest: rcs0
[253.508967] Dynamic subtest rcs0: SUCCESS (0.064s)
[253.520901] Starting dynamic subtest: bcs0
[253.546629] Dynamic subtest bcs0: SUCCESS (0.036s)
[253.559577] Starting dynamic subtest: vcs0
[253.564560] Dynamic subtest vcs0: SUCCESS (0.016s)
[253.576757] Starting dynamic subtest: vcs1
[253.607450] Dynamic subtest vcs1: SUCCESS (0.042s)
[253.617102] Starting dynamic subtest: vecs0
[253.654394] Dynamic subtest vecs0: SUCCESS (0.046s)
[253.664634] Starting dynamic subtest: ccs0
[253.696603] Dynamic subtest ccs0: SUCCESS (0.040s)
[253.698990] Subtest engines-cleanup: SUCCESS (0.253s)
[253.775408] [074/133] (767s left) i915_pm_rpm (system-suspend-devices)
[256.014983] Starting subtest: system-suspend-devices
[263.872488] Subtest system-suspend-devices: SUCCESS (7.859s)
[264.258425] [075/133] (756s left) kms_vblank (wait-idle)
[264.368476] Starting subtest: wait-idle
[264.370766] Starting dynamic subtest: pipe-A-eDP-1
[266.131591] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.764s)
[266.146926] Starting dynamic subtest: pipe-D-eDP-1
[268.579957] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.446s)
[268.582406] Subtest wait-idle: SUCCESS (4.214s)
[269.410429] [076/133] (751s left) kms_lease (setcrtc-implicit-plane)
[269.520804] Starting subtest: setcrtc-implicit-plane
[269.523541] Starting dynamic subtest: pipe-A-eDP-1
[269.988357] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.466s)
[270.000206] Starting dynamic subtest: pipe-B-eDP-1
[271.142170] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.152s)
[271.152521] Starting dynamic subtest: pipe-C-eDP-1
[272.237974] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.093s)
[272.248951] Starting dynamic subtest: pipe-D-eDP-1
[273.392895] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.153s)
[273.395381] Subtest setcrtc-implicit-plane: SUCCESS (3.872s)
[274.223914] [077/133] (747s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[274.319983] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[277.892211] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.576s)
[279.030799] [078/133] (742s left) gen9_exec_parse (bb-secure)
[279.089952] Subtest bb-secure: SKIP (0.000s)
[279.164183] [079/133] (742s left) gem_wait (write-busy)
[279.220227] Starting subtest: write-busy
[279.222703] Starting dynamic subtest: all-engines
[279.831787] Dynamic subtest all-engines: SUCCESS (0.611s)
[279.849033] Starting dynamic subtest: rcs0
[280.387840] Dynamic subtest rcs0: SUCCESS (0.553s)
[280.404823] Starting dynamic subtest: bcs0
[280.937838] Dynamic subtest bcs0: SUCCESS (0.549s)
[280.954942] Starting dynamic subtest: vcs0
[282.902186] Dynamic subtest vcs0: SUCCESS (1.962s)
[282.918658] Starting dynamic subtest: vcs1
[284.886524] Dynamic subtest vcs1: SUCCESS (1.982s)
[284.903081] Starting dynamic subtest: vecs0
[286.934533] Dynamic subtest vecs0: SUCCESS (2.045s)
[286.950916] Starting dynamic subtest: ccs0
[287.484707] Dynamic subtest ccs0: SUCCESS (0.549s)
[287.487394] Subtest write-busy: SUCCESS (8.265s)
[287.685948] [080/133] (733s left) kms_content_protection (dp-mst-type-1-suspend-resume)
[287.829629] Starting subtest: dp-mst-type-1-suspend-resume
[287.834436] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s)
[287.960014] [081/133] (733s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[288.068446] Starting subtest: modeset-transition-nonblocking-fencing
[288.070657] Starting dynamic subtest: 1x-outputs
[299.092923] Dynamic subtest 1x-outputs: SUCCESS (11.022s)
[299.095806] Subtest modeset-transition-nonblocking-fencing: SUCCESS (11.023s)
[299.944512] [082/133] (721s left) syncobj_eventfd (timeline-wait)
[300.000874] Starting subtest: timeline-wait
[300.009476] Subtest timeline-wait: SUCCESS (0.010s)
[300.085716] [083/133] (721s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[300.196097] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[300.200077] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[300.286136] [084/133] (721s left) kms_psr (psr2-cursor-plane-onoff)
[300.385918] Starting subtest: psr2-cursor-plane-onoff
[300.388059] Starting dynamic subtest: eDP-1
[302.115476] Dynamic subtest eDP-1: SUCCESS (1.731s)
[302.117700] Subtest psr2-cursor-plane-onoff: SUCCESS (1.732s)
[302.920022] [085/133] (718s left) gem_mmap_wc (fault-concurrent)
[302.981114] Subtest fault-concurrent: SKIP (0.000s)
[303.044698] [086/133] (718s left) gem_softpin (allocator-fork)
[303.101766] Starting subtest: allocator-fork
[305.323822] Subtest allocator-fork: SUCCESS (2.221s)
[305.450191] [087/133] (716s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[305.561871] Starting subtest: compare-crc-sanitycheck-xr24
[305.564084] Starting dynamic subtest: pipe-A-eDP-1
[306.216075] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.649s)
[306.226644] Starting dynamic subtest: pipe-B-eDP-1
[307.531065] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.317s)
[307.541159] Starting dynamic subtest: pipe-C-eDP-1
[308.768095] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.234s)
[308.777846] Starting dynamic subtest: pipe-D-eDP-1
[309.991038] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.220s)
[309.992991] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.427s)
[310.832902] [088/133] (710s left) kms_psr (fbc-psr2-sprite-render)
[310.926200] Starting subtest: fbc-psr2-sprite-render
[310.928520] Starting dynamic subtest: eDP-1
[310.932714] Dynamic subtest eDP-1: SKIP (0.000s)
[310.936839] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[311.003368] [089/133] (710s left) syncobj_timeline (multi-wait-all-signaled)
[311.056807] Starting subtest: multi-wait-all-signaled
[311.059088] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[311.165225] [090/133] (710s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[311.276673] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[311.280702] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[311.374161] [091/133] (710s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[311.467352] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[311.469662] Starting dynamic subtest: pipe-A-eDP-1
[311.492763] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[311.504167] Starting dynamic subtest: pipe-B-eDP-1
[311.526091] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[311.534998] Starting dynamic subtest: pipe-C-eDP-1
[311.555696] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[311.564955] Starting dynamic subtest: pipe-D-eDP-1
[311.587104] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[311.591200] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[313.636332] [092/133] (708s left) gem_lmem_swapping (heavy-verify-multi)
[313.685394] Subtest heavy-verify-multi: SKIP (0.000s)
[313.733495] [093/133] (708s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[313.826534] Starting subtest: 4-tiled-32bpp-rotate-90
[313.847225] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.020s)
[313.961996] [094/133] (708s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[314.024658] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[314.028603] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[314.206300] [095/133] (707s left) gem_partial_pwrite_pread (reads)
[314.278616] Subtest reads: SKIP (0.000s)
[314.356833] [096/133] (707s left) sriov_basic (enable-vfs-bind-unbind-each)
[314.412539] Starting subtest: enable-vfs-bind-unbind-each
[314.414533] Starting dynamic subtest: numvfs-1
[314.489146] Dynamic subtest numvfs-1: FAIL (0.005s)
[314.498847] Starting dynamic subtest: numvfs-2
[314.572076] Dynamic subtest numvfs-2: FAIL (0.004s)
[314.582724] Starting dynamic subtest: numvfs-3
[314.655434] Dynamic subtest numvfs-3: FAIL (0.004s)
[314.666065] Starting dynamic subtest: numvfs-4
[314.738374] Dynamic subtest numvfs-4: FAIL (0.003s)
[314.748987] Starting dynamic subtest: numvfs-5
[314.822563] Dynamic subtest numvfs-5: FAIL (0.004s)
[314.831828] Starting dynamic subtest: numvfs-6
[314.905871] Dynamic subtest numvfs-6: FAIL (0.003s)
[314.917461] Starting dynamic subtest: numvfs-7
[314.991018] Dynamic subtest numvfs-7: FAIL (0.004s)
[315.001756] Starting dynamic subtest: numvfs-random
[315.074071] Dynamic subtest numvfs-random: FAIL (0.003s)
[315.076084] Subtest enable-vfs-bind-unbind-each: FAIL (0.035s)
[315.116311] [097/133] (707s left) gem_exec_fence (syncobj-timeline-wait)
[315.681678] Starting subtest: syncobj-timeline-wait
[316.917856] Subtest syncobj-timeline-wait: SUCCESS (1.240s)
[318.984325] [098/133] (703s left) syncobj_wait (invalid-wait-illegal-handle)
[319.036023] Starting subtest: invalid-wait-illegal-handle
[319.038246] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[319.133810] [099/133] (703s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[319.238487] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[319.242729] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[319.358545] [100/133] (702s left) gem_exec_schedule (in-order)
[319.429489] Starting subtest: in-order
[319.431453] Starting dynamic subtest: rcs0
[319.534566] Dynamic subtest rcs0: SUCCESS (0.109s)
[319.547392] Starting dynamic subtest: vcs0
[319.631711] Dynamic subtest vcs0: SUCCESS (0.097s)
[319.644199] Starting dynamic subtest: vcs1
[319.779519] Dynamic subtest vcs1: SUCCESS (0.145s)
[319.792377] Starting dynamic subtest: vecs0
[319.883301] Dynamic subtest vecs0: SUCCESS (0.102s)
[319.894346] Starting dynamic subtest: ccs0
[319.970877] Dynamic subtest ccs0: SUCCESS (0.086s)
[319.973025] Subtest in-order: SUCCESS (0.548s)
[321.016618] [101/133] (701s left) i915_module_load (reload)
[321.055275] Starting subtest: reload
[325.858879] Subtest reload: SUCCESS (4.806s)
[325.900240] [102/133] (696s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[327.906884] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[327.911206] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[327.978125] [103/133] (694s left) kms_draw_crc (draw-method-mmap-wc)
[328.078738] Starting subtest: draw-method-mmap-wc
[328.081019] Starting dynamic subtest: xrgb8888-untiled
[328.335658] Dynamic subtest xrgb8888-untiled: SUCCESS (0.257s)
[328.344744] Starting dynamic subtest: rgb565-untiled
[328.569258] Dynamic subtest rgb565-untiled: SUCCESS (0.232s)
[328.578476] Starting dynamic subtest: xrgb2101010-untiled
[328.791407] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.220s)
[328.801057] Starting dynamic subtest: xbgr16161616f-untiled
[329.024051] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.231s)
[329.032690] Starting dynamic subtest: xrgb8888-xtiled
[329.168861] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.144s)
[329.177238] Starting dynamic subtest: rgb565-xtiled
[329.301793] Dynamic subtest rgb565-xtiled: SUCCESS (0.131s)
[329.310484] Starting dynamic subtest: xrgb2101010-xtiled
[329.424089] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s)
[329.433198] Starting dynamic subtest: xbgr16161616f-xtiled
[329.557487] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s)
[329.568500] Starting dynamic subtest: xrgb8888-4tiled
[329.724066] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.166s)
[329.734429] Starting dynamic subtest: rgb565-4tiled
[329.879874] Dynamic subtest rgb565-4tiled: SUCCESS (0.154s)
[329.890994] Starting dynamic subtest: xrgb2101010-4tiled
[330.035435] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.153s)
[330.043760] Starting dynamic subtest: xbgr16161616f-4tiled
[330.213200] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.177s)
[330.215101] Subtest draw-method-mmap-wc: SUCCESS (2.136s)
[330.318112] [104/133] (692s left) kms_vrr (seamless-rr-switch-drrs)
[330.401422] Starting subtest: seamless-rr-switch-drrs
[330.406783] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[330.473059] [105/133] (692s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[330.859976] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[331.627573] [106/133] (690s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[331.737421] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[338.857409] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.124s)
[338.978981] [107/133] (683s left) kms_cursor_crc (cursor-onscreen-256x256)
[339.227531] Starting subtest: cursor-onscreen-256x256
[339.232588] Starting dynamic subtest: pipe-A-eDP-1
[341.359320] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.125s)
[341.394586] Starting dynamic subtest: pipe-D-eDP-1
[344.199522] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.813s)
[344.201796] Subtest cursor-onscreen-256x256: SUCCESS (4.971s)
[345.034214] [108/133] (677s left) sysfs_heartbeat_interval (nopreempt)
[345.110496] Starting subtest: nopreempt
[345.113049] Starting dynamic subtest: vecs0
[354.898993] Dynamic subtest vecs0: SUCCESS (9.785s)
[354.910925] Starting dynamic subtest: ccs0
[358.969932] Dynamic subtest ccs0: SUCCESS (4.071s)
[358.983655] Starting dynamic subtest: vcs0
[368.921142] Dynamic subtest vcs0: SUCCESS (9.947s)
[368.933346] Starting dynamic subtest: bcs0
[372.781319] Dynamic subtest bcs0: SUCCESS (3.859s)
[372.791457] Starting dynamic subtest: rcs0
[376.854260] Dynamic subtest rcs0: SUCCESS (4.071s)
[376.864468] Starting dynamic subtest: vcs1
[386.898953] Dynamic subtest vcs1: SUCCESS (10.041s)
[386.901489] Subtest nopreempt: SUCCESS (41.785s)
[386.974972] [109/133] (635s left) vgem_basic (second-client)
[387.026973] Starting subtest: second-client
[387.049015] Subtest second-client: SUCCESS (0.022s)
[387.107326] [110/133] (635s left) kms_big_fb (y-tiled-addfb)
[387.227577] Starting subtest: y-tiled-addfb
[387.232323] Subtest y-tiled-addfb: SKIP (0.000s)
[387.332323] [111/133] (635s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[387.384528] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[387.439329] [112/133] (635s left) gem_exec_reloc (basic-write-cpu-active)
[387.501545] Subtest basic-write-cpu-active: SKIP (0.000s)
[387.572530] [113/133] (635s left) gem_exec_suspend (basic-s3-devices)
[387.639476] Starting subtest: basic-S3-devices
[387.641360] Starting dynamic subtest: smem
[398.935048] Dynamic subtest smem: SUCCESS (11.296s)
[398.937949] Subtest basic-S3-devices: SUCCESS (11.298s)
[399.147382] [114/133] (623s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[399.257528] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[399.262068] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[399.371404] [115/133] (623s left) kms_addfb_basic (addfb25-bad-modifier)
[399.473137] Starting subtest: addfb25-bad-modifier
[399.475409] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[399.574168] [116/133] (623s left) gem_create (create-ext-cpu-access-big)
[399.742878] Starting subtest: create-ext-cpu-access-big
[399.747889] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[399.821083] [117/133] (623s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[399.919503] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[399.923786] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[400.033484] [118/133] (623s left) kms_flip (2x-busy-flip)
[400.126908] Starting subtest: 2x-busy-flip
[400.139141] Subtest 2x-busy-flip: SKIP (0.011s)
[400.220860] [119/133] (622s left) i915_query (engine-info)
[400.277277] Starting subtest: engine-info
[400.284312] Subtest engine-info: SUCCESS (0.009s)
[400.397178] [120/133] (622s left) gem_exec_fence (basic-busy-all)
[400.458494] Starting subtest: basic-busy-all
[400.537991] Subtest basic-busy-all: SUCCESS (0.080s)
[402.032909] [121/133] (621s left) api_intel_allocator (fork-simple-stress-signal)
[402.092367] Starting subtest: fork-simple-stress-signal
[407.493327] Subtest fork-simple-stress-signal: SUCCESS (5.402s)
[407.615140] [122/133] (615s left) gem_mmap_gtt (pf-nonblock)
[407.670295] Subtest pf-nonblock: SKIP (0.000s)
[407.730191] [123/133] (615s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[407.833035] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[407.835268] Starting dynamic subtest: pipe-A
[409.025921] Dynamic subtest pipe-A: SUCCESS (1.195s)
[409.035412] Starting dynamic subtest: pipe-B
[411.241930] Dynamic subtest pipe-B: SUCCESS (2.214s)
[411.251444] Starting dynamic subtest: pipe-C
[412.416429] Dynamic subtest pipe-C: SUCCESS (1.173s)
[412.426477] Starting dynamic subtest: pipe-D
[413.646621] Dynamic subtest pipe-D: SUCCESS (1.229s)
[413.648848] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.816s)
[414.845548] [124/133] (608s left) gem_exec_schedule (submit-golden-slice)
[414.917780] Starting subtest: submit-golden-slice
[414.919817] Starting dynamic subtest: rcs0
[414.944417] Dynamic subtest rcs0: SUCCESS (0.035s)
[414.956896] Starting dynamic subtest: bcs0
[414.976310] Dynamic subtest bcs0: SUCCESS (0.031s)
[414.986340] Starting dynamic subtest: vcs0
[415.018032] Dynamic subtest vcs0: SUCCESS (0.041s)
[415.027657] Starting dynamic subtest: vcs1
[415.049395] Dynamic subtest vcs1: SUCCESS (0.030s)
[415.058571] Starting dynamic subtest: vecs0
[415.081894] Dynamic subtest vecs0: SUCCESS (0.032s)
[415.091479] Starting dynamic subtest: ccs0
[415.113145] Dynamic subtest ccs0: SUCCESS (0.030s)
[415.115299] Subtest submit-golden-slice: SUCCESS (0.204s)
[417.008554] [125/133] (606s left) kms_atomic_transition (plane-all-transition)
[417.106096] Starting subtest: plane-all-transition
[417.108406] Starting dynamic subtest: pipe-A-eDP-1
[419.601537] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.497s)
[419.912885] Starting dynamic subtest: pipe-B-eDP-1
[423.184995] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.282s)
[423.505687] Subtest plane-all-transition: SUCCESS (6.398s)
[424.357424] [126/133] (599s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[424.472189] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[424.476206] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[424.587816] [127/133] (598s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[424.673925] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[424.693282] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.017s)
[424.770861] [128/133] (598s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[424.880244] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[424.884828] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[425.029457] [129/133] (598s left) gem_exec_whisper (basic-forked-all)
[425.091494] Starting subtest: basic-forked-all
[438.221655] Subtest basic-forked-all: SUCCESS (13.126s)
[438.406449] [130/133] (585s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[438.505989] Starting subtest: fbc-pr-cursor-mmap-cpu
[438.510493] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[438.576848] [131/133] (585s left) gem_exec_flush (basic-uc-set-default)
[438.635167] Starting subtest: basic-uc-set-default
[444.103591] Subtest basic-uc-set-default: SUCCESS (5.468s)
[444.294615] [132/133] (579s left) gem_mmap_gtt (medium-copy-odd)
[444.357760] Subtest medium-copy-odd: SKIP (0.000s)
[444.417428] [133/133] (579s left) gem_userptr_blits (dmabuf-unsync)
[444.489064] Subtest dmabuf-unsync: SKIP (0.000s)
[444.603601] Closing watchdogs
results: parsing output: 0/ for test: kms_pm_dc
results: parsing output: 1/ for test: kms_addfb_basic
results: parsing output: 2/ for test: dmabuf_sync_file
results: parsing output: 3/ for test: kms_flip
results: parsing output: 4/ for test: gem_render_copy
results: parsing output: 5/ for test: kms_cursor_legacy
results: parsing output: 6/ for test: gem_workarounds
results: parsing output: 7/ for test: gem_exec_big
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: perf_pmu
results: parsing output: 10/ for test: kms_addfb_basic
results: parsing output: 11/ for test: kms_ccs
results: parsing output: 12/ for test: prime_self_import
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_exec_balancer
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: kms_psr2_sf
results: parsing output: 17/ for test: gem_blits
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_shrink
results: parsing output: 20/ for test: syncobj_timeline
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: kms_ccs
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_rotation_crc
results: parsing output: 26/ for test: kms_chamelium_edid
results: parsing output: 27/ for test: gem_ctx_persistence
results: parsing output: 28/ for test: gem_ctx_param
results: parsing output: 29/ for test: kms_hdr
results: parsing output: 30/ for test: gem_exec_create
results: parsing output: 31/ for test: gem_ctx_shared
results: parsing output: 32/ for test: kms_cursor_legacy
results: parsing output: 33/ for test: api_intel_bb
results: parsing output: 34/ for test: kms_flip_scaled_crc
results: parsing output: 35/ for test: gem_exec_reloc
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: syncobj_timeline
results: parsing output: 39/ for test: kms_joiner
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gem_mmap_wc
results: parsing output: 42/ for test: gem_exec_flush
results: parsing output: 43/ for test: gem_pxp
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: gem_exec_fence
results: parsing output: 46/ for test: kms_prime
results: parsing output: 47/ for test: kms_debugfs
results: parsing output: 48/ for test: sw_sync
results: parsing output: 49/ for test: gem_userptr_blits
results: parsing output: 50/ for test: kms_plane_multiple
results: parsing output: 51/ for test: kms_sequence
results: parsing output: 52/ for test: kms_cursor_crc
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: kms_ccs
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_psr
results: parsing output: 57/ for test: kms_flip_scaled_crc
results: parsing output: 58/ for test: drm_read
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: perf
results: parsing output: 63/ for test: kms_cursor_legacy
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: kms_chamelium_color
results: parsing output: 66/ for test: kms_color_pipeline
results: parsing output: 67/ for test: kms_cursor_edge_walk
results: parsing output: 68/ for test: i915_drm_fdinfo
results: parsing output: 69/ for test: kms_getfb
results: parsing output: 70/ for test: kms_plane_scaling
results: parsing output: 71/ for test: gem_exec_params
results: parsing output: 72/ for test: gem_ctx_persistence
results: parsing output: 73/ for test: i915_pm_rpm
results: parsing output: 74/ for test: kms_vblank
results: parsing output: 75/ for test: kms_lease
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gen9_exec_parse
results: parsing output: 78/ for test: gem_wait
results: parsing output: 79/ for test: kms_content_protection
results: parsing output: 80/ for test: kms_atomic_transition
results: parsing output: 81/ for test: syncobj_eventfd
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_psr
results: parsing output: 84/ for test: gem_mmap_wc
results: parsing output: 85/ for test: gem_softpin
results: parsing output: 86/ for test: kms_pipe_crc_basic
results: parsing output: 87/ for test: kms_psr
results: parsing output: 88/ for test: syncobj_timeline
results: parsing output: 89/ for test: kms_psr2_sf
results: parsing output: 90/ for test: kms_ccs
results: parsing output: 91/ for test: gem_lmem_swapping
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: gem_render_copy
results: parsing output: 94/ for test: gem_partial_pwrite_pread
results: parsing output: 95/ for test: sriov_basic
results: parsing output: 96/ for test: gem_exec_fence
results: parsing output: 97/ for test: syncobj_wait
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: gem_exec_schedule
results: parsing output: 100/ for test: i915_module_load
results: parsing output: 101/ for test: kms_plane
results: parsing output: 102/ for test: kms_draw_crc
results: parsing output: 103/ for test: kms_vrr
results: parsing output: 104/ for test: kms_chamelium_hpd
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_cursor_crc
results: parsing output: 107/ for test: sysfs_heartbeat_interval
results: parsing output: 108/ for test: vgem_basic
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: gem_mmap_gtt
results: parsing output: 111/ for test: gem_exec_reloc
results: parsing output: 112/ for test: gem_exec_suspend
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_addfb_basic
results: parsing output: 115/ for test: gem_create
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_flip
results: parsing output: 118/ for test: i915_query
results: parsing output: 119/ for test: gem_exec_fence
results: parsing output: 120/ for test: api_intel_allocator
results: parsing output: 121/ for test: gem_mmap_gtt
results: parsing output: 122/ for test: kms_plane_scaling
results: parsing output: 123/ for test: gem_exec_schedule
results: parsing output: 124/ for test: kms_atomic_transition
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_flip
results: parsing output: 127/ for test: kms_cursor_legacy
results: parsing output: 128/ for test: gem_exec_whisper
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: gem_exec_flush
results: parsing output: 131/ for test: gem_mmap_gtt
results: parsing output: 132/ for test: gem_userptr_blits
Done.