[61.801619] Initializing watchdogs
[61.801667]   /dev/watchdog0
[61.816137] [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]
[61.820522] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.822724] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.826285] [001/130] (960s left) kms_content_protection (uevent)
[61.997720] Starting subtest: uevent
[62.002300] Subtest uevent: SKIP (0.000s)
[62.174959] [002/130] (960s left) gem_mmap_wc (pf-nonblock)
[62.244026] Subtest pf-nonblock: SKIP (0.000s)
[62.311920] [003/130] (960s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[62.430133] Starting subtest: basic-flip-before-cursor-varying-size
[63.406551] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.974s)
[64.269631] [004/130] (958s left) kms_psr (fbc-pr-primary-render)
[64.378200] Starting subtest: fbc-pr-primary-render
[64.382558] Subtest fbc-pr-primary-render: SKIP (0.000s)
[64.470750] [005/130] (958s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs)
[64.567191] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs
[64.569498] Starting dynamic subtest: pipe-A-eDP-1
[64.591649] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[64.599654] Starting dynamic subtest: pipe-B-eDP-1
[64.621078] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[64.627807] Starting dynamic subtest: pipe-C-eDP-1
[64.649075] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[64.655537] Starting dynamic subtest: pipe-D-eDP-1
[64.677148] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[64.681404] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[66.738088] [006/130] (955s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[66.853729] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[74.159941] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.309s)
[74.319226] [007/130] (948s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[74.425628] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[74.429859] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[74.546128] [008/130] (948s left) syncobj_timeline (multi-wait-signaled)
[74.605035] Starting subtest: multi-wait-signaled
[74.607450] Subtest multi-wait-signaled: SUCCESS (0.001s)
[74.731541] [009/130] (947s left) gem_ctx_shared (detached-shared-gtt)
[74.797316] Starting subtest: detached-shared-gtt
[76.950979] Subtest detached-shared-gtt: SUCCESS (2.153s)
[77.428965] [010/130] (945s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[77.544673] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[77.549262] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[77.691282] [011/130] (945s left) i915_hangman (engine-engine-error)
[77.768607] Starting subtest: engine-engine-error
[77.770628] Starting dynamic subtest: rcs0
[78.900075] Dynamic subtest rcs0: SUCCESS (1.131s)
[78.908554] Starting dynamic subtest: bcs0
[80.883674] Dynamic subtest bcs0: SUCCESS (1.983s)
[80.894279] Starting dynamic subtest: vcs0
[82.867634] Dynamic subtest vcs0: SUCCESS (1.982s)
[82.877564] Starting dynamic subtest: vcs1
[84.851334] Dynamic subtest vcs1: SUCCESS (1.982s)
[84.861224] Starting dynamic subtest: vecs0
[86.897353] Dynamic subtest vecs0: SUCCESS (2.045s)
[86.911398] Starting dynamic subtest: ccs0
[88.883989] Dynamic subtest ccs0: SUCCESS (1.985s)
[88.886598] Subtest engine-engine-error: SUCCESS (11.114s)
[88.983360] [012/130] (933s left) api_intel_bb (blit-noreloc-purge-cache)
[89.045856] Starting subtest: blit-noreloc-purge-cache
[89.060657] Subtest blit-noreloc-purge-cache: SUCCESS (0.016s)
[89.216707] [013/130] (933s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[89.281723] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[89.364370] [014/130] (933s left) kms_psr (pr-dpms)
[89.464802] Starting subtest: pr-dpms
[89.469233] Subtest pr-dpms: SKIP (0.000s)
[89.558095] [015/130] (933s left) syncobj_basic (bad-pad-fd-to-handle)
[89.624867] Starting subtest: bad-pad-fd-to-handle
[89.627176] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[89.767789] [016/130] (933s left) gem_exec_create (basic)
[89.835981] Starting subtest: basic
[89.838286] Starting dynamic subtest: smem
[92.884962] Dynamic subtest smem: SUCCESS (3.047s)
[92.887425] Subtest basic: SUCCESS (3.048s)
[93.092416] [017/130] (929s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[93.210637] Starting subtest: yf-tiled-addfb-size-offset-overflow
[93.214905] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[93.334045] [018/130] (929s left) prime_mmap (test_forked_cpu_write)
[93.396925] Starting subtest: test_forked_cpu_write
[93.398946] Starting dynamic subtest: test_forked_cpu_write-smem
[93.401211] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.006s)
[93.403601] Subtest test_forked_cpu_write: SUCCESS (0.007s)
[93.537504] [019/130] (929s left) gem_workarounds (reset)
[93.615864] Starting subtest: reset
[93.812127] Subtest reset: SUCCESS (0.199s)
[93.953899] [020/130] (929s left) perf (non-zero-reason)
[94.098449] Starting subtest: non-zero-reason
[94.100243] Starting dynamic subtest: 0-rcs0
[99.485861] Dynamic subtest 0-rcs0: SUCCESS (5.385s)
[99.497881] Starting dynamic subtest: 1-vecs0
[103.398087] Dynamic subtest 1-vecs0: SUCCESS (3.911s)
[103.400848] Subtest non-zero-reason: SUCCESS (9.297s)
[103.438841] [021/130] (919s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[103.558312] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[110.080112] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.524s)
[110.224837] [022/130] (912s left) perf (unprivileged-single-ctx-counters)
[110.326902] Starting subtest: unprivileged-single-ctx-counters
[110.331461] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[110.365311] [023/130] (912s left) gem_softpin (allocator-evict)
[110.429100] Starting subtest: allocator-evict
[110.430896] Starting dynamic subtest: rcs0
[133.695732] Dynamic subtest rcs0: SUCCESS (23.267s)
[133.704111] Starting dynamic subtest: bcs0
[157.363971] Dynamic subtest bcs0: SUCCESS (23.667s)
[157.374959] Starting dynamic subtest: vcs0
[181.223622] Dynamic subtest vcs0: SUCCESS (23.857s)
[181.233635] Starting dynamic subtest: vcs1
[205.268159] Dynamic subtest vcs1: SUCCESS (24.042s)
[205.278803] Starting dynamic subtest: vecs0
[229.109054] Dynamic subtest vecs0: SUCCESS (23.840s)
[229.117076] Starting dynamic subtest: ccs0
[253.206384] Dynamic subtest ccs0: SUCCESS (24.095s)
[253.209233] Subtest allocator-evict: SUCCESS (142.773s)
[253.309928] [024/130] (769s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[253.479827] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[253.482208] Starting dynamic subtest: pipe-A
[253.830492] Dynamic subtest pipe-A: SUCCESS (0.352s)
[253.839293] Starting dynamic subtest: pipe-B
[255.258587] Dynamic subtest pipe-B: SUCCESS (1.427s)
[255.266825] Starting dynamic subtest: pipe-C
[256.697477] Dynamic subtest pipe-C: SUCCESS (1.438s)
[256.706276] Starting dynamic subtest: pipe-D
[258.107470] Dynamic subtest pipe-D: SUCCESS (1.410s)
[258.109758] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.630s)
[259.298344] [025/130] (763s left) kms_flip (2x-flip-vs-expired-vblank)
[259.408944] Starting subtest: 2x-flip-vs-expired-vblank
[259.417790] Subtest 2x-flip-vs-expired-vblank: SKIP (0.011s)
[259.521118] [026/130] (763s left) kms_scaling_modes (scaling-mode-none)
[259.617452] Starting subtest: scaling-mode-none
[259.619347] Starting dynamic subtest: pipe-A-eDP-1
[259.719490] Dynamic subtest pipe-A-eDP-1: SKIP (0.101s)
[259.729936] Starting dynamic subtest: pipe-B-eDP-1
[259.754929] Dynamic subtest pipe-B-eDP-1: SKIP (0.033s)
[259.763382] Starting dynamic subtest: pipe-C-eDP-1
[259.788089] Dynamic subtest pipe-C-eDP-1: SKIP (0.032s)
[259.796151] Starting dynamic subtest: pipe-D-eDP-1
[259.823310] Dynamic subtest pipe-D-eDP-1: SKIP (0.034s)
[259.827798] Subtest scaling-mode-none: SKIP (0.205s)
[259.980240] [027/130] (763s left) kms_cursor_edge_walk (256x256-top-edge)
[260.078117] Starting subtest: 256x256-top-edge
[260.080345] Starting dynamic subtest: pipe-A-eDP-1
[263.543779] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.466s)
[263.552677] Starting dynamic subtest: pipe-D-eDP-1
[266.682891] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.139s)
[266.685158] Subtest 256x256-top-edge: SUCCESS (6.607s)
[267.511833] [028/130] (755s left) dumb_buffer (create-valid-dumb)
[267.577832] Starting subtest: create-valid-dumb
[267.579782] Subtest create-valid-dumb: SUCCESS (0.000s)
[267.715856] [029/130] (755s left) kms_invalid_mode (zero-vdisplay)
[267.817291] Starting subtest: zero-vdisplay
[267.819500] Starting dynamic subtest: pipe-A-eDP-1
[268.109566] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.292s)
[268.118854] Starting dynamic subtest: pipe-B-eDP-1
[268.121225] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[268.128659] Starting dynamic subtest: pipe-C-eDP-1
[268.130958] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[268.138381] Starting dynamic subtest: pipe-D-eDP-1
[268.140283] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[268.142136] Subtest zero-vdisplay: SUCCESS (0.297s)
[268.945712] [030/130] (754s left) gem_exec_fence (syncobj-timeline-repeat)
[269.588815] Starting subtest: syncobj-timeline-repeat
[269.821072] Subtest syncobj-timeline-repeat: SUCCESS (0.231s)
[271.033033] [FACT gem_exec_fence (syncobj-timeline-repeat)] new: kernel.kmod_is_loaded.vgem: true
[271.036196] [031/130] (752s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[271.144803] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[271.147486] Starting dynamic subtest: pipe-A-default-mode
[271.439929] Dynamic subtest pipe-A-default-mode: SKIP (0.292s)
[271.444585] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.294s)
[272.275068] [032/130] (751s left) gem_exec_whisper (basic-contexts-forked-all)
[272.350732] Starting subtest: basic-contexts-forked-all
[294.924344] Subtest basic-contexts-forked-all: SUCCESS (22.515s)
[295.075652] [033/130] (728s left) gem_exec_capture (capture)
[295.142731] Starting subtest: capture
[295.145046] Starting dynamic subtest: rcs0-smem
[295.979149] Dynamic subtest rcs0-smem: SUCCESS (0.835s)
[295.987900] Starting dynamic subtest: bcs0-smem
[296.805196] Dynamic subtest bcs0-smem: SUCCESS (0.825s)
[296.815834] Starting dynamic subtest: vcs0-smem
[297.634197] Dynamic subtest vcs0-smem: SUCCESS (0.826s)
[297.649265] Starting dynamic subtest: vcs1-smem
[298.957751] Dynamic subtest vcs1-smem: SUCCESS (1.323s)
[298.973162] Starting dynamic subtest: vecs0-smem
[299.853393] Dynamic subtest vecs0-smem: FAIL (0.835s)
[299.864659] Starting dynamic subtest: ccs0-smem
[301.112909] Dynamic subtest ccs0-smem: SUCCESS (1.320s)
[301.115301] Subtest capture: FAIL (5.967s)
[301.282115] [034/130] (722s left) gem_vm_create (create-ext)
[301.346633] Starting subtest: create-ext
[301.356390] Subtest create-ext: SUCCESS (0.010s)
[301.527419] [035/130] (722s left) gem_mmap_gtt (big-bo-tiledx)
[301.591609] Subtest big-bo-tiledX: SKIP (0.000s)
[301.652588] [036/130] (722s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[301.758784] Starting subtest: extended-pageflip-modeset-hang-oldfb
[301.760715] Starting dynamic subtest: pipe-A
[309.658200] Dynamic subtest pipe-A: SUCCESS (7.898s)
[309.667965] Starting dynamic subtest: pipe-D
[318.247066] Dynamic subtest pipe-D: SUCCESS (8.586s)
[318.249457] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.488s)
[319.128182] [037/130] (704s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[319.233513] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[319.237470] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[319.358398] [038/130] (704s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[319.482623] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[326.302523] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (6.820s)
[326.439422] [039/130] (697s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[326.541318] Starting subtest: fbc-psr2-sprite-mmap-gtt
[326.543427] Starting dynamic subtest: eDP-1
[326.547609] Dynamic subtest eDP-1: SKIP (0.000s)
[326.551701] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[326.633790] [040/130] (697s left) kms_getfb (getfb-handle-closed)
[326.718611] Starting subtest: getfb-handle-closed
[326.721112] Subtest getfb-handle-closed: SUCCESS (0.000s)
[326.862191] [041/130] (696s left) sw_sync (sync_merge_same)
[326.901946] Starting subtest: sync_merge_same
[326.904282] Subtest sync_merge_same: SUCCESS (0.000s)
[326.984929] [042/130] (696s left) gen9_exec_parse (bb-oversize)
[327.035047] Subtest bb-oversize: SKIP (0.000s)
[327.102729] [043/130] (696s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[327.191959] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[327.194289] Starting dynamic subtest: pipe-A-eDP-1
[327.225408] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[327.234572] Starting dynamic subtest: pipe-B-eDP-1
[327.250824] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[327.260749] Starting dynamic subtest: pipe-C-eDP-1
[327.276086] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[327.284271] Starting dynamic subtest: pipe-D-eDP-1
[327.299464] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[327.301037] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.007s)
[329.510940] [044/130] (694s left) prime_vgem (shrink)
[329.591664] Starting subtest: shrink
[329.628599] Subtest shrink: SUCCESS (0.034s)
[329.796958] [045/130] (694s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[329.864020] Subtest writes-after-reads-uncached: SKIP (0.000s)
[329.952717] [046/130] (694s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[330.059610] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[330.064093] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[330.189805] [047/130] (693s left) vgem_basic (sysfs)
[330.237127] Starting subtest: sysfs
[330.238983] Subtest sysfs: SUCCESS (0.000s)
[330.320418] [048/130] (693s left) perf_pmu (semaphore-busy)
[330.363344] Starting subtest: semaphore-busy
[330.365251] Starting dynamic subtest: rcs0
[332.023499] Dynamic subtest rcs0: SUCCESS (1.659s)
[332.035077] Starting dynamic subtest: bcs0
[333.656078] Dynamic subtest bcs0: SUCCESS (1.630s)
[333.667580] Starting dynamic subtest: vcs0
[337.478352] Dynamic subtest vcs0: SUCCESS (3.766s)
[337.489533] Starting dynamic subtest: vcs1
[343.490817] Dynamic subtest vcs1: SUCCESS (6.011s)
[343.502220] Starting dynamic subtest: vecs0
[349.390536] Dynamic subtest vecs0: SUCCESS (5.949s)
[349.399912] Starting dynamic subtest: ccs0
[352.529920] Dynamic subtest ccs0: SUCCESS (3.137s)
[352.532904] Subtest semaphore-busy: SUCCESS (22.165s)
[352.715471] [049/130] (671s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[357.744133] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf
[357.746546] Starting dynamic subtest: pipe-A-eDP-1
[369.183103] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.436s)
[369.191946] Starting dynamic subtest: pipe-B-eDP-1
[380.609644] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.425s)
[380.611966] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.865s)
[381.494278] [050/130] (642s left) kms_getfb (getfb2-handle-closed)
[381.601684] Starting subtest: getfb2-handle-closed
[381.604228] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[381.743680] [051/130] (642s left) api_intel_bb (reset-bb)
[381.801756] Starting subtest: reset-bb
[381.806425] Subtest reset-bb: SUCCESS (0.005s)
[381.974095] [052/130] (642s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[382.083334] Starting subtest: y-tiled-32bpp-rotate-270
[382.087663] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[382.228428] [053/130] (642s left) kms_psr (pr-basic)
[382.328969] Starting subtest: pr-basic
[382.333489] Subtest pr-basic: SKIP (0.000s)
[382.424432] [054/130] (641s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[382.479207] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[382.584679] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.103s)
[382.686459] [055/130] (641s left) kms_vblank (ts-continuation-modeset)
[382.779129] Starting subtest: ts-continuation-modeset
[382.781267] Starting dynamic subtest: pipe-A-eDP-1
[384.225680] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.448s)
[384.240501] Starting dynamic subtest: pipe-D-eDP-1
[386.409539] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.181s)
[386.412057] Subtest ts-continuation-modeset: SUCCESS (3.633s)
[387.250435] [056/130] (637s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[387.348636] Starting subtest: stress-xrgb8888-ytiled
[387.353279] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[387.439032] [057/130] (637s left) kms_prop_blob (invalid-get-prop-any)
[387.504693] Starting subtest: invalid-get-prop-any
[387.506997] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[387.649903] [058/130] (636s left) kms_plane_alpha_blend (constant-alpha-mid)
[387.748265] Starting subtest: constant-alpha-mid
[388.045692] Starting dynamic subtest: pipe-A-eDP-1
[388.973822] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.926s)
[388.983735] Starting dynamic subtest: pipe-D-eDP-1
[390.466792] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.492s)
[390.469669] Subtest constant-alpha-mid: SUCCESS (2.720s)
[391.306477] [059/130] (633s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[391.408837] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[398.251614] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.845s)
[398.440209] [060/130] (626s left) gem_partial_pwrite_pread (write-snoop)
[398.501633] Subtest write-snoop: SKIP (0.000s)
[398.599872] [061/130] (626s left) gem_mmap_gtt (hang-busy)
[398.653746] Subtest hang-busy: SKIP (0.000s)
[398.719679] [062/130] (626s left) gem_busy (extended)
[398.910256] Starting subtest: extended
[398.912797] Starting dynamic subtest: rcs0
[399.006276] Dynamic subtest rcs0: SUCCESS (0.097s)
[399.017345] Starting dynamic subtest: bcs0
[399.047159] Dynamic subtest bcs0: SUCCESS (0.039s)
[399.056872] Starting dynamic subtest: vcs0
[400.914455] Dynamic subtest vcs0: SUCCESS (1.865s)
[400.925734] Starting dynamic subtest: vcs1
[402.954510] Dynamic subtest vcs1: SUCCESS (1.982s)
[402.965720] Starting dynamic subtest: vecs0
[404.885022] Dynamic subtest vecs0: SUCCESS (1.982s)
[404.896587] Starting dynamic subtest: ccs0
[404.929847] Dynamic subtest ccs0: SUCCESS (0.044s)
[404.932209] Subtest extended: SUCCESS (6.022s)
[405.220636] [063/130] (619s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[405.292844] Starting subtest: yf-tiled-to-vebox-y-tiled
[405.297467] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[405.496632] [064/130] (619s left) prime_vgem (basic-fence-flip)
[405.582507] Starting subtest: basic-fence-flip
[405.905840] Subtest basic-fence-flip: SUCCESS (0.324s)
[406.059291] [065/130] (618s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[406.169570] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[406.173726] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[406.279955] [066/130] (618s left) kms_flip (modeset-vs-vblank-race)
[406.366327] Starting subtest: modeset-vs-vblank-race
[406.368532] Starting dynamic subtest: A-eDP1
[411.029113] Dynamic subtest A-eDP1: SUCCESS (4.664s)
[411.040697] Starting dynamic subtest: B-eDP1
[415.761461] Dynamic subtest B-eDP1: SUCCESS (4.730s)
[415.771765] Starting dynamic subtest: C-eDP1
[420.376989] Dynamic subtest C-eDP1: SUCCESS (4.613s)
[420.387735] Starting dynamic subtest: D-eDP1
[424.931355] Dynamic subtest D-eDP1: SUCCESS (4.553s)
[424.933805] Subtest modeset-vs-vblank-race: SUCCESS (18.570s)
[426.203422] [067/130] (598s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[426.304613] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[426.306962] Starting dynamic subtest: pipe-A-default-mode
[429.031118] Dynamic subtest pipe-A-default-mode: SUCCESS (2.727s)
[429.033518] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.729s)
[429.892621] [068/130] (595s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[430.006123] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[430.007994] Starting dynamic subtest: pipe-A-eDP-1
[431.287266] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.281s)
[431.296515] Starting dynamic subtest: pipe-B-eDP-1
[433.623774] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.335s)
[433.633134] Starting dynamic subtest: pipe-C-eDP-1
[435.959828] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.335s)
[435.969654] Starting dynamic subtest: pipe-D-eDP-1
[438.260475] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.299s)
[438.262802] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.257s)
[439.517115] [069/130] (585s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[439.625553] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[439.627785] Starting dynamic subtest: pipe-A-eDP-1
[455.859006] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.525s)
[455.869023] Starting dynamic subtest: pipe-B-eDP-1
[473.846349] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.854s)
[473.856094] Starting dynamic subtest: pipe-C-eDP-1
[491.824098] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.848s)
[491.835474] Starting dynamic subtest: pipe-D-eDP-1
[509.782516] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.696s)
[509.784621] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (13.927s)
[522.115159] [070/130] (514s left) gem_exec_balancer (invalid-balancer)
[522.203074] Starting subtest: invalid-balancer
[523.106004] Subtest invalid-balancer: SUCCESS (0.889s)
[523.461148] [071/130] (512s left) kms_atomic_interruptible (legacy-setmode)
[523.580543] Starting subtest: legacy-setmode
[523.582907] Starting dynamic subtest: pipe-A-eDP-1
[530.453303] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.819s)
[530.455823] Subtest legacy-setmode: SUCCESS (6.820s)
[531.277162] [072/130] (504s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[531.389866] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[531.405208] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.013s)
[531.509748] [073/130] (504s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[531.613292] Starting subtest: yf-tiled-32bpp-rotate-90
[531.617668] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[531.736006] [074/130] (504s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[531.826811] Starting subtest: random-ccs-data-yf-tiled-ccs
[531.829009] Starting dynamic subtest: pipe-A-eDP-1
[531.853624] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[531.869643] Starting dynamic subtest: pipe-B-eDP-1
[531.892677] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[531.901890] Starting dynamic subtest: pipe-C-eDP-1
[531.924715] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[531.933676] Starting dynamic subtest: pipe-D-eDP-1
[531.958253] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[531.962718] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.005s)
[534.073388] [075/130] (502s left) i915_drm_fdinfo (memory-info-purgeable)
[534.114532] Starting subtest: memory-info-purgeable
[534.116862] Starting dynamic subtest: smem0
[536.623866] Dynamic subtest smem0: SUCCESS (2.504s)
[536.625905] Subtest memory-info-purgeable: SUCCESS (2.505s)
[536.744605] [076/130] (499s left) kms_pm_lpsp (screens-disabled)
[537.858723] Starting subtest: screens-disabled
[537.863048] Subtest screens-disabled: SKIP (0.000s)
[537.954949] [077/130] (498s left) syncobj_timeline (single-wait-all-signaled)
[538.016167] Starting subtest: single-wait-all-signaled
[538.018194] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[538.142793] [078/130] (498s left) gem_exec_fence (syncobj-signal)
[538.572278] Starting subtest: syncobj-signal
[538.574809] Subtest syncobj-signal: SUCCESS (0.004s)
[540.288265] [079/130] (496s left) kms_display_modes (extended-mode-basic)
[540.390750] Starting subtest: extended-mode-basic
[540.395141] Subtest extended-mode-basic: SKIP (0.000s)
[540.445686] [080/130] (496s left) i915_pm_rpm (gem-pread)
[542.282636] Starting subtest: gem-pread
[544.367909] Subtest gem-pread: SUCCESS (2.085s)
[544.481828] [081/130] (492s left) kms_big_fb (linear-64bpp-rotate-270)
[544.579951] Starting subtest: linear-64bpp-rotate-270
[544.598758] Subtest linear-64bpp-rotate-270: SKIP (0.018s)
[544.728242] [082/130] (491s left) gem_tiled_fence_blits (normal)
[544.793289] Subtest normal: SKIP (0.000s)
[544.861826] [083/130] (491s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[544.953629] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[544.955868] Starting dynamic subtest: pipe-A-default-mode
[545.245963] Dynamic subtest pipe-A-default-mode: SKIP (0.287s)
[545.250325] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.289s)
[546.074776] [084/130] (490s left) kms_draw_crc (draw-method-pwrite)
[546.175646] Starting subtest: draw-method-pwrite
[546.177793] Starting dynamic subtest: xrgb8888-untiled
[546.753412] Dynamic subtest xrgb8888-untiled: SUCCESS (0.578s)
[546.763952] Starting dynamic subtest: rgb565-untiled
[547.222287] Dynamic subtest rgb565-untiled: SUCCESS (0.466s)
[547.232198] Starting dynamic subtest: xrgb2101010-untiled
[547.778023] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.555s)
[547.788347] Starting dynamic subtest: xbgr16161616f-untiled
[548.533203] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.755s)
[548.543906] Starting dynamic subtest: xrgb8888-xtiled
[550.323600] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.788s)
[550.333751] Starting dynamic subtest: rgb565-xtiled
[551.424144] Dynamic subtest rgb565-xtiled: SUCCESS (1.099s)
[551.436493] Starting dynamic subtest: xrgb2101010-xtiled
[553.214730] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.787s)
[553.227989] Starting dynamic subtest: xbgr16161616f-xtiled
[556.506008] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.288s)
[556.515958] Starting dynamic subtest: xrgb8888-4tiled
[557.595526] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.087s)
[557.617651] Starting dynamic subtest: rgb565-4tiled
[558.151301] Dynamic subtest rgb565-4tiled: SUCCESS (0.555s)
[558.161393] Starting dynamic subtest: xrgb2101010-4tiled
[559.251916] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.099s)
[559.262240] Starting dynamic subtest: xbgr16161616f-4tiled
[562.309227] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (3.055s)
[562.311479] Subtest draw-method-pwrite: SUCCESS (16.123s)
[562.451989] [085/130] (474s left) gem_mmap (bad-offset)
[562.526029] Subtest bad-offset: SKIP (0.000s)
[562.595449] [086/130] (474s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[562.691665] Starting subtest: primary-yf-tiled-reflect-x-0
[562.751442] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.059s)
[562.877525] [087/130] (474s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[563.263052] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[564.080149] [088/130] (472s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[564.192943] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[564.197095] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[564.332429] [089/130] (472s left) kms_pipe_crc_basic (bad-source)
[564.429626] Starting subtest: bad-source
[564.431479] Subtest bad-source: SUCCESS (0.000s)
[564.525523] [090/130] (472s left) gem_basic (create-close)
[564.592004] Starting subtest: create-close
[564.596513] Subtest create-close: SUCCESS (0.000s)
[564.724557] [091/130] (472s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[564.790035] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[564.893696] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.102s)
[564.993980] [092/130] (472s left) kms_sequence (get-busy)
[565.080691] Starting subtest: get-busy
[565.082630] Starting dynamic subtest: pipe-A-eDP-1
[567.012985] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.933s)
[567.023736] Starting dynamic subtest: pipe-B-eDP-1
[569.609730] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.591s)
[569.620055] Starting dynamic subtest: pipe-C-eDP-1
[572.197123] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.586s)
[572.207857] Starting dynamic subtest: pipe-D-eDP-1
[574.744588] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.543s)
[574.746727] Subtest get-busy: SUCCESS (9.658s)
[575.563716] [093/130] (461s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[575.656512] Starting subtest: addfb25-y-tiled-legacy
[575.658669] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[575.769617] [094/130] (461s left) i915_query (test-query-geometry-subslices)
[575.836130] Starting subtest: test-query-geometry-subslices
[575.838340] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[575.946835] [095/130] (461s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[576.050798] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[576.788920] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.739s)
[576.986021] [096/130] (460s left) gem_exec_whisper (basic-queues-priority-all)
[577.043346] Starting subtest: basic-queues-priority-all
[595.490984] Subtest basic-queues-priority-all: SUCCESS (18.434s)
[595.695949] [097/130] (441s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[595.816258] Starting subtest: cursorB-vs-flipA-atomic
[595.820881] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s)
[595.986039] [098/130] (441s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[596.195454] Starting subtest: cursor-rapid-movement-64x21
[596.243330] Subtest cursor-rapid-movement-64x21: SKIP (0.044s)
[596.497677] [099/130] (440s left) gem_mmap_wc (write-cpu-read-wc)
[596.551285] Subtest write-cpu-read-wc: SKIP (0.000s)
[596.615281] [100/130] (440s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[596.720933] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[605.383137] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.660s)
[605.523087] [101/130] (432s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[605.622921] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[605.626888] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[605.771001] [102/130] (431s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[605.891998] Starting subtest: 4-tiled-8bpp-rotate-90
[605.913618] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.020s)
[606.075069] [103/130] (431s left) kms_pm_rpm (system-suspend-modeset)
[608.304052] Starting subtest: system-suspend-modeset
[628.170931] Subtest system-suspend-modeset: SUCCESS (5.019s)
[633.624810] [104/130] (409s left) prime_self_import (basic-with_fd_dup)
[633.671848] Starting subtest: basic-with_fd_dup
[633.698268] Subtest basic-with_fd_dup: SUCCESS (0.024s)
[633.839781] [105/130] (408s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[634.243143] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[635.060155] [106/130] (407s left) gem_create (create-clear)
[635.133063] Starting subtest: create-clear
[635.135636] Starting dynamic subtest: smem0
[667.919156] Dynamic subtest smem0: SUCCESS (32.685s)
[667.921217] Subtest create-clear: SUCCESS (32.687s)
[668.136529] [107/130] (374s left) syncobj_wait (invalid-signal-illegal-handle)
[668.199575] Starting subtest: invalid-signal-illegal-handle
[668.201922] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[668.353151] [108/130] (374s left) gem_userptr_blits (create-destroy-sync)
[668.420728] Starting subtest: create-destroy-sync
[673.486455] Subtest create-destroy-sync: SUCCESS (5.014s)
[673.604283] [109/130] (369s left) gem_linear_blits (interruptible)
[673.862563] Starting subtest: interruptible
[678.843171] Subtest interruptible: SUCCESS (4.983s)
[679.049645] [110/130] (363s left) vgem_basic (setversion)
[679.149490] Starting subtest: setversion
[679.153630] Subtest setversion: SUCCESS (0.000s)
[679.233358] [111/130] (363s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[679.352112] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[679.356077] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[679.474483] [112/130] (363s left) gem_exec_parallel (contexts)
[679.549096] Starting subtest: contexts
[679.551456] Starting dynamic subtest: rcs0
[682.782486] Dynamic subtest rcs0: SUCCESS (3.231s)
[682.795296] Starting dynamic subtest: bcs0
[686.313492] Dynamic subtest bcs0: SUCCESS (3.528s)
[686.326497] Starting dynamic subtest: vcs0
[690.472604] Dynamic subtest vcs0: SUCCESS (4.157s)
[690.485010] Starting dynamic subtest: vcs1
[694.500138] Dynamic subtest vcs1: SUCCESS (4.023s)
[694.513086] Starting dynamic subtest: vecs0
[698.622719] Dynamic subtest vecs0: SUCCESS (4.120s)
[698.639174] Starting dynamic subtest: ccs0
[702.222202] Dynamic subtest ccs0: SUCCESS (3.595s)
[702.224814] Subtest contexts: SUCCESS (22.668s)
[702.437131] [113/130] (340s left) gem_flink_basic (basic)
[702.491959] Starting subtest: basic
[702.494239] Subtest basic: SUCCESS (0.000s)
[702.640245] [114/130] (340s left) gem_exec_schedule (preemptive-hang)
[702.826474] Starting subtest: preemptive-hang
[702.828874] Starting dynamic subtest: rcs0
[712.099853] Dynamic subtest rcs0: SUCCESS (9.270s)
[712.109700] Starting dynamic subtest: bcs0
[721.126656] Dynamic subtest bcs0: SUCCESS (9.016s)
[721.139538] Starting dynamic subtest: vcs0
[730.081939] Dynamic subtest vcs0: SUCCESS (8.954s)
[730.093623] Starting dynamic subtest: vcs1
[739.110303] Dynamic subtest vcs1: SUCCESS (9.031s)
[739.119855] Starting dynamic subtest: vecs0
[748.135514] Dynamic subtest vecs0: SUCCESS (9.021s)
[748.146500] Starting dynamic subtest: ccs0
[757.156721] Dynamic subtest ccs0: SUCCESS (9.027s)
[757.159533] Subtest preemptive-hang: SUCCESS (54.327s)
[757.441035] [115/130] (285s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[757.549148] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[757.553007] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[757.689161] [116/130] (285s left) kms_lease (lease-invalid-crtc)
[757.796681] Starting subtest: lease-invalid-crtc
[757.798873] Starting dynamic subtest: pipe-A-eDP-1
[757.801222] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[757.811138] Starting dynamic subtest: pipe-B-eDP-1
[757.812953] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[757.822880] Starting dynamic subtest: pipe-C-eDP-1
[757.825034] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[757.833842] Starting dynamic subtest: pipe-D-eDP-1
[757.835727] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[757.837524] Subtest lease-invalid-crtc: SUCCESS (0.005s)
[757.898267] [117/130] (285s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[757.963468] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[757.965860] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[758.099017] [118/130] (285s left) gem_ctx_persistence (engines-queued)
[758.155231] Starting subtest: engines-queued
[758.157537] Starting dynamic subtest: rcs0
[758.254319] Dynamic subtest rcs0: SUCCESS (0.099s)
[758.267344] Starting dynamic subtest: bcs0
[758.285969] Dynamic subtest bcs0: SUCCESS (0.030s)
[758.295173] Starting dynamic subtest: vcs0
[759.962372] Dynamic subtest vcs0: SUCCESS (1.673s)
[759.974915] Starting dynamic subtest: vcs1
[761.945552] Dynamic subtest vcs1: SUCCESS (1.981s)
[761.958411] Starting dynamic subtest: vecs0
[763.983748] Dynamic subtest vecs0: SUCCESS (1.981s)
[763.995758] Starting dynamic subtest: ccs0
[764.117856] Dynamic subtest ccs0: SUCCESS (0.186s)
[764.120489] Subtest engines-queued: SUCCESS (5.963s)
[764.271275] [119/130] (279s left) gem_ctx_exec (basic-nohangcheck)
[764.333324] Starting subtest: basic-nohangcheck
[764.889218] Subtest basic-nohangcheck: SUCCESS (0.556s)
[765.279747] [120/130] (278s left) kms_psr (psr-cursor-mmap-cpu)
[765.450906] Starting subtest: psr-cursor-mmap-cpu
[765.453231] Starting dynamic subtest: eDP-1
[767.165386] Dynamic subtest eDP-1: SUCCESS (1.712s)
[767.167370] Subtest psr-cursor-mmap-cpu: SUCCESS (1.713s)
[768.079288] [121/130] (275s left) gem_exec_schedule (u-fairslice)
[768.152484] Starting subtest: u-fairslice
[768.154571] Starting dynamic subtest: rcs0
[770.214571] Dynamic subtest rcs0: SUCCESS (2.017s)
[770.231437] Starting dynamic subtest: bcs0
[772.179723] Dynamic subtest bcs0: SUCCESS (2.015s)
[772.189626] Starting dynamic subtest: vcs0
[774.246957] Dynamic subtest vcs0: SUCCESS (2.017s)
[774.258487] Starting dynamic subtest: vcs1
[776.212481] Dynamic subtest vcs1: SUCCESS (2.015s)
[776.224949] Starting dynamic subtest: vecs0
[778.281453] Dynamic subtest vecs0: SUCCESS (2.016s)
[778.293037] Starting dynamic subtest: ccs0
[780.252371] Dynamic subtest ccs0: SUCCESS (2.020s)
[780.254383] Subtest u-fairslice: SUCCESS (12.106s)
[780.576785] [122/130] (263s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[780.681564] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[780.683916] Starting dynamic subtest: pipe-A
[780.750617] Dynamic subtest pipe-A: SUCCESS (0.071s)
[780.767740] Starting dynamic subtest: pipe-B
[781.862495] Dynamic subtest pipe-B: SUCCESS (1.111s)
[781.875374] Starting dynamic subtest: pipe-C
[782.973082] Dynamic subtest pipe-C: SUCCESS (1.108s)
[782.990354] Starting dynamic subtest: pipe-D
[784.120104] Dynamic subtest pipe-D: SUCCESS (1.144s)
[784.122676] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.442s)
[785.289395] [123/130] (258s left) gem_exec_params (invalid-fence-in)
[785.363978] Starting subtest: invalid-fence-in
[785.366377] Subtest invalid-fence-in: SUCCESS (0.000s)
[785.491796] [124/130] (258s left) kms_color (ctm-max)
[785.595461] Starting subtest: ctm-max
[785.597681] Starting dynamic subtest: pipe-A-eDP-1
[786.314053] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.720s)
[786.324699] Starting dynamic subtest: pipe-B-eDP-1
[787.772701] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.457s)
[787.783758] Starting dynamic subtest: pipe-C-eDP-1
[789.149523] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.377s)
[789.159859] Starting dynamic subtest: pipe-D-eDP-1
[790.484707] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.332s)
[790.486722] Subtest ctm-max: SUCCESS (4.889s)
[791.323012] [125/130] (252s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[791.433507] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[791.437614] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[791.572291] [126/130] (252s left) kms_atomic_transition (modeset-transition-nonblocking)
[791.672192] Starting subtest: modeset-transition-nonblocking
[791.674353] Starting dynamic subtest: 1x-outputs
[802.795925] Dynamic subtest 1x-outputs: SUCCESS (11.122s)
[802.798784] Subtest modeset-transition-nonblocking: SUCCESS (11.123s)
[803.673067] [127/130] (240s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[803.769097] Starting subtest: fbc-rgb565-draw-mmap-wc
[807.753860] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (3.986s)
[808.970397] [128/130] (234s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[809.101379] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[809.105754] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[809.271680] [129/130] (234s left) gem_pxp (verify-pxp-stale-buf-execution)
[809.397866] Starting subtest: verify-pxp-stale-buf-execution
[810.455899] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.060s)
[810.626938] [130/130] (233s left) perf (non-sampling-read-error)
[810.751628] Starting subtest: non-sampling-read-error
[810.760301] Subtest non-sampling-read-error: SUCCESS (0.006s)
[810.812943] Closing watchdogs
results: parsing output: 0/ for test: kms_content_protection
results: parsing output: 1/ for test: gem_mmap_wc
results: parsing output: 2/ for test: kms_cursor_legacy
results: parsing output: 3/ for test: kms_psr
results: parsing output: 4/ for test: kms_ccs
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: gem_ctx_shared
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: i915_hangman
results: parsing output: 11/ for test: api_intel_bb
results: parsing output: 12/ for test: gem_exec_reloc
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: syncobj_basic
results: parsing output: 15/ for test: gem_exec_create
results: parsing output: 16/ for test: kms_big_fb
results: parsing output: 17/ for test: prime_mmap
results: parsing output: 18/ for test: gem_workarounds
results: parsing output: 19/ for test: perf
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: perf
results: parsing output: 22/ for test: gem_softpin
results: parsing output: 23/ for test: kms_plane_scaling
results: parsing output: 24/ for test: kms_flip
results: parsing output: 25/ for test: kms_scaling_modes
results: parsing output: 26/ for test: kms_cursor_edge_walk
results: parsing output: 27/ for test: dumb_buffer
results: parsing output: 28/ for test: kms_invalid_mode
results: parsing output: 29/ for test: gem_exec_fence
results: parsing output: 30/ for test: kms_flip_scaled_crc
results: parsing output: 31/ for test: gem_exec_whisper
results: parsing output: 32/ for test: gem_exec_capture
results: parsing output: 33/ for test: gem_vm_create
results: parsing output: 34/ for test: gem_mmap_gtt
results: parsing output: 35/ for test: kms_busy
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: kms_getfb
results: parsing output: 40/ for test: sw_sync
results: parsing output: 41/ for test: gen9_exec_parse
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: prime_vgem
results: parsing output: 44/ for test: gem_partial_pwrite_pread
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: vgem_basic
results: parsing output: 47/ for test: perf_pmu
results: parsing output: 48/ for test: kms_psr2_sf
results: parsing output: 49/ for test: kms_getfb
results: parsing output: 50/ for test: api_intel_bb
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: syncobj_timeline
results: parsing output: 54/ for test: kms_vblank
results: parsing output: 55/ for test: kms_pipe_stress
results: parsing output: 56/ for test: kms_prop_blob
results: parsing output: 57/ for test: kms_plane_alpha_blend
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_partial_pwrite_pread
results: parsing output: 60/ for test: gem_mmap_gtt
results: parsing output: 61/ for test: gem_busy
results: parsing output: 62/ for test: gem_render_copy
results: parsing output: 63/ for test: prime_vgem
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_flip
results: parsing output: 66/ for test: kms_flip_scaled_crc
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: kms_ccs
results: parsing output: 69/ for test: gem_exec_balancer
results: parsing output: 70/ for test: kms_atomic_interruptible
results: parsing output: 71/ for test: kms_flip
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: i915_drm_fdinfo
results: parsing output: 75/ for test: kms_pm_lpsp
results: parsing output: 76/ for test: syncobj_timeline
results: parsing output: 77/ for test: gem_exec_fence
results: parsing output: 78/ for test: kms_display_modes
results: parsing output: 79/ for test: i915_pm_rpm
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: gem_tiled_fence_blits
results: parsing output: 82/ for test: kms_flip_scaled_crc
results: parsing output: 83/ for test: kms_draw_crc
results: parsing output: 84/ for test: gem_mmap
results: parsing output: 85/ for test: kms_rotation_crc
results: parsing output: 86/ for test: kms_chamelium_hpd
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_pipe_crc_basic
results: parsing output: 89/ for test: gem_basic
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: kms_sequence
results: parsing output: 92/ for test: kms_addfb_basic
results: parsing output: 93/ for test: i915_query
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: gem_exec_whisper
results: parsing output: 96/ for test: kms_cursor_legacy
results: parsing output: 97/ for test: kms_cursor_crc
results: parsing output: 98/ for test: gem_mmap_wc
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: kms_pm_rpm
results: parsing output: 103/ for test: prime_self_import
results: parsing output: 104/ for test: kms_chamelium_hpd
results: parsing output: 105/ for test: gem_create
results: parsing output: 106/ for test: syncobj_wait
results: parsing output: 107/ for test: gem_userptr_blits
results: parsing output: 108/ for test: gem_linear_blits
results: parsing output: 109/ for test: vgem_basic
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: gem_exec_parallel
results: parsing output: 112/ for test: gem_flink_basic
results: parsing output: 113/ for test: gem_exec_schedule
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_lease
results: parsing output: 116/ for test: syncobj_timeline
results: parsing output: 117/ for test: gem_ctx_persistence
results: parsing output: 118/ for test: gem_ctx_exec
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: gem_exec_schedule
results: parsing output: 121/ for test: kms_plane_scaling
results: parsing output: 122/ for test: gem_exec_params
results: parsing output: 123/ for test: kms_color
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_atomic_transition
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_cursor_legacy
results: parsing output: 128/ for test: gem_pxp
results: parsing output: 129/ for test: perf
Done.