[57.396849] Initializing watchdogs
[57.396895]   /dev/watchdog0
[57.410872] [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.415393] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.417547] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.421011] [001/133] (960s left) gem_ctx_param (invalid-size-get)
[57.522765] Starting subtest: invalid-size-get
[57.525286] Subtest invalid-size-get: SUCCESS (0.003s)
[57.634885] [002/133] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[57.731611] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[57.736222] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[57.827490] [003/133] (960s left) template (a)
[57.878562] Starting subtest: A
[57.880670] Subtest A: SUCCESS (0.000s)
[57.969409] [004/133] (960s left) kms_plane_alpha_blend (constant-alpha-mid)
[58.057802] Starting subtest: constant-alpha-mid
[58.335557] Starting dynamic subtest: pipe-A-eDP-1
[59.206171] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.875s)
[59.214102] Starting dynamic subtest: pipe-D-eDP-1
[60.689535] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.495s)
[60.691854] Subtest constant-alpha-mid: SUCCESS (2.654s)
[61.489427] [005/133] (956s left) gem_exec_fence (syncobj-timeline-signal)
[62.041079] Starting subtest: syncobj-timeline-signal
[62.045990] Subtest syncobj-timeline-signal: SUCCESS (0.008s)
[62.983363] [FACT gem_exec_fence (syncobj-timeline-signal)] new: kernel.kmod_is_loaded.vgem: true
[62.986374] [006/133] (955s left) kms_invalid_mode (zero-hdisplay)
[63.077637] Starting subtest: zero-hdisplay
[63.079816] Starting dynamic subtest: pipe-A-eDP-1
[63.359480] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[63.368317] Starting dynamic subtest: pipe-B-eDP-1
[63.370191] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[63.376797] Starting dynamic subtest: pipe-C-eDP-1
[63.378782] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[63.385807] Starting dynamic subtest: pipe-D-eDP-1
[63.387992] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[63.390159] Subtest zero-hdisplay: SUCCESS (0.290s)
[64.223987] [007/133] (953s left) kms_psr (fbc-pr-primary-mmap-gtt)
[64.309774] Starting subtest: fbc-pr-primary-mmap-gtt
[64.314368] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[64.385179] [008/133] (953s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[64.506648] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[64.511346] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[64.648007] [009/133] (953s left) gem_exec_schedule (preempt)
[64.728563] Starting subtest: preempt
[64.730820] Starting dynamic subtest: rcs0
[64.747886] Dynamic subtest rcs0: SUCCESS (0.029s)
[64.758300] Starting dynamic subtest: bcs0
[64.766898] Dynamic subtest bcs0: SUCCESS (0.019s)
[64.781049] Starting dynamic subtest: vcs0
[64.787350] Dynamic subtest vcs0: SUCCESS (0.020s)
[64.797964] Starting dynamic subtest: vcs1
[64.807026] Dynamic subtest vcs1: SUCCESS (0.019s)
[64.814089] Starting dynamic subtest: vecs0
[64.829839] Dynamic subtest vecs0: SUCCESS (0.023s)
[64.836694] Starting dynamic subtest: ccs0
[64.850318] Dynamic subtest ccs0: SUCCESS (0.020s)
[64.852543] Subtest preempt: SUCCESS (0.132s)
[65.981697] [010/133] (952s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[66.067601] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[66.070211] Starting dynamic subtest: pipe-A-default-mode
[68.853214] Dynamic subtest pipe-A-default-mode: SUCCESS (2.793s)
[68.855481] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.794s)
[69.674270] [011/133] (948s left) kms_psr2_su (page_flip-nv12)
[69.726460] Subtest page_flip-NV12: SKIP (0.000s)
[69.781359] [012/133] (948s left) kms_rotation_crc (primary-rotation-270)
[69.884361] Starting subtest: primary-rotation-270
[69.888928] Subtest primary-rotation-270: SKIP (0.001s)
[69.956353] [013/133] (948s left) kms_cursor_edge_walk (256x256-left-edge)
[70.044724] Starting subtest: 256x256-left-edge
[70.047031] Starting dynamic subtest: pipe-A-eDP-1
[73.545116] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.506s)
[73.552977] Starting dynamic subtest: pipe-D-eDP-1
[76.669538] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.125s)
[76.671758] Subtest 256x256-left-edge: SUCCESS (6.633s)
[77.476152] [014/133] (940s left) gem_mmap_gtt (cpuset-big-copy-xy)
[77.542858] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[77.601758] [015/133] (940s left) gem_exec_reloc (basic-gtt)
[77.659200] Subtest basic-gtt: SKIP (0.000s)
[77.719756] [016/133] (940s left) kms_feature_discovery (psr2)
[77.812498] Starting subtest: psr2
[77.814675] Subtest psr2: SUCCESS (0.000s)
[77.883012] [017/133] (940s left) kms_feature_discovery (chamelium)
[77.979779] Starting subtest: chamelium
[77.984367] Subtest chamelium: SKIP (0.000s)
[78.047898] [018/133] (940s left) gem_exec_params (sol-reset-not-gen7)
[78.121314] Starting subtest: sol-reset-not-gen7
[78.123614] Subtest sol-reset-not-gen7: SUCCESS (0.003s)
[78.242892] [019/133] (940s left) kms_content_protection (suspend-resume)
[78.388808] Starting subtest: suspend-resume
[78.393444] Subtest suspend-resume: SKIP (0.000s)
[78.512035] [020/133] (940s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[78.603875] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[78.607395] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[78.707463] [021/133] (939s left) kms_flip (2x-blocking-wf_vblank)
[78.805493] Starting subtest: 2x-blocking-wf_vblank
[78.817275] Subtest 2x-blocking-wf_vblank: SKIP (0.011s)
[78.914974] [022/133] (939s left) gem_pread (display)
[78.979844] Subtest display: SKIP (0.000s)
[79.038453] [023/133] (939s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[79.129659] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[79.131674] Starting dynamic subtest: pipe-A
[79.367567] Dynamic subtest pipe-A: SUCCESS (0.240s)
[79.375410] Starting dynamic subtest: pipe-B
[80.655063] Dynamic subtest pipe-B: SUCCESS (1.286s)
[80.663389] Starting dynamic subtest: pipe-C
[81.999368] Dynamic subtest pipe-C: SUCCESS (1.343s)
[82.008550] Starting dynamic subtest: pipe-D
[83.325133] Dynamic subtest pipe-D: SUCCESS (1.325s)
[83.327462] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.197s)
[84.522341] [024/133] (934s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[84.574932] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[84.579412] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[84.758093] [025/133] (934s left) prime_vgem (fence-wait)
[84.827561] Starting subtest: fence-wait
[84.829877] Starting dynamic subtest: rcs0
[85.859520] Dynamic subtest rcs0: SUCCESS (1.030s)
[85.869123] Starting dynamic subtest: bcs0
[86.908219] Dynamic subtest bcs0: SUCCESS (1.048s)
[86.917875] Starting dynamic subtest: vcs0
[87.952877] Dynamic subtest vcs0: SUCCESS (1.042s)
[87.962253] Starting dynamic subtest: vcs1
[88.997840] Dynamic subtest vcs1: SUCCESS (1.044s)
[89.007197] Starting dynamic subtest: vecs0
[90.044422] Dynamic subtest vecs0: SUCCESS (1.045s)
[90.053048] Starting dynamic subtest: ccs0
[91.086581] Dynamic subtest ccs0: SUCCESS (1.040s)
[91.089561] Subtest fence-wait: SUCCESS (6.257s)
[91.225827] [026/133] (927s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[91.333153] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[97.936993] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.604s)
[98.059988] [027/133] (920s left) api_intel_allocator (gem-pool)
[98.116095] Starting subtest: gem-pool
[98.120537] Subtest gem-pool: SUCCESS (0.007s)
[98.221503] [028/133] (920s left) i915_pm_rps (reset)
[98.277668] Starting subtest: reset
[106.712287] Subtest reset: SUCCESS (8.431s)
[106.823631] [029/133] (912s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[106.919186] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[106.923572] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[107.002968] [030/133] (912s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[107.053049] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[107.055416] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[107.153368] [031/133] (911s left) vgem_basic (dmabuf-mmap)
[107.203102] Starting subtest: dmabuf-mmap
[107.228277] Subtest dmabuf-mmap: SUCCESS (0.027s)
[107.283422] [032/133] (911s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[107.373347] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[107.377430] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[107.463406] [033/133] (911s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[107.562777] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[107.567306] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[107.652264] [034/133] (911s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[107.739872] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[107.743490] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[108.884473] [035/133] (910s left) kms_flip (2x-dpms-vs-vblank-race)
[108.992735] Starting subtest: 2x-dpms-vs-vblank-race
[109.001550] Subtest 2x-dpms-vs-vblank-race: SKIP (0.010s)
[109.084044] [036/133] (910s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[109.183062] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[109.185360] Starting dynamic subtest: pipe-A-eDP-1
[109.205819] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[109.215805] Starting dynamic subtest: pipe-B-eDP-1
[109.235336] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[109.242681] Starting dynamic subtest: pipe-C-eDP-1
[109.261714] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[109.269057] Starting dynamic subtest: pipe-D-eDP-1
[109.287676] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[109.289734] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.004s)
[111.444984] [037/133] (907s left) perf_pmu (invalid-open)
[111.486987] Starting subtest: invalid-open
[111.489437] Subtest invalid-open: SUCCESS (0.000s)
[111.576508] [038/133] (907s left) gem_spin_batch (engines)
[111.635041] Starting subtest: engines
[111.637292] Starting dynamic subtest: rcs0
[114.878776] Dynamic subtest rcs0: SUCCESS (3.237s)
[114.888284] Starting dynamic subtest: bcs0
[118.167925] Dynamic subtest bcs0: SUCCESS (3.237s)
[118.178395] Starting dynamic subtest: vcs0
[121.405302] Dynamic subtest vcs0: SUCCESS (3.236s)
[121.416429] Starting dynamic subtest: vcs1
[124.644366] Dynamic subtest vcs1: SUCCESS (3.237s)
[124.655486] Starting dynamic subtest: vecs0
[127.882031] Dynamic subtest vecs0: SUCCESS (3.235s)
[127.892736] Starting dynamic subtest: ccs0
[131.119740] Dynamic subtest ccs0: SUCCESS (3.236s)
[131.122267] Subtest engines: SUCCESS (19.429s)
[131.320190] [039/133] (888s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[131.413108] Starting subtest: plane-lut1d-ctm3x4-lut1d
[131.563886] Starting dynamic subtest: pipe-A-plane-0
[131.727823] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s)
[131.736302] Starting dynamic subtest: pipe-A-plane-1
[131.872220] Dynamic subtest pipe-A-plane-1: SUCCESS (0.144s)
[131.880873] Starting dynamic subtest: pipe-A-plane-2
[132.017874] Dynamic subtest pipe-A-plane-2: SUCCESS (0.144s)
[133.264762] Starting dynamic subtest: pipe-B-plane-0
[133.402773] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s)
[133.410845] Starting dynamic subtest: pipe-B-plane-1
[133.536468] Dynamic subtest pipe-B-plane-1: SUCCESS (0.133s)
[133.544600] Starting dynamic subtest: pipe-B-plane-2
[133.670389] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s)
[134.854538] Starting dynamic subtest: pipe-C-plane-0
[134.981219] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[134.990072] Starting dynamic subtest: pipe-C-plane-1
[135.125801] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[135.134089] Starting dynamic subtest: pipe-C-plane-2
[135.281472] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[136.491863] Starting dynamic subtest: pipe-D-plane-0
[136.610824] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s)
[136.619282] Starting dynamic subtest: pipe-D-plane-1
[136.766638] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[136.775068] Starting dynamic subtest: pipe-D-plane-2
[136.900198] Dynamic subtest pipe-D-plane-2: SUCCESS (0.133s)
[137.187126] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (5.772s)
[138.065596] [040/133] (881s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[138.168079] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[138.172270] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[138.276307] [041/133] (881s left) gem_ctx_persistence (hang)
[138.326611] Starting subtest: hang
[138.331247] Subtest hang: SKIP (0.000s)
[138.432162] [042/133] (881s left) gem_barrier_race (remote-request)
[138.495066] Starting subtest: remote-request
[138.497245] Starting dynamic subtest: rcs0
[143.687015] Dynamic subtest rcs0: SUCCESS (5.195s)
[143.689102] Subtest remote-request: SUCCESS (5.196s)
[143.814623] [043/133] (875s left) gem_mmap_wc (pf-nonblock)
[143.866247] Subtest pf-nonblock: SKIP (0.000s)
[143.923474] [044/133] (875s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[144.040407] Starting subtest: flip-vs-cursor-toggle
[152.862910] Subtest flip-vs-cursor-toggle: SUCCESS (8.823s)
[153.697061] [045/133] (865s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[154.072824] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[154.911061] [046/133] (864s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[155.010366] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[156.110620] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.101s)
[156.230830] [047/133] (863s left) perf (mi-rpc)
[156.332509] Starting subtest: mi-rpc
[156.336460] Subtest mi-rpc: SKIP (0.000s)
[156.374390] [048/133] (863s left) i915_getparams_basic (basic-subslice-total)
[156.431713] Starting subtest: basic-subslice-total
[156.435255] Subtest basic-subslice-total: SUCCESS (0.000s)
[156.510907] [049/133] (863s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[156.561485] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[156.565185] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[156.742827] [050/133] (863s left) gem_exec_whisper (basic-queues-priority-all)
[156.820297] Starting subtest: basic-queues-priority-all
[179.293166] Subtest basic-queues-priority-all: SUCCESS (22.473s)
[179.496755] [051/133] (840s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[179.557380] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[179.651636] [052/133] (840s left) gem_userptr_blits (forbidden-operations)
[179.719799] Starting subtest: forbidden-operations
[179.724423] Subtest forbidden-operations: SKIP (0.000s)
[179.846239] [053/133] (840s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[179.966718] Starting subtest: cursor-vs-flip-atomic-transitions
[210.183068] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (30.215s)
[211.050776] [054/133] (808s left) gem_exec_flush (basic-wb-rw-default)
[211.111114] Starting subtest: basic-wb-rw-default
[216.593688] Subtest basic-wb-rw-default: SUCCESS (5.447s)
[216.740974] [055/133] (803s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[216.831576] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[216.836009] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[216.922378] [056/133] (803s left) kms_async_flips (test-time-stamp)
[217.020065] Starting subtest: test-time-stamp
[217.392839] Starting dynamic subtest: pipe-A-eDP-1
[218.155966] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.762s)
[218.526217] Starting dynamic subtest: pipe-B-eDP-1
[219.284578] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.763s)
[219.657581] Starting dynamic subtest: pipe-C-eDP-1
[220.422206] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.768s)
[220.781253] Starting dynamic subtest: pipe-D-eDP-1
[221.550212] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.774s)
[221.552494] Subtest test-time-stamp: SUCCESS (4.530s)
[222.702963] [057/133] (797s left) gem_wait (wait)
[222.771287] Starting subtest: wait
[222.773611] Starting dynamic subtest: all-engines
[223.892073] Dynamic subtest all-engines: SUCCESS (1.120s)
[223.902636] Starting dynamic subtest: rcs0
[224.938960] Dynamic subtest rcs0: SUCCESS (1.045s)
[224.949312] Starting dynamic subtest: bcs0
[225.986468] Dynamic subtest bcs0: SUCCESS (1.045s)
[225.997103] Starting dynamic subtest: vcs0
[227.031412] Dynamic subtest vcs0: SUCCESS (1.043s)
[227.040865] Starting dynamic subtest: vcs1
[228.078572] Dynamic subtest vcs1: SUCCESS (1.045s)
[228.089194] Starting dynamic subtest: vecs0
[229.123392] Dynamic subtest vecs0: SUCCESS (1.043s)
[229.134779] Starting dynamic subtest: ccs0
[230.171388] Dynamic subtest ccs0: SUCCESS (1.045s)
[230.174055] Subtest wait: SUCCESS (7.401s)
[230.389653] [058/133] (789s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[230.452969] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[230.554114] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.101s)
[230.631853] [059/133] (789s left) kms_pm_rpm (dpms-lpsp)
[232.181958] Starting subtest: dpms-lpsp
[232.877981] Subtest dpms-lpsp: SUCCESS (0.699s)
[232.961390] [060/133] (787s left) gem_exec_fence (syncobj-timeline-repeat)
[233.508400] Starting subtest: syncobj-timeline-repeat
[233.742119] Subtest syncobj-timeline-repeat: SUCCESS (0.234s)
[234.987275] [061/133] (785s left) kms_psr (fbc-psr-dpms)
[235.074813] Starting subtest: fbc-psr-dpms
[235.077113] Starting dynamic subtest: eDP-1
[235.081147] Dynamic subtest eDP-1: SKIP (0.000s)
[235.085349] Subtest fbc-psr-dpms: SKIP (0.001s)
[235.146404] [062/133] (785s left) kms_setmode (invalid-clone-single-crtc)
[235.195913] Starting subtest: invalid-clone-single-crtc
[235.201847] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[235.294166] [063/133] (785s left) gem_mmap_offset (clear-via-pagefault)
[235.355495] Starting subtest: clear-via-pagefault
[235.357444] Starting dynamic subtest: smem0
[268.591805] Dynamic subtest smem0: SUCCESS (33.232s)
[268.594349] Subtest clear-via-pagefault: SUCCESS (33.233s)
[268.688929] [064/133] (751s left) kms_atomic_interruptible (universal-setplane-cursor)
[268.779638] Starting subtest: universal-setplane-cursor
[268.781834] Starting dynamic subtest: pipe-A-eDP-1
[276.178337] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.398s)
[276.180554] Subtest universal-setplane-cursor: SUCCESS (7.399s)
[277.019334] [065/133] (743s left) gem_exec_balancer (parallel-contexts)
[277.281418] Starting subtest: parallel-contexts
[280.514653] Subtest parallel-contexts: SUCCESS (3.232s)
[281.078836] [066/133] (739s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[281.184515] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[281.188763] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[281.296516] [067/133] (739s left) gem_eio (context-create)
[281.531357] Starting subtest: context-create
[281.836535] Subtest context-create: SUCCESS (0.305s)
[281.956327] [068/133] (738s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[282.064841] Starting subtest: y-tiled-8bpp-rotate-90
[282.068592] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[282.156093] [069/133] (738s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[282.267491] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[283.327055] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.058s)
[283.461677] [070/133] (737s left) kms_vblank (ts-continuation-dpms-suspend)
[283.554871] Starting subtest: ts-continuation-dpms-suspend
[283.556913] Starting dynamic subtest: pipe-A-eDP-1
[300.729344] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.989s)
[300.743047] Starting dynamic subtest: pipe-D-eDP-1
[318.678331] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.508s)
[318.680609] Subtest ts-continuation-dpms-suspend: SUCCESS (4.501s)
[319.476862] [071/133] (701s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[319.571567] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[323.715171] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.250s)
[324.849147] [072/133] (695s left) vgem_basic (dmabuf-export)
[324.891535] Starting subtest: dmabuf-export
[324.939214] Subtest dmabuf-export: SUCCESS (0.053s)
[325.043139] [073/133] (695s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[325.138825] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[325.142792] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[325.204000] [074/133] (695s left) drm_read (empty-block)
[325.350270] Starting subtest: empty-block
[326.348080] Subtest empty-block: SUCCESS (1.014s)
[326.494204] [075/133] (694s left) syncobj_wait (reset-during-wait-for-submit)
[326.559075] Starting subtest: reset-during-wait-for-submit
[326.661983] Subtest reset-during-wait-for-submit: SUCCESS (0.104s)
[326.740957] [076/133] (694s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[326.853757] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[327.448780] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.604s)
[327.619319] [077/133] (693s left) gem_exec_balancer (full)
[327.673370] Starting subtest: full
[332.417169] Subtest full: SUCCESS (4.783s)
[332.745463] [078/133] (688s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[332.843556] Starting subtest: psr-indfb-scaledprimary
[338.602431] Subtest psr-indfb-scaledprimary: SUCCESS (5.787s)
[338.717613] [079/133] (682s left) gem_exec_schedule (semaphore-codependency)
[338.795083] Starting subtest: semaphore-codependency
[338.800778] Subtest semaphore-codependency: SUCCESS (0.012s)
[339.163902] [080/133] (681s left) syncobj_timeline (wait-all-complex)
[339.217986] Starting subtest: wait-all-complex
[339.429669] Subtest wait-all-complex: SUCCESS (0.213s)
[339.505931] [081/133] (681s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[339.601200] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[339.603541] Starting dynamic subtest: pipe-A-eDP-1
[339.626152] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[339.637532] Starting dynamic subtest: pipe-B-eDP-1
[339.658863] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[339.667909] Starting dynamic subtest: pipe-C-eDP-1
[339.688628] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[339.697439] Starting dynamic subtest: pipe-D-eDP-1
[339.718191] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[339.722098] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[341.900103] [082/133] (679s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[342.006811] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[342.774365] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.770s)
[342.922587] [083/133] (678s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[343.007184] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[343.011619] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[343.096958] [084/133] (678s left) gem_create (create-ext-placement-all)
[343.264316] Starting subtest: create-ext-placement-all
[343.267059] Subtest create-ext-placement-all: SUCCESS (0.000s)
[343.353358] [085/133] (677s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[343.465218] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[360.778245] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.304s)
[361.681478] [086/133] (659s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[361.796789] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[361.801152] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[361.896418] [087/133] (659s left) gen7_exec_parse (bitmasks)
[361.949800] Subtest bitmasks: SKIP (0.000s)
[362.019297] [088/133] (659s left) gem_eio (in-flight-contexts-1us)
[362.245807] Starting subtest: in-flight-contexts-1us
[373.673263] Subtest in-flight-contexts-1us: SUCCESS (11.423s)
[373.832737] [089/133] (647s left) gem_exec_suspend (basic-s3-devices)
[373.897136] Starting subtest: basic-S3-devices
[373.899429] Starting dynamic subtest: smem
[385.612962] Dynamic subtest smem: SUCCESS (11.713s)
[385.616296] Subtest basic-S3-devices: SUCCESS (11.716s)
[385.797797] [090/133] (635s left) gem_exec_params (invalid-ring2)
[385.860069] Starting subtest: invalid-ring2
[385.862432] Subtest invalid-ring2: SUCCESS (0.000s)
[385.959567] [091/133] (635s left) i915_query (test-query-geometry-subslices)
[386.005211] Starting subtest: test-query-geometry-subslices
[386.007479] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[386.114779] [092/133] (635s left) kms_universal_plane (disable-primary-vs-flip)
[386.218608] Starting subtest: disable-primary-vs-flip
[386.220852] Starting dynamic subtest: pipe-A-eDP-1
[387.757228] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.539s)
[387.769480] Starting dynamic subtest: pipe-B-eDP-1
[390.028289] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.269s)
[390.038213] Starting dynamic subtest: pipe-C-eDP-1
[392.257293] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.229s)
[392.267292] Starting dynamic subtest: pipe-D-eDP-1
[394.442855] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.182s)
[394.444770] Subtest disable-primary-vs-flip: SUCCESS (8.224s)
[395.247258] [093/133] (626s left) kms_vrr (seamless-rr-switch-drrs)
[395.348252] Starting subtest: seamless-rr-switch-drrs
[395.354969] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[395.432627] [094/133] (626s left) gem_exec_params (dr4-dirt)
[395.491313] Starting subtest: DR4-dirt
[395.493522] Subtest DR4-dirt: SUCCESS (0.000s)
[395.585680] [095/133] (626s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[395.673758] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[395.678094] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[395.786288] [096/133] (625s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[395.884225] Starting subtest: plane-scaler-unity-scaling-with-rotation
[395.886552] Starting dynamic subtest: pipe-A
[396.110749] Dynamic subtest pipe-A: SUCCESS (0.228s)
[396.121963] Starting dynamic subtest: pipe-B
[397.420318] Dynamic subtest pipe-B: SUCCESS (1.309s)
[397.429799] Starting dynamic subtest: pipe-C
[398.747784] Dynamic subtest pipe-C: SUCCESS (1.326s)
[398.757035] Starting dynamic subtest: pipe-D
[400.082992] Dynamic subtest pipe-D: SUCCESS (1.334s)
[400.085350] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.201s)
[401.261257] [097/133] (620s left) i915_drm_fdinfo (context-close-stress)
[401.303864] Starting subtest: context-close-stress
[412.101396] Subtest context-close-stress: SUCCESS (10.746s)
[412.143254] [098/133] (609s left) kms_chamelium_hpd (dp-hpd-storm)
[412.680361] Subtest dp-hpd-storm: SKIP (0.000s)
[413.464559] [099/133] (608s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[413.564726] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[420.573075] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.011s)
[420.685106] [100/133] (601s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[420.746290] Starting subtest: etime-multi-wait-for-submit-submitted
[420.847264] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.101s)
[420.946214] [101/133] (600s left) perf_pmu (all-busy-idle-check-all)
[420.985582] Starting subtest: all-busy-idle-check-all
[422.605724] Subtest all-busy-idle-check-all: SUCCESS (1.621s)
[422.717429] [102/133] (599s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[422.806690] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[430.018847] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.216s)
[430.130123] [103/133] (591s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[430.228969] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[437.507486] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.283s)
[437.672382] [104/133] (584s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[437.769924] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[437.774053] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[437.834985] [105/133] (584s left) kms_cursor_crc (cursor-offscreen-256x256)
[438.082888] Starting subtest: cursor-offscreen-256x256
[438.087628] Starting dynamic subtest: pipe-A-eDP-1
[440.021152] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.932s)
[440.048941] Starting dynamic subtest: pipe-D-eDP-1
[442.663806] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.622s)
[442.666107] Subtest cursor-offscreen-256x256: SUCCESS (4.580s)
[443.510193] [106/133] (578s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[443.626143] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[443.630272] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[443.724100] [107/133] (578s left) kms_async_flips (alternate-sync-async-flip-atomic)
[443.814878] Starting subtest: alternate-sync-async-flip-atomic
[444.198758] Starting dynamic subtest: pipe-A-eDP-1
[447.013978] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.817s)
[447.395911] Starting dynamic subtest: pipe-B-eDP-1
[450.141498] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.755s)
[450.530707] Starting dynamic subtest: pipe-C-eDP-1
[453.275784] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.764s)
[453.650221] Starting dynamic subtest: pipe-D-eDP-1
[456.408753] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.768s)
[456.411782] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.600s)
[457.583786] [108/133] (564s left) syncobj_eventfd (invalid-bad-flags)
[457.647803] Starting subtest: invalid-bad-flags
[457.650119] Subtest invalid-bad-flags: SUCCESS (0.000s)
[457.748046] [109/133] (564s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[457.850433] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[457.852704] Starting dynamic subtest: pipe-A-eDP-1
[457.873199] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[457.887422] Starting dynamic subtest: pipe-B-eDP-1
[457.906825] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[457.915632] Starting dynamic subtest: pipe-C-eDP-1
[457.935129] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[457.943891] Starting dynamic subtest: pipe-D-eDP-1
[457.963396] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[457.965281] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.007s)
[460.144389] [110/133] (562s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[460.241987] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[460.246332] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[460.351852] [111/133] (561s left) kms_getfb (getfb-reject-nv12)
[460.446559] Starting subtest: getfb-reject-nv12
[460.448793] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[460.554570] [112/133] (561s left) kms_chamelium_color (ctm-blue-to-red)
[460.650884] Subtest ctm-blue-to-red: SKIP (0.000s)
[460.698166] [113/133] (561s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[460.761069] Starting subtest: multi-wait-all-available-submitted-signaled
[460.763368] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s)
[460.855096] [114/133] (561s left) gem_caching (writes)
[460.922684] Subtest writes: SKIP (0.000s)
[461.003866] [115/133] (561s left) kms_psr (psr-suspend)
[461.099943] Starting subtest: psr-suspend
[461.101837] Starting dynamic subtest: eDP-1
[479.592096] Dynamic subtest eDP-1: SUCCESS (2.937s)
[479.594325] Subtest psr-suspend: SUCCESS (2.938s)
[480.437365] [116/133] (542s left) kms_psr (psr2-cursor-blt)
[480.535656] Starting subtest: psr2-cursor-blt
[480.537995] Starting dynamic subtest: eDP-1
[482.184135] Dynamic subtest eDP-1: SUCCESS (1.698s)
[482.186352] Subtest psr2-cursor-blt: SUCCESS (1.699s)
[483.036450] [117/133] (539s left) kms_psr (psr-basic)
[483.132632] Starting subtest: psr-basic
[483.134854] Starting dynamic subtest: eDP-1
[484.695365] Dynamic subtest eDP-1: SUCCESS (1.596s)
[484.697604] Subtest psr-basic: SUCCESS (1.597s)
[485.553187] [118/133] (537s left) gem_exec_reloc (basic-write-gtt)
[485.620257] Subtest basic-write-gtt: SKIP (0.000s)
[485.687435] [119/133] (536s left) kms_flip (2x-flip-vs-fences)
[485.771360] Starting subtest: 2x-flip-vs-fences
[485.775480] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[485.883909] [120/133] (536s left) kms_atomic_transition (plane-all-transition)
[485.974704] Starting subtest: plane-all-transition
[485.976846] Starting dynamic subtest: pipe-A-eDP-1
[488.433893] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[488.750208] Starting dynamic subtest: pipe-B-eDP-1
[491.920005] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.211s)
[492.213234] Subtest plane-all-transition: SUCCESS (6.311s)
[493.050035] [121/133] (529s left) gem_ctx_persistence (engines-hostile)
[493.117617] Starting subtest: engines-hostile
[493.119816] Starting dynamic subtest: rcs0
[493.186094] Dynamic subtest rcs0: SUCCESS (0.071s)
[493.198480] Starting dynamic subtest: bcs0
[493.261137] Dynamic subtest bcs0: SUCCESS (0.073s)
[493.272218] Starting dynamic subtest: vcs0
[493.380307] Dynamic subtest vcs0: SUCCESS (0.118s)
[493.392926] Starting dynamic subtest: vcs1
[493.469053] Dynamic subtest vcs1: SUCCESS (0.087s)
[493.481334] Starting dynamic subtest: vecs0
[493.561224] Dynamic subtest vecs0: SUCCESS (0.090s)
[493.573414] Starting dynamic subtest: ccs0
[493.655261] Dynamic subtest ccs0: SUCCESS (0.092s)
[493.657686] Subtest engines-hostile: SUCCESS (0.545s)
[493.746217] [122/133] (529s left) kms_plane_cursor (primary)
[493.838568] Starting subtest: primary
[493.842505] Starting dynamic subtest: pipe-A-eDP-1-size-64
[496.367733] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.543s)
[496.393173] Starting dynamic subtest: pipe-A-eDP-1-size-128
[498.915535] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.539s)
[498.938373] Starting dynamic subtest: pipe-A-eDP-1-size-256
[501.509491] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.585s)
[501.823129] Starting dynamic subtest: pipe-B-eDP-1-size-64
[505.071144] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.264s)
[505.096599] Starting dynamic subtest: pipe-B-eDP-1-size-128
[507.712032] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.628s)
[507.736423] Starting dynamic subtest: pipe-B-eDP-1-size-256
[510.288501] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.561s)
[510.608924] Starting dynamic subtest: pipe-C-eDP-1-size-64
[513.521822] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.925s)
[513.549680] Starting dynamic subtest: pipe-C-eDP-1-size-128
[515.721600] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.180s)
[515.751753] Starting dynamic subtest: pipe-C-eDP-1-size-256
[517.943861] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.203s)
[518.267665] Starting dynamic subtest: pipe-D-eDP-1-size-64
[521.154712] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.900s)
[521.181897] Starting dynamic subtest: pipe-D-eDP-1-size-128
[523.364927] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.191s)
[523.392387] Starting dynamic subtest: pipe-D-eDP-1-size-256
[525.564792] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.180s)
[525.872863] Subtest primary: SUCCESS (32.079s)
[526.720446] [123/133] (496s left) gem_exec_params (no-blt)
[526.784492] Starting subtest: no-blt
[526.787018] Subtest no-blt: SUCCESS (0.002s)
[526.933792] [124/133] (495s left) kms_cursor_crc (cursor-size-hints)
[527.051223] Starting subtest: cursor-size-hints
[527.053475] Starting dynamic subtest: pipe-A-eDP-1
[527.658892] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.607s)
[527.669124] Starting dynamic subtest: pipe-D-eDP-1
[528.874183] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.213s)
[528.876408] Subtest cursor-size-hints: SUCCESS (1.822s)
[529.690109] [125/133] (493s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[529.805251] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[529.809739] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s)
[529.879079] [126/133] (493s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[529.943139] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[530.013409] [127/133] (493s left) sysfs_timeslice_duration (idempotent)
[530.071134] Starting subtest: idempotent
[530.073357] Starting dynamic subtest: vecs0
[530.075682] Dynamic subtest vecs0: SUCCESS (0.000s)
[530.085046] Starting dynamic subtest: ccs0
[530.086939] Dynamic subtest ccs0: SUCCESS (0.000s)
[530.095629] Starting dynamic subtest: vcs0
[530.097513] Dynamic subtest vcs0: SUCCESS (0.000s)
[530.106256] Starting dynamic subtest: bcs0
[530.108181] Dynamic subtest bcs0: SUCCESS (0.000s)
[530.116821] Starting dynamic subtest: rcs0
[530.118729] Dynamic subtest rcs0: SUCCESS (0.000s)
[530.127611] Starting dynamic subtest: vcs1
[530.129844] Dynamic subtest vcs1: SUCCESS (0.000s)
[530.132114] Subtest idempotent: SUCCESS (0.006s)
[530.179364] [128/133] (492s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[530.267656] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[530.269942] Starting dynamic subtest: pipe-A-eDP-1
[530.780219] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.491s)
[530.790809] Starting dynamic subtest: pipe-B-eDP-1
[532.270827] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.484s)
[532.281100] Starting dynamic subtest: pipe-C-eDP-1
[533.697681] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.427s)
[533.708540] Starting dynamic subtest: pipe-D-eDP-1
[535.092790] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.393s)
[535.094744] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.801s)
[536.296487] [129/133] (486s left) api_intel_bb (object-reloc-purge-cache)
[536.370056] Starting subtest: object-reloc-purge-cache
[536.374287] Subtest object-reloc-purge-cache: SKIP (0.003s)
[536.500003] [130/133] (486s left) device_reset (unbind-cold-reset-rebind)
[536.546837] Starting subtest: unbind-cold-reset-rebind
[536.551270] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[536.619524] [131/133] (486s left) gem_exec_whisper (basic-contexts-forked)
[536.671599] Starting subtest: basic-contexts-forked
[561.749542] Subtest basic-contexts-forked: SUCCESS (25.034s)
[561.881589] [132/133] (461s left) kms_prop_blob (invalid-get-prop)
[561.942638] Starting subtest: invalid-get-prop
[561.944918] Subtest invalid-get-prop: SUCCESS (0.000s)
[562.053178] [133/133] (461s left) kms_pm_rpm (modeset-non-lpsp)
[564.288686] Starting subtest: modeset-non-lpsp
[565.448637] Subtest modeset-non-lpsp: SKIP (1.160s)
[565.828605] Closing watchdogs
results: parsing output: 0/ for test: gem_ctx_param
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: template
results: parsing output: 3/ for test: kms_plane_alpha_blend
results: parsing output: 4/ for test: gem_exec_fence
results: parsing output: 5/ for test: kms_invalid_mode
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: kms_cursor_legacy
results: parsing output: 8/ for test: gem_exec_schedule
results: parsing output: 9/ for test: kms_flip_scaled_crc
results: parsing output: 10/ for test: kms_psr2_su
results: parsing output: 11/ for test: kms_rotation_crc
results: parsing output: 12/ for test: kms_cursor_edge_walk
results: parsing output: 13/ for test: gem_mmap_gtt
results: parsing output: 14/ for test: gem_exec_reloc
results: parsing output: 15/ for test: kms_feature_discovery
results: parsing output: 16/ for test: kms_feature_discovery
results: parsing output: 17/ for test: gem_exec_params
results: parsing output: 18/ for test: kms_content_protection
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_flip
results: parsing output: 21/ for test: gem_pread
results: parsing output: 22/ for test: kms_plane_scaling
results: parsing output: 23/ for test: gem_render_copy
results: parsing output: 24/ for test: prime_vgem
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: api_intel_allocator
results: parsing output: 27/ for test: i915_pm_rps
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: vgem_basic
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_ccs
results: parsing output: 34/ for test: kms_flip
results: parsing output: 35/ for test: kms_ccs
results: parsing output: 36/ for test: perf_pmu
results: parsing output: 37/ for test: gem_spin_batch
results: parsing output: 38/ for test: kms_color_pipeline
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_ctx_persistence
results: parsing output: 41/ for test: gem_barrier_race
results: parsing output: 42/ for test: gem_mmap_wc
results: parsing output: 43/ for test: kms_cursor_legacy
results: parsing output: 44/ for test: kms_chamelium_edid
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: perf
results: parsing output: 47/ for test: i915_getparams_basic
results: parsing output: 48/ for test: gem_render_copy
results: parsing output: 49/ for test: gem_exec_whisper
results: parsing output: 50/ for test: kms_pipe_b_c_ivb
results: parsing output: 51/ for test: gem_userptr_blits
results: parsing output: 52/ for test: kms_cursor_legacy
results: parsing output: 53/ for test: gem_exec_flush
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: kms_async_flips
results: parsing output: 56/ for test: gem_wait
results: parsing output: 57/ for test: syncobj_wait
results: parsing output: 58/ for test: kms_pm_rpm
results: parsing output: 59/ for test: gem_exec_fence
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: kms_setmode
results: parsing output: 62/ for test: gem_mmap_offset
results: parsing output: 63/ for test: kms_atomic_interruptible
results: parsing output: 64/ for test: gem_exec_balancer
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_eio
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: kms_vblank
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: vgem_basic
results: parsing output: 72/ for test: kms_psr2_sf
results: parsing output: 73/ for test: drm_read
results: parsing output: 74/ for test: syncobj_wait
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: gem_exec_balancer
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_exec_schedule
results: parsing output: 79/ for test: syncobj_timeline
results: parsing output: 80/ for test: kms_ccs
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: kms_plane
results: parsing output: 83/ for test: gem_create
results: parsing output: 84/ for test: kms_cursor_legacy
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gen7_exec_parse
results: parsing output: 87/ for test: gem_eio
results: parsing output: 88/ for test: gem_exec_suspend
results: parsing output: 89/ for test: gem_exec_params
results: parsing output: 90/ for test: i915_query
results: parsing output: 91/ for test: kms_universal_plane
results: parsing output: 92/ for test: kms_vrr
results: parsing output: 93/ for test: gem_exec_params
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_plane_scaling
results: parsing output: 96/ for test: i915_drm_fdinfo
results: parsing output: 97/ for test: kms_chamelium_hpd
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: syncobj_timeline
results: parsing output: 100/ for test: perf_pmu
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_joiner
results: parsing output: 104/ for test: kms_cursor_crc
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_async_flips
results: parsing output: 107/ for test: syncobj_eventfd
results: parsing output: 108/ for test: kms_ccs
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_getfb
results: parsing output: 111/ for test: kms_chamelium_color
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: gem_caching
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: kms_psr
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: gem_exec_reloc
results: parsing output: 118/ for test: kms_flip
results: parsing output: 119/ for test: kms_atomic_transition
results: parsing output: 120/ for test: gem_ctx_persistence
results: parsing output: 121/ for test: kms_plane_cursor
results: parsing output: 122/ for test: gem_exec_params
results: parsing output: 123/ for test: kms_cursor_crc
results: parsing output: 124/ for test: kms_flip_scaled_crc
results: parsing output: 125/ for test: gem_exec_reloc
results: parsing output: 126/ for test: sysfs_timeslice_duration
results: parsing output: 127/ for test: kms_ccs
results: parsing output: 128/ for test: api_intel_bb
results: parsing output: 129/ for test: device_reset
results: parsing output: 130/ for test: gem_exec_whisper
results: parsing output: 131/ for test: kms_prop_blob
results: parsing output: 132/ for test: kms_pm_rpm
Done.