[57.432585] Initializing watchdogs
[57.432636]   /dev/watchdog0
[57.447056] [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.451578] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.454163] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.457464] [001/133] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[57.584134] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[57.588066] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[57.671869] [002/133] (960s left) gem_mmap_gtt (fault-concurrent-x)
[57.725848] Subtest fault-concurrent-X: SKIP (0.000s)
[57.779100] [003/133] (960s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[57.867948] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[57.879629] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.011s)
[57.954887] [004/133] (960s left) syncobj_wait (wait-any-snapshot)
[57.999970] Starting subtest: wait-any-snapshot
[58.082024] Subtest wait-any-snapshot: SUCCESS (0.083s)
[58.152511] [005/133] (959s left) kms_frontbuffer_tracking (psr-1p-rte)
[58.247069] Starting subtest: psr-1p-rte
[63.621858] Subtest psr-1p-rte: SUCCESS (5.382s)
[63.740944] [006/133] (954s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[63.839049] Starting subtest: disable-crc-after-crtc
[63.841446] Starting dynamic subtest: pipe-A-eDP-1
[65.489877] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.652s)
[65.497826] Starting dynamic subtest: pipe-B-eDP-1
[67.744955] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.256s)
[67.754021] Starting dynamic subtest: pipe-C-eDP-1
[69.993032] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.248s)
[70.000900] Starting dynamic subtest: pipe-D-eDP-1
[72.254329] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.262s)
[72.256774] Subtest disable-crc-after-crtc: SUCCESS (8.422s)
[73.109600] [007/133] (945s left) kms_dp_link_training (uhbr-sst)
[73.233084] Starting subtest: uhbr-sst
[73.241814] Subtest uhbr-sst: SKIP (0.000s)
[73.411687] [008/133] (944s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[73.549667] Starting subtest: invalid-single-wait-all-unsubmitted
[73.551597] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[73.644977] [009/133] (944s left) gem_ctx_isolation (preservation)
[73.710865] Starting subtest: preservation
[73.713365] Starting dynamic subtest: rcs0
[73.857402] Dynamic subtest rcs0: SUCCESS (0.145s)
[73.866243] Starting dynamic subtest: bcs0
[73.990715] Dynamic subtest bcs0: SUCCESS (0.134s)
[74.000996] Starting dynamic subtest: vcs0
[74.154834] Dynamic subtest vcs0: SUCCESS (0.164s)
[74.165763] Starting dynamic subtest: vcs1
[75.474474] Dynamic subtest vcs1: SUCCESS (1.320s)
[75.485235] Starting dynamic subtest: vecs0
[77.465294] Dynamic subtest vecs0: SUCCESS (1.991s)
[77.475427] Starting dynamic subtest: ccs0
[79.471076] Dynamic subtest ccs0: SUCCESS (2.006s)
[79.474556] Subtest preservation: SUCCESS (5.762s)
[79.713668] [010/133] (938s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[79.848406] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[79.853643] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[79.938573] [011/133] (938s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[80.030719] Starting subtest: primary-y-tiled-reflect-x-270
[80.035142] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[80.110736] [012/133] (938s left) kms_psr (fbc-psr-no-drrs)
[80.203897] Starting subtest: fbc-psr-no-drrs
[80.206294] Starting dynamic subtest: eDP-1
[80.210735] Dynamic subtest eDP-1: SKIP (0.000s)
[80.215260] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[80.276032] [013/133] (938s left) core_setmaster (master-drop-set-user)
[80.360113] Starting subtest: master-drop-set-user
[80.373447] Subtest master-drop-set-user: SUCCESS (0.013s)
[80.410635] [014/133] (938s left) gem_eio (wait-1us)
[80.611229] Starting subtest: wait-1us
[80.906070] Subtest wait-1us: SUCCESS (0.295s)
[81.059449] [015/133] (937s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[81.151540] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[81.153628] Starting dynamic subtest: pipe-A-eDP-1
[81.171251] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[81.180254] Starting dynamic subtest: pipe-B-eDP-1
[81.197327] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[81.205305] Starting dynamic subtest: pipe-C-eDP-1
[81.220937] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[81.228131] Starting dynamic subtest: pipe-D-eDP-1
[81.243773] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[81.245569] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.007s)
[83.449467] [016/133] (935s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[83.550837] Starting subtest: y-tiled-16bpp-rotate-90
[83.555174] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[83.660672] [017/133] (934s left) gem_ppgtt (shrink-vs-evict-pinned)
[83.715727] Starting subtest: shrink-vs-evict-pinned
[91.285640] Subtest shrink-vs-evict-pinned: SUCCESS (7.569s)
[91.373818] [018/133] (927s left) kms_getfb (getfb-reject-nv12)
[91.474921] Starting subtest: getfb-reject-nv12
[91.477249] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[91.567323] [019/133] (927s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[91.678509] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[99.374963] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.700s)
[99.485932] [020/133] (919s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[99.590445] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[99.594456] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[99.682705] [021/133] (919s left) kms_properties (plane-properties-legacy)
[99.771223] Starting subtest: plane-properties-legacy
[99.773566] Starting dynamic subtest: pipe-A-eDP-1
[100.348423] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.577s)
[100.357734] Starting dynamic subtest: pipe-B-eDP-1
[101.670341] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.322s)
[101.680198] Starting dynamic subtest: pipe-C-eDP-1
[102.982290] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.308s)
[102.993290] Starting dynamic subtest: pipe-D-eDP-1
[104.224230] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.243s)
[104.226552] Subtest plane-properties-legacy: SUCCESS (4.455s)
[105.031740] [022/133] (913s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[105.125670] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[105.129624] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s)
[105.208130] [023/133] (913s left) gem_exec_reloc (basic-cpu-noreloc)
[105.285547] Subtest basic-cpu-noreloc: SKIP (0.000s)
[105.351804] [024/133] (913s left) i915_query (query-topology-coherent-slice-mask)
[105.400058] Starting subtest: query-topology-coherent-slice-mask
[105.404594] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[105.486052] [025/133] (913s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[105.546163] Starting subtest: multi-wait-available-submitted-signaled
[105.548502] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.001s)
[105.665880] [026/133] (913s left) gem_exec_fence (syncobj-unused-fence)
[106.125051] Starting subtest: syncobj-unused-fence
[106.131469] Subtest syncobj-unused-fence: SUCCESS (0.009s)
[107.360984] [FACT gem_exec_fence (syncobj-unused-fence)] new: kernel.kmod_is_loaded.vgem: true
[107.364404] [027/133] (911s left) gem_mmap_wc (write-read-distinct)
[107.423132] Subtest write-read-distinct: SKIP (0.000s)
[107.488851] [028/133] (911s left) kms_cursor_edge_walk (128x128-top-bottom)
[107.585400] Starting subtest: 128x128-top-bottom
[107.587723] Starting dynamic subtest: pipe-A-eDP-1
[111.011512] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.426s)
[111.021352] Starting dynamic subtest: pipe-D-eDP-1
[114.139937] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.129s)
[114.142281] Subtest 128x128-top-bottom: SUCCESS (6.557s)
[114.944888] [029/133] (904s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[115.027091] Starting subtest: fbc-psr2-primary-mmap-cpu
[115.029205] Starting dynamic subtest: eDP-1
[115.033132] Dynamic subtest eDP-1: SKIP (0.000s)
[115.037074] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[115.102096] [030/133] (904s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[115.210365] Starting subtest: x-tiled-32bpp-rotate-270
[115.229838] Subtest x-tiled-32bpp-rotate-270: SKIP (0.019s)
[115.331303] [031/133] (903s left) kms_psr (pr-cursor-mmap-cpu)
[115.427795] Starting subtest: pr-cursor-mmap-cpu
[115.432175] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[115.496652] [032/133] (903s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[115.595746] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[115.600087] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[115.693344] [033/133] (903s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[115.797546] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[115.801599] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[115.920062] [034/133] (903s left) kms_big_fb (yf-tiled-addfb)
[116.019742] Starting subtest: yf-tiled-addfb
[116.023534] Subtest yf-tiled-addfb: SKIP (0.000s)
[116.119195] [035/133] (903s left) prime_vgem (wait)
[116.185088] Starting subtest: wait
[116.186727] Starting dynamic subtest: rcs0
[116.223213] Dynamic subtest rcs0: SUCCESS (0.040s)
[116.231328] Starting dynamic subtest: bcs0
[116.284862] Dynamic subtest bcs0: SUCCESS (0.061s)
[116.292953] Starting dynamic subtest: vcs0
[116.331594] Dynamic subtest vcs0: SUCCESS (0.046s)
[116.339642] Starting dynamic subtest: vcs1
[116.378570] Dynamic subtest vcs1: SUCCESS (0.046s)
[116.386545] Starting dynamic subtest: vecs0
[116.423712] Dynamic subtest vecs0: SUCCESS (0.045s)
[116.431846] Starting dynamic subtest: ccs0
[116.471938] Dynamic subtest ccs0: SUCCESS (0.048s)
[116.473673] Subtest wait: SUCCESS (0.289s)
[116.605097] [036/133] (902s left) gem_mmap_offset (partial-remap)
[116.657024] Starting subtest: partial-remap
[116.659244] Starting dynamic subtest: smem0
[116.666824] Dynamic subtest smem0: SUCCESS (0.004s)
[116.668676] Subtest partial-remap: SUCCESS (0.004s)
[116.779797] [037/133] (902s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[116.873116] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[116.875068] Starting dynamic subtest: pipe-A-eDP-1
[122.736397] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.867s)
[122.746745] Starting dynamic subtest: pipe-B-eDP-1
[129.390422] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.651s)
[129.392815] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.520s)
[130.268676] [038/133] (889s left) kms_hdr (static-toggle-suspend)
[130.375720] Starting subtest: static-toggle-suspend
[130.381694] Subtest static-toggle-suspend: SKIP (0.000s)
[130.463119] [039/133] (889s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[130.533408] Starting subtest: yf-tiled-to-vebox-yf-tiled
[130.538071] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[130.719450] [040/133] (888s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[130.821344] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[130.823716] Starting dynamic subtest: pipe-A-eDP-1
[130.847562] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[130.858608] Starting dynamic subtest: pipe-B-eDP-1
[130.880712] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[130.888884] Starting dynamic subtest: pipe-C-eDP-1
[130.910355] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[130.918150] Starting dynamic subtest: pipe-D-eDP-1
[130.940050] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[130.944405] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[133.136009] [041/133] (886s left) kms_pm_rpm (pc8-residency)
[134.668784] Starting subtest: pc8-residency
[134.673633] Subtest pc8-residency: SKIP (0.000s)
[135.382758] [042/133] (884s left) gem_exec_schedule (preemptive-hang)
[135.580983] Starting subtest: preemptive-hang
[135.583303] Starting dynamic subtest: rcs0
[144.532514] Dynamic subtest rcs0: SUCCESS (8.948s)
[144.542905] Starting dynamic subtest: bcs0
[153.426597] Dynamic subtest bcs0: SUCCESS (8.898s)
[153.438058] Starting dynamic subtest: vcs0
[162.508852] Dynamic subtest vcs0: SUCCESS (9.081s)
[162.519081] Starting dynamic subtest: vcs1
[171.535196] Dynamic subtest vcs1: SUCCESS (9.020s)
[171.543412] Starting dynamic subtest: vecs0
[180.495998] Dynamic subtest vecs0: SUCCESS (8.957s)
[180.504496] Starting dynamic subtest: ccs0
[189.457049] Dynamic subtest ccs0: SUCCESS (8.961s)
[189.459758] Subtest preemptive-hang: SUCCESS (53.871s)
[189.697426] [043/133] (829s left) kms_pipe_crc_basic (bad-source)
[189.793925] Starting subtest: bad-source
[189.796136] Subtest bad-source: SUCCESS (0.000s)
[189.866878] [044/133] (829s left) gem_exec_schedule (preempt-user)
[189.940908] Starting subtest: preempt-user
[189.943213] Starting dynamic subtest: rcs0
[189.961352] Dynamic subtest rcs0: SUCCESS (0.025s)
[189.974341] Starting dynamic subtest: bcs0
[189.979529] Dynamic subtest bcs0: SUCCESS (0.018s)
[189.988245] Starting dynamic subtest: vcs0
[189.999275] Dynamic subtest vcs0: SUCCESS (0.019s)
[190.008128] Starting dynamic subtest: vcs1
[190.018756] Dynamic subtest vcs1: SUCCESS (0.019s)
[190.027943] Starting dynamic subtest: vecs0
[190.042895] Dynamic subtest vecs0: SUCCESS (0.024s)
[190.052188] Starting dynamic subtest: ccs0
[190.064289] Dynamic subtest ccs0: SUCCESS (0.021s)
[190.066515] Subtest preempt-user: SUCCESS (0.129s)
[191.401704] [045/133] (828s left) gem_huc_copy (huc-copy)
[191.461361] Starting subtest: huc-copy
[191.466565] Subtest huc-copy: SUCCESS (0.004s)
[191.571464] [046/133] (828s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[191.674930] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[192.786767] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.112s)
[192.896650] [047/133] (826s left) kms_content_protection (dp-mst-lic-type-1)
[193.030066] Starting subtest: dp-mst-lic-type-1
[193.033370] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[193.135745] [048/133] (826s left) core_getclient (basic)
[193.188097] Starting subtest: basic
[193.189922] Subtest basic: SUCCESS (0.000s)
[193.284255] [049/133] (826s left) gem_mmap (short-mmap)
[193.351515] Subtest short-mmap: SKIP (0.000s)
[193.414176] [050/133] (826s left) perf_pmu (busy-check-all)
[193.452208] Starting subtest: busy-check-all
[193.454119] Starting dynamic subtest: rcs0
[194.008277] Dynamic subtest rcs0: SUCCESS (0.558s)
[194.020135] Starting dynamic subtest: bcs0
[194.557911] Dynamic subtest bcs0: SUCCESS (0.547s)
[194.569905] Starting dynamic subtest: vcs0
[196.322528] Dynamic subtest vcs0: SUCCESS (1.761s)
[196.333710] Starting dynamic subtest: vcs1
[198.307086] Dynamic subtest vcs1: SUCCESS (1.982s)
[198.319338] Starting dynamic subtest: vecs0
[200.354403] Dynamic subtest vecs0: SUCCESS (2.045s)
[200.367037] Starting dynamic subtest: ccs0
[200.908292] Dynamic subtest ccs0: SUCCESS (0.553s)
[200.910812] Subtest busy-check-all: SUCCESS (7.458s)
[201.016795] [051/133] (818s left) gem_partial_pwrite_pread (write-display)
[201.076914] Subtest write-display: SKIP (0.000s)
[201.142072] [052/133] (818s left) gem_ctx_sseu (invalid-sseu)
[201.200444] Subtest invalid-sseu: SKIP (0.000s)
[201.267585] [053/133] (818s left) kms_plane_multiple (tiling-none)
[201.360124] Starting subtest: tiling-none
[201.362471] Starting dynamic subtest: pipe-A-eDP-1
[205.128516] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.767s)
[205.138317] Starting dynamic subtest: pipe-B-eDP-1
[209.635360] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.506s)
[209.644945] Starting dynamic subtest: pipe-C-eDP-1
[214.072656] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.436s)
[214.082485] Starting dynamic subtest: pipe-D-eDP-1
[218.407205] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.331s)
[218.409528] Subtest tiling-none: SUCCESS (17.046s)
[219.214707] [054/133] (800s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[219.268211] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[219.326412] [055/133] (800s left) i915_pm_rpm (system-suspend-devices)
[221.563483] Starting subtest: system-suspend-devices
[229.390372] Subtest system-suspend-devices: SUCCESS (7.828s)
[240.858019] [056/133] (790s left) kms_async_flips (test-time-stamp-atomic)
[240.976101] Starting subtest: test-time-stamp-atomic
[241.360984] Starting dynamic subtest: pipe-A-eDP-1
[242.196811] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.834s)
[242.592771] Starting dynamic subtest: pipe-B-eDP-1
[243.414893] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.827s)
[243.792391] Starting dynamic subtest: pipe-C-eDP-1
[244.546730] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.761s)
[244.909801] Starting dynamic subtest: pipe-D-eDP-1
[245.675067] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.771s)
[245.677448] Subtest test-time-stamp-atomic: SUCCESS (4.699s)
[246.846222] [057/133] (784s left) kms_cursor_crc (cursor-offscreen-256x256)
[247.113828] Starting subtest: cursor-offscreen-256x256
[247.116098] Starting dynamic subtest: pipe-A-eDP-1
[249.068712] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.952s)
[249.099031] Starting dynamic subtest: pipe-D-eDP-1
[251.649350] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.558s)
[251.651782] Subtest cursor-offscreen-256x256: SUCCESS (4.537s)
[252.525498] [058/133] (778s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[252.620252] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[252.624435] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[252.712457] [059/133] (778s left) gem_exec_await (wide-contexts)
[252.914555] Starting subtest: wide-contexts
[276.177045] Subtest wide-contexts: SUCCESS (23.259s)
[276.387613] [060/133] (755s left) kms_flip (nonexisting-fb-interruptible)
[276.547431] Starting subtest: nonexisting-fb-interruptible
[276.552253] Starting dynamic subtest: A-eDP1
[277.693061] Dynamic subtest A-eDP1: SUCCESS (1.142s)
[277.704527] Starting dynamic subtest: B-eDP1
[278.828137] Dynamic subtest B-eDP1: SUCCESS (1.134s)
[278.841181] Starting dynamic subtest: C-eDP1
[279.964534] Dynamic subtest C-eDP1: SUCCESS (1.134s)
[279.977554] Starting dynamic subtest: D-eDP1
[281.095373] Dynamic subtest D-eDP1: SUCCESS (1.128s)
[281.100488] Subtest nonexisting-fb-interruptible: SUCCESS (4.551s)
[282.274143] [061/133] (749s left) kms_psr (psr2-no-drrs)
[282.369400] Starting subtest: psr2-no-drrs
[282.371786] Starting dynamic subtest: eDP-1
[283.953604] Dynamic subtest eDP-1: SUCCESS (1.584s)
[283.955975] Subtest psr2-no-drrs: SUCCESS (1.585s)
[284.753525] [062/133] (746s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping)
[284.847275] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping
[284.873142] Starting dynamic subtest: pipe-A-plane-0
[285.162421] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[285.175777] Starting dynamic subtest: pipe-A-plane-3
[285.395048] Dynamic subtest pipe-A-plane-3: SUCCESS (0.230s)
[286.536178] Starting dynamic subtest: pipe-B-plane-0
[286.825552] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[286.835817] Starting dynamic subtest: pipe-B-plane-3
[287.070023] Dynamic subtest pipe-B-plane-3: SUCCESS (0.242s)
[287.378871] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.534s)
[288.201400] [063/133] (743s left) gem_exec_balancer (bonded-true-hang)
[288.478345] Starting subtest: bonded-true-hang
[288.482709] Subtest bonded-true-hang: SKIP (0.000s)
[288.599624] [064/133] (742s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[288.981171] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[289.812771] [065/133] (741s left) gem_exec_reloc (basic-write-cpu-noreloc)
[289.875718] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[289.952655] [066/133] (741s left) kms_hdmi_inject (inject-4k)
[290.291175] Starting subtest: inject-4k
[290.600844] Subtest inject-4k: SUCCESS (0.313s)
[291.211601] [067/133] (740s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[291.267725] Starting subtest: etime-single-wait-all-for-submit-submitted
[291.375031] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.105s)
[291.454120] [068/133] (740s left) kms_flip (flip-vs-modeset-vs-hang)
[291.547642] Starting subtest: flip-vs-modeset-vs-hang
[291.550075] Starting dynamic subtest: A-eDP1
[342.780176] Dynamic subtest A-eDP1: SUCCESS (51.231s)
[342.791416] Starting dynamic subtest: D-eDP1
[392.767755] Dynamic subtest D-eDP1: SUCCESS (49.981s)
[392.770379] Subtest flip-vs-modeset-vs-hang: SUCCESS (101.221s)
[393.147325] [069/133] (638s left) kms_lease (master-vs-lease)
[393.263456] Starting subtest: master-vs-lease
[393.265879] Subtest master-vs-lease: SUCCESS (0.002s)
[393.380615] [070/133] (638s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[393.480314] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[393.482508] Starting dynamic subtest: pipe-A-eDP-1
[393.988582] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.482s)
[394.000935] Starting dynamic subtest: pipe-B-eDP-1
[395.474367] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.483s)
[395.487029] Starting dynamic subtest: pipe-C-eDP-1
[396.903761] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.428s)
[396.924974] Starting dynamic subtest: pipe-D-eDP-1
[398.308655] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.404s)
[398.310924] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.803s)
[399.448396] [071/133] (632s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[399.515366] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[399.520046] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[399.713837] [072/133] (632s left) gem_ctx_engines (invalid-engines)
[399.777965] Starting subtest: invalid-engines
[399.782890] Subtest invalid-engines: SUCCESS (0.008s)
[399.999844] [073/133] (631s left) gem_exec_params (dr4-dirt)
[400.076644] Starting subtest: DR4-dirt
[400.079042] Subtest DR4-dirt: SUCCESS (0.000s)
[400.181450] [074/133] (631s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[400.286778] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[400.290857] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[400.390433] [075/133] (631s left) sw_sync (sync_multi_producer_single_consumer)
[400.429466] Starting subtest: sync_multi_producer_single_consumer
[401.501996] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s)
[401.582201] [076/133] (630s left) syncobj_timeline (wait-all-for-submit-complex)
[401.640862] Starting subtest: wait-all-for-submit-complex
[401.855843] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[401.933220] [077/133] (630s left) gem_eio (execbuf)
[402.141944] Starting subtest: execbuf
[402.431461] Subtest execbuf: SUCCESS (0.288s)
[402.583768] [078/133] (629s left) gem_partial_pwrite_pread (writes-after-reads)
[402.642086] Subtest writes-after-reads: SKIP (0.000s)
[402.711428] [079/133] (629s left) kms_feature_discovery (dp-mst)
[402.801161] Starting subtest: dp-mst
[402.805502] Subtest dp-mst: SKIP (0.000s)
[402.876968] [080/133] (629s left) perf (low-oa-exponent-permissions)
[403.020320] Starting subtest: low-oa-exponent-permissions
[403.057555] Subtest low-oa-exponent-permissions: SUCCESS (0.039s)
[403.108572] [081/133] (629s left) gem_exec_fence (syncobj-import)
[403.625832] Starting subtest: syncobj-import
[403.631628] Subtest syncobj-import: SUCCESS (0.008s)
[405.455834] [082/133] (626s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[405.559278] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[405.561734] Starting dynamic subtest: pipe-A-eDP-1
[405.645322] Dynamic subtest pipe-A-eDP-1: SKIP (0.089s)
[405.657834] Starting dynamic subtest: pipe-B-eDP-1
[406.791570] Dynamic subtest pipe-B-eDP-1: SKIP (1.145s)
[406.796175] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.236s)
[407.972905] [083/133] (624s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[408.104046] Starting subtest: cursorB-vs-flipB-atomic
[408.108776] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[408.300811] [084/133] (624s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[408.408446] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[408.420822] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.011s)
[408.500302] [085/133] (624s left) kms_vblank (ts-continuation-idle)
[408.597092] Starting subtest: ts-continuation-idle
[408.599175] Starting dynamic subtest: pipe-A-eDP-1
[408.994641] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.397s)
[409.012913] Starting dynamic subtest: pipe-D-eDP-1
[410.108528] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.111s)
[410.110486] Subtest ts-continuation-idle: SUCCESS (1.512s)
[410.954874] [086/133] (621s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[411.063455] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[411.068062] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[412.177383] [087/133] (620s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[412.288701] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[412.292787] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[412.404438] [088/133] (620s left) syncobj_eventfd (invalid-bad-flags)
[412.453111] Starting subtest: invalid-bad-flags
[412.455439] Subtest invalid-bad-flags: SUCCESS (0.000s)
[412.559684] [089/133] (620s left) kms_pwrite_crc (basic)
[412.648990] Starting subtest: basic
[413.340152] Subtest basic: SUCCESS (0.691s)
[414.156154] [090/133] (618s left) gem_sync (basic-store-each)
[414.231777] Starting subtest: basic-store-each
[416.698115] Subtest basic-store-each: SUCCESS (2.478s)
[416.891708] [091/133] (615s left) kms_universal_plane (universal-plane-sanity)
[417.000959] Starting subtest: universal-plane-sanity
[417.003479] Starting dynamic subtest: pipe-A-eDP-1
[417.602996] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.603s)
[417.614423] Starting dynamic subtest: pipe-B-eDP-1
[418.834992] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.227s)
[418.846790] Starting dynamic subtest: pipe-C-eDP-1
[420.015880] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.181s)
[420.028061] Starting dynamic subtest: pipe-D-eDP-1
[421.215256] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.197s)
[421.217646] Subtest universal-plane-sanity: SUCCESS (4.215s)
[422.069674] [092/133] (610s left) gem_spin_batch (legacy)
[422.126586] Starting subtest: legacy
[422.128796] Starting dynamic subtest: default
[425.369316] Dynamic subtest default: SUCCESS (3.237s)
[425.382731] Starting dynamic subtest: render
[428.657681] Dynamic subtest render: SUCCESS (3.233s)
[428.670790] Starting dynamic subtest: bsd
[431.895833] Dynamic subtest bsd: SUCCESS (3.236s)
[431.908917] Starting dynamic subtest: bsd1
[435.129180] Dynamic subtest bsd1: SUCCESS (3.231s)
[435.144715] Starting dynamic subtest: bsd2
[438.366823] Dynamic subtest bsd2: SUCCESS (3.234s)
[438.380478] Starting dynamic subtest: blt
[441.604072] Dynamic subtest blt: SUCCESS (3.234s)
[441.617181] Starting dynamic subtest: vebox
[444.842376] Dynamic subtest vebox: SUCCESS (3.235s)
[444.844872] Subtest legacy: SUCCESS (22.661s)
[445.341389] [093/133] (587s left) kms_rotation_crc (primary-rotation-90)
[445.432921] Starting subtest: primary-rotation-90
[445.437448] Subtest primary-rotation-90: SKIP (0.001s)
[445.509170] [094/133] (587s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[445.605833] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[454.275103] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.673s)
[454.390239] [095/133] (578s left) api_intel_allocator (default-alignment)
[454.455888] Starting subtest: default-alignment
[454.458824] Subtest default-alignment: SUCCESS (0.004s)
[454.600939] [096/133] (578s left) kms_chamelium_frames (hdmi-frame-dump)
[454.983729] Subtest hdmi-frame-dump: SKIP (0.000s)
[455.816944] [097/133] (577s left) kms_chamelium_audio (hdmi-audio)
[456.193359] Subtest hdmi-audio: SKIP (0.000s)
[457.023435] [098/133] (576s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[457.136508] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[457.950105] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.814s)
[458.104539] [099/133] (575s left) gen7_exec_parse (bitmasks)
[458.162602] Subtest bitmasks: SKIP (0.000s)
[458.237593] [100/133] (575s left) gem_mmap_wc (set-cache-level)
[458.290542] Subtest set-cache-level: SKIP (0.000s)
[458.353855] [101/133] (574s left) gem_madvise (dontneed-before-exec)
[458.390487] Starting subtest: dontneed-before-exec
[458.400439] Subtest dontneed-before-exec: SKIP (0.012s)
[458.462933] [102/133] (574s left) i915_module_load (resize-bar)
[458.504848] Starting subtest: resize-bar
[458.511586] Subtest resize-bar: SKIP (0.006s)
[458.554456] [103/133] (574s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[458.647263] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[458.649586] Starting dynamic subtest: pipe-A-eDP-1
[458.658807] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[458.670629] Starting dynamic subtest: pipe-B-eDP-1
[458.679791] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[458.690176] Starting dynamic subtest: pipe-C-eDP-1
[458.698764] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[458.708911] Starting dynamic subtest: pipe-D-eDP-1
[458.717380] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[458.721512] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.005s)
[460.845961] [104/133] (572s left) gem_eio (wait-immediate)
[461.064060] Starting subtest: wait-immediate
[461.406960] Subtest wait-immediate: SUCCESS (0.342s)
[461.526835] [105/133] (571s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[461.634641] Starting subtest: 2x-long-flip-vs-cursor-legacy
[461.639206] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s)
[461.780222] [106/133] (571s left) gem_exec_reloc (basic-gtt-wc-active)
[461.836432] Subtest basic-gtt-wc-active: SKIP (0.000s)
[461.916966] [107/133] (571s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[462.009392] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[462.012853] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[462.083736] [108/133] (571s left) kms_frontbuffer_tracking (fbc-tiling-4)
[462.176800] Starting subtest: fbc-tiling-4
[466.419065] Subtest fbc-tiling-4: SUCCESS (4.246s)
[467.550329] [109/133] (566s left) kms_big_fb (linear-32bpp-rotate-270)
[467.669917] Starting subtest: linear-32bpp-rotate-270
[467.689517] Subtest linear-32bpp-rotate-270: SKIP (0.019s)
[467.807439] [110/133] (565s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[467.907300] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[467.909664] Starting dynamic subtest: pipe-A
[468.018306] Dynamic subtest pipe-A: SKIP (0.108s)
[468.029731] Starting dynamic subtest: pipe-B
[469.185524] Dynamic subtest pipe-B: SKIP (1.164s)
[469.203059] Starting dynamic subtest: pipe-C
[470.385217] Dynamic subtest pipe-C: SUCCESS (1.206s)
[470.399617] Starting dynamic subtest: pipe-D
[471.576434] Dynamic subtest pipe-D: SUCCESS (1.189s)
[471.578836] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.672s)
[472.752445] [111/133] (561s left) fbdev (pan)
[472.792244] Starting subtest: pan
[472.822761] Subtest pan: SUCCESS (0.033s)
[472.894189] [112/133] (560s left) gem_exec_capture (pi)
[472.949191] Starting subtest: pi
[472.951557] Starting dynamic subtest: rcs0
[477.100756] Dynamic subtest rcs0: SUCCESS (4.153s)
[477.112571] Starting dynamic subtest: bcs0
[481.037327] Dynamic subtest bcs0: SUCCESS (3.935s)
[481.048256] Starting dynamic subtest: vcs0
[485.005695] Dynamic subtest vcs0: SUCCESS (3.967s)
[485.019654] Starting dynamic subtest: vcs1
[488.982373] Dynamic subtest vcs1: SUCCESS (3.976s)
[488.995169] Starting dynamic subtest: vecs0
[493.002964] Dynamic subtest vecs0: SUCCESS (4.020s)
[493.016894] Starting dynamic subtest: ccs0
[497.062777] Dynamic subtest ccs0: SUCCESS (4.058s)
[497.065257] Subtest pi: SUCCESS (24.116s)
[497.149896] [113/133] (536s left) i915_query (query-regions-garbage-items)
[497.249317] Starting subtest: query-regions-garbage-items
[497.251254] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[497.343539] [114/133] (536s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[497.446194] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[497.450141] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[497.522746] [115/133] (536s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[497.620363] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[497.624800] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[497.722780] [116/133] (536s left) gem_userptr_blits (sd-probe)
[497.782938] Starting subtest: sd-probe
[497.784845] Subtest sd-probe: SUCCESS (0.000s)
[497.892420] [117/133] (536s left) i915_drm_fdinfo (busy-check-all)
[497.931668] Starting subtest: busy-check-all
[497.933964] Starting dynamic subtest: rcs0
[497.938584] Dynamic subtest rcs0: SKIP (0.004s)
[497.950911] Starting dynamic subtest: bcs0
[497.955043] Dynamic subtest bcs0: SKIP (0.000s)
[497.965505] Starting dynamic subtest: vcs0
[497.969828] Dynamic subtest vcs0: SKIP (0.000s)
[497.980160] Starting dynamic subtest: vcs1
[497.984368] Dynamic subtest vcs1: SKIP (0.000s)
[497.994668] Starting dynamic subtest: vecs0
[497.998954] Dynamic subtest vecs0: SKIP (0.000s)
[498.009256] Starting dynamic subtest: ccs0
[498.012790] Dynamic subtest ccs0: SKIP (0.000s)
[498.016321] Subtest busy-check-all: SKIP (0.010s)
[498.054497] [118/133] (536s left) syncobj_timeline (wait-zero-handles)
[498.130753] Starting subtest: wait-zero-handles
[498.132778] Subtest wait-zero-handles: SUCCESS (0.000s)
[498.207023] [119/133] (535s left) syncobj_basic (bad-create-flags)
[498.263925] Starting subtest: bad-create-flags
[498.265564] Subtest bad-create-flags: SUCCESS (0.000s)
[498.390403] [120/133] (535s left) perf_pmu (busy-start)
[498.435259] Starting subtest: busy-start
[498.437180] Starting dynamic subtest: rcs0
[500.989951] Dynamic subtest rcs0: SUCCESS (2.553s)
[501.003887] Starting dynamic subtest: bcs0
[503.561338] Dynamic subtest bcs0: SUCCESS (2.547s)
[503.574035] Starting dynamic subtest: vcs0
[507.362522] Dynamic subtest vcs0: SUCCESS (3.820s)
[507.374630] Starting dynamic subtest: vcs1
[511.329943] Dynamic subtest vcs1: SUCCESS (3.965s)
[511.343051] Starting dynamic subtest: vecs0
[515.298956] Dynamic subtest vecs0: SUCCESS (3.966s)
[515.312718] Starting dynamic subtest: ccs0
[517.872082] Dynamic subtest ccs0: SUCCESS (2.552s)
[517.874592] Subtest busy-start: SUCCESS (19.417s)
[517.953193] [121/133] (516s left) gem_ctx_persistence (processes)
[518.024492] Starting subtest: processes
[519.271526] Subtest processes: SUCCESS (1.247s)
[519.369872] [122/133] (514s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[519.481493] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[519.485995] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[519.583174] [123/133] (514s left) gen3_mixed_blits
[519.700754] [124/133] (514s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[519.786333] Starting subtest: async-flip-with-page-flip-events-tiled
[520.167343] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[522.973480] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.804s)
[522.986622] Starting dynamic subtest: pipe-A-eDP-1-4
[525.200885] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.173s)
[525.213807] Starting dynamic subtest: pipe-A-eDP-1-4
[527.158111] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[527.171532] Starting dynamic subtest: pipe-A-eDP-1-x
[529.388445] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.176s)
[529.709270] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[532.530368] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.778s)
[532.547275] Starting dynamic subtest: pipe-B-eDP-1-4
[534.716294] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.184s)
[534.730727] Starting dynamic subtest: pipe-B-eDP-1-4
[536.675079] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[536.689128] Starting dynamic subtest: pipe-B-eDP-1-x
[538.915713] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[539.231386] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[542.027481] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.754s)
[542.039395] Starting dynamic subtest: pipe-C-eDP-1-4
[544.202882] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s)
[544.216599] Starting dynamic subtest: pipe-C-eDP-1-4
[546.160079] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[546.171040] Starting dynamic subtest: pipe-C-eDP-1-x
[548.391672] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s)
[548.706262] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[551.476518] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.779s)
[551.489341] Starting dynamic subtest: pipe-D-eDP-1-4
[553.702914] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.172s)
[553.717014] Starting dynamic subtest: pipe-D-eDP-1-4
[555.659533] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[555.670635] Starting dynamic subtest: pipe-D-eDP-1-x
[557.849916] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.188s)
[557.852828] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.065s)
[559.032491] [125/133] (475s left) gem_exec_whisper (basic-contexts)
[559.104968] Starting subtest: basic-contexts
[565.917801] Subtest basic-contexts: SUCCESS (6.811s)
[566.105030] [126/133] (468s left) kms_cursor_crc (cursor-random-512x170)
[566.431082] Starting subtest: cursor-random-512x170
[566.435598] Subtest cursor-random-512x170: SKIP (0.001s)
[566.575513] [127/133] (467s left) kms_color_pipeline (plane-ctm3x4)
[566.663342] Starting subtest: plane-ctm3x4
[566.786553] Starting dynamic subtest: pipe-A-plane-0
[566.931040] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s)
[566.942645] Starting dynamic subtest: pipe-A-plane-1
[567.097209] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s)
[567.112941] Starting dynamic subtest: pipe-A-plane-2
[567.208463] Dynamic subtest pipe-A-plane-2: SUCCESS (0.110s)
[568.391254] Starting dynamic subtest: pipe-B-plane-0
[568.526413] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s)
[568.537964] Starting dynamic subtest: pipe-B-plane-1
[568.681971] Dynamic subtest pipe-B-plane-1: SUCCESS (0.155s)
[568.693057] Starting dynamic subtest: pipe-B-plane-2
[568.804148] Dynamic subtest pipe-B-plane-2: SUCCESS (0.121s)
[569.989713] Starting dynamic subtest: pipe-C-plane-0
[570.091716] Dynamic subtest pipe-C-plane-0: SUCCESS (0.111s)
[570.102790] Starting dynamic subtest: pipe-C-plane-1
[570.214086] Dynamic subtest pipe-C-plane-1: SUCCESS (0.121s)
[570.227326] Starting dynamic subtest: pipe-C-plane-2
[570.325220] Dynamic subtest pipe-C-plane-2: SUCCESS (0.110s)
[571.512677] Starting dynamic subtest: pipe-D-plane-0
[571.614100] Dynamic subtest pipe-D-plane-0: SUCCESS (0.111s)
[571.625141] Starting dynamic subtest: pipe-D-plane-1
[571.725097] Dynamic subtest pipe-D-plane-1: SUCCESS (0.110s)
[571.735834] Starting dynamic subtest: pipe-D-plane-2
[571.836279] Dynamic subtest pipe-D-plane-2: SUCCESS (0.110s)
[572.120757] Subtest plane-ctm3x4: SUCCESS (5.459s)
[572.938729] [128/133] (461s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[573.031683] Starting subtest: fbcpsr-1p-rte
[579.976908] Subtest fbcpsr-1p-rte: SUCCESS (6.950s)
[580.140007] [129/133] (454s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[580.259458] Starting subtest: basic-flip-before-cursor-legacy
[581.202049] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.942s)
[582.029253] [130/133] (452s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[582.127046] Starting subtest: plane-upscale-factor-0-25-with-rotation
[582.129317] Starting dynamic subtest: pipe-A
[582.351359] Dynamic subtest pipe-A: SUCCESS (0.226s)
[582.362805] Starting dynamic subtest: pipe-B
[583.675010] Dynamic subtest pipe-B: SUCCESS (1.322s)
[583.690766] Starting dynamic subtest: pipe-C
[584.975339] Dynamic subtest pipe-C: SUCCESS (1.299s)
[584.986679] Starting dynamic subtest: pipe-D
[586.278087] Dynamic subtest pipe-D: SUCCESS (1.301s)
[586.280346] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.154s)
[587.430688] [131/133] (447s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[587.555411] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[619.378275] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.821s)
[620.234025] [132/133] (414s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[620.332302] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[620.336318] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[620.454749] [133/133] (414s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[622.490973] Starting subtest: dpms-mode-unset-lpsp
[626.524553] Subtest dpms-mode-unset-lpsp: SUCCESS (4.034s)
[626.906955] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_mmap_gtt
results: parsing output: 2/ for test: kms_flip
results: parsing output: 3/ for test: syncobj_wait
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_pipe_crc_basic
results: parsing output: 6/ for test: kms_dp_link_training
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: gem_ctx_isolation
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_rotation_crc
results: parsing output: 11/ for test: kms_psr
results: parsing output: 12/ for test: core_setmaster
results: parsing output: 13/ for test: gem_eio
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: gem_ppgtt
results: parsing output: 17/ for test: kms_getfb
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_properties
results: parsing output: 21/ for test: kms_flip_scaled_crc
results: parsing output: 22/ for test: gem_exec_reloc
results: parsing output: 23/ for test: i915_query
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: gem_exec_fence
results: parsing output: 26/ for test: gem_mmap_wc
results: parsing output: 27/ for test: kms_cursor_edge_walk
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: kms_psr
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_big_fb
results: parsing output: 34/ for test: prime_vgem
results: parsing output: 35/ for test: gem_mmap_offset
results: parsing output: 36/ for test: kms_psr2_sf
results: parsing output: 37/ for test: kms_hdr
results: parsing output: 38/ for test: gem_render_copy
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: kms_pm_rpm
results: parsing output: 41/ for test: gem_exec_schedule
results: parsing output: 42/ for test: kms_pipe_crc_basic
results: parsing output: 43/ for test: gem_exec_schedule
results: parsing output: 44/ for test: gem_huc_copy
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: kms_content_protection
results: parsing output: 47/ for test: core_getclient
results: parsing output: 48/ for test: gem_mmap
results: parsing output: 49/ for test: perf_pmu
results: parsing output: 50/ for test: gem_partial_pwrite_pread
results: parsing output: 51/ for test: gem_ctx_sseu
results: parsing output: 52/ for test: kms_plane_multiple
results: parsing output: 53/ for test: gem_fenced_exec_thrash
results: parsing output: 54/ for test: i915_pm_rpm
results: parsing output: 55/ for test: kms_async_flips
results: parsing output: 56/ for test: kms_cursor_crc
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: gem_exec_await
results: parsing output: 59/ for test: kms_flip
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: kms_plane
results: parsing output: 62/ for test: gem_exec_balancer
results: parsing output: 63/ for test: kms_chamelium_hpd
results: parsing output: 64/ for test: gem_exec_reloc
results: parsing output: 65/ for test: kms_hdmi_inject
results: parsing output: 66/ for test: syncobj_timeline
results: parsing output: 67/ for test: kms_flip
results: parsing output: 68/ for test: kms_lease
results: parsing output: 69/ for test: kms_ccs
results: parsing output: 70/ for test: gem_render_copy
results: parsing output: 71/ for test: gem_ctx_engines
results: parsing output: 72/ for test: gem_exec_params
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: sw_sync
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: gem_eio
results: parsing output: 77/ for test: gem_partial_pwrite_pread
results: parsing output: 78/ for test: kms_feature_discovery
results: parsing output: 79/ for test: perf
results: parsing output: 80/ for test: gem_exec_fence
results: parsing output: 81/ for test: kms_psr2_sf
results: parsing output: 82/ for test: kms_cursor_legacy
results: parsing output: 83/ for test: kms_flip
results: parsing output: 84/ for test: kms_vblank
results: parsing output: 85/ for test: kms_ccs
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: syncobj_eventfd
results: parsing output: 88/ for test: kms_pwrite_crc
results: parsing output: 89/ for test: gem_sync
results: parsing output: 90/ for test: kms_universal_plane
results: parsing output: 91/ for test: gem_spin_batch
results: parsing output: 92/ for test: kms_rotation_crc
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: api_intel_allocator
results: parsing output: 95/ for test: kms_chamelium_frames
results: parsing output: 96/ for test: kms_chamelium_audio
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: gen7_exec_parse
results: parsing output: 99/ for test: gem_mmap_wc
results: parsing output: 100/ for test: gem_madvise
results: parsing output: 101/ for test: i915_module_load
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: gem_eio
results: parsing output: 104/ for test: kms_cursor_legacy
results: parsing output: 105/ for test: gem_exec_reloc
results: parsing output: 106/ for test: kms_psr2_sf
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: kms_plane_scaling
results: parsing output: 110/ for test: fbdev
results: parsing output: 111/ for test: gem_exec_capture
results: parsing output: 112/ for test: i915_query
results: parsing output: 113/ for test: kms_flip_scaled_crc
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: gem_userptr_blits
results: parsing output: 116/ for test: i915_drm_fdinfo
results: parsing output: 117/ for test: syncobj_timeline
results: parsing output: 118/ for test: syncobj_basic
results: parsing output: 119/ for test: perf_pmu
results: parsing output: 120/ for test: gem_ctx_persistence
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: gen3_mixed_blits
results: parsing output: 123/ for test: kms_async_flips
results: parsing output: 124/ for test: gem_exec_whisper
results: parsing output: 125/ for test: kms_cursor_crc
results: parsing output: 126/ for test: kms_color_pipeline
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_cursor_legacy
results: parsing output: 129/ for test: kms_plane_scaling
results: parsing output: 130/ for test: kms_cursor_legacy
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_pm_rpm
Done.