[57.897350] Initializing watchdogs
[57.897400]   /dev/watchdog0
[57.911974] [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.916885] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.919185] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.922992] [001/133] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[58.058077] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[58.062189] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[58.165463] [002/133] (960s left) gem_mmap_gtt (fault-concurrent-x)
[58.216977] Subtest fault-concurrent-X: SKIP (0.000s)
[58.271812] [003/133] (960s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[58.367075] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[58.379909] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.011s)
[58.454349] [004/133] (960s left) syncobj_wait (wait-any-snapshot)
[58.509975] Starting subtest: wait-any-snapshot
[58.590909] Subtest wait-any-snapshot: SUCCESS (0.082s)
[58.660866] [005/133] (959s left) kms_frontbuffer_tracking (psr-1p-rte)
[58.763169] Starting subtest: psr-1p-rte
[64.424813] Subtest psr-1p-rte: SUCCESS (5.669s)
[64.592696] [006/133] (954s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[64.691046] Starting subtest: disable-crc-after-crtc
[64.693039] Starting dynamic subtest: pipe-A-eDP-1
[66.361034] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.670s)
[66.372351] Starting dynamic subtest: pipe-B-eDP-1
[68.728366] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.364s)
[68.736862] Starting dynamic subtest: pipe-C-eDP-1
[70.992317] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.263s)
[71.002498] Starting dynamic subtest: pipe-D-eDP-1
[73.261633] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.267s)
[73.263897] Subtest disable-crc-after-crtc: SUCCESS (8.569s)
[74.074644] [007/133] (944s left) kms_dp_link_training (uhbr-sst)
[74.170706] Starting subtest: uhbr-sst
[74.179071] Subtest uhbr-sst: SKIP (0.000s)
[74.241342] [008/133] (944s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[74.289045] Starting subtest: invalid-single-wait-all-unsubmitted
[74.291330] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[74.370393] [009/133] (944s left) gem_ctx_isolation (preservation)
[74.435774] Starting subtest: preservation
[74.438141] Starting dynamic subtest: rcs0
[74.550780] Dynamic subtest rcs0: SUCCESS (0.114s)
[74.561743] Starting dynamic subtest: bcs0
[74.697475] Dynamic subtest bcs0: SUCCESS (0.147s)
[74.708710] Starting dynamic subtest: vcs0
[74.864824] Dynamic subtest vcs0: SUCCESS (0.165s)
[74.875901] Starting dynamic subtest: vcs1
[76.405896] Dynamic subtest vcs1: SUCCESS (1.540s)
[76.418076] Starting dynamic subtest: vecs0
[78.402752] Dynamic subtest vecs0: SUCCESS (1.997s)
[78.415073] Starting dynamic subtest: ccs0
[80.395714] Dynamic subtest ccs0: SUCCESS (1.993s)
[80.398371] Subtest preservation: SUCCESS (5.958s)
[80.638863] [010/133] (938s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[80.743739] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[80.748073] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[80.837459] [011/133] (937s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[80.931826] Starting subtest: primary-y-tiled-reflect-x-270
[80.936242] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[81.006691] [012/133] (937s left) kms_psr (fbc-psr-no-drrs)
[81.102046] Starting subtest: fbc-psr-no-drrs
[81.104453] Starting dynamic subtest: eDP-1
[81.108976] Dynamic subtest eDP-1: SKIP (0.000s)
[81.113499] Subtest fbc-psr-no-drrs: SKIP (0.000s)
[81.171548] [013/133] (937s left) core_setmaster (master-drop-set-user)
[81.247210] Starting subtest: master-drop-set-user
[81.261711] Subtest master-drop-set-user: SUCCESS (0.014s)
[81.297784] [014/133] (937s left) gem_eio (wait-1us)
[81.493744] Starting subtest: wait-1us
[81.784071] Subtest wait-1us: SUCCESS (0.292s)
[81.928442] [015/133] (937s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[82.024241] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[82.026333] Starting dynamic subtest: pipe-A-eDP-1
[82.044155] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[82.055252] Starting dynamic subtest: pipe-B-eDP-1
[82.071842] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[82.080288] Starting dynamic subtest: pipe-C-eDP-1
[82.096430] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[82.104543] Starting dynamic subtest: pipe-D-eDP-1
[82.120837] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[82.122467] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[84.337318] [016/133] (934s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[84.444281] Starting subtest: y-tiled-16bpp-rotate-90
[84.448263] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[84.532218] [017/133] (934s left) gem_ppgtt (shrink-vs-evict-pinned)
[84.590292] Starting subtest: shrink-vs-evict-pinned
[90.265593] Subtest shrink-vs-evict-pinned: SUCCESS (5.673s)
[90.361329] [018/133] (928s left) kms_getfb (getfb-reject-nv12)
[90.465813] Starting subtest: getfb-reject-nv12
[90.468109] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[90.563896] [019/133] (928s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[90.675103] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[98.370027] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.699s)
[98.469828] [020/133] (920s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[98.566634] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[98.571208] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[98.662046] [021/133] (920s left) kms_properties (plane-properties-legacy)
[98.754740] Starting subtest: plane-properties-legacy
[98.756663] Starting dynamic subtest: pipe-A-eDP-1
[99.329547] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.574s)
[99.338977] Starting dynamic subtest: pipe-B-eDP-1
[100.635182] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.304s)
[100.644719] Starting dynamic subtest: pipe-C-eDP-1
[101.874230] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.239s)
[101.887295] Starting dynamic subtest: pipe-D-eDP-1
[103.118700] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.244s)
[103.121204] Subtest plane-properties-legacy: SUCCESS (4.364s)
[103.906314] [022/133] (915s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[104.002601] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[104.007075] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s)
[104.071241] [023/133] (915s left) gem_exec_reloc (basic-cpu-noreloc)
[104.137152] Subtest basic-cpu-noreloc: SKIP (0.000s)
[104.203799] [024/133] (915s left) i915_query (query-topology-coherent-slice-mask)
[104.260279] Starting subtest: query-topology-coherent-slice-mask
[104.264440] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[104.377758] [025/133] (914s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[104.436098] Starting subtest: multi-wait-available-submitted-signaled
[104.438363] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.001s)
[104.552364] [026/133] (914s left) gem_exec_fence (syncobj-unused-fence)
[104.994871] Starting subtest: syncobj-unused-fence
[104.999418] Subtest syncobj-unused-fence: SUCCESS (0.005s)
[106.412223] [FACT gem_exec_fence (syncobj-unused-fence)] new: kernel.kmod_is_loaded.vgem: true
[106.415978] [027/133] (913s left) gem_mmap_wc (write-read-distinct)
[106.477265] Subtest write-read-distinct: SKIP (0.000s)
[106.537281] [028/133] (912s left) kms_cursor_edge_walk (128x128-top-bottom)
[106.632117] Starting subtest: 128x128-top-bottom
[106.634457] Starting dynamic subtest: pipe-A-eDP-1
[110.075793] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.444s)
[110.086918] Starting dynamic subtest: pipe-D-eDP-1
[113.177129] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.100s)
[113.179549] Subtest 128x128-top-bottom: SUCCESS (6.545s)
[114.000864] [029/133] (905s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[114.089074] Starting subtest: fbc-psr2-primary-mmap-cpu
[114.091395] Starting dynamic subtest: eDP-1
[114.095900] Dynamic subtest eDP-1: SKIP (0.000s)
[114.100377] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[114.159917] [030/133] (905s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[114.251242] Starting subtest: x-tiled-32bpp-rotate-270
[114.270817] Subtest x-tiled-32bpp-rotate-270: SKIP (0.019s)
[114.387954] [031/133] (905s left) kms_psr (pr-cursor-mmap-cpu)
[114.481535] Starting subtest: pr-cursor-mmap-cpu
[114.485671] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[114.553243] [032/133] (905s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[114.646703] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[114.650876] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[114.730793] [033/133] (904s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[114.830777] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[114.834973] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[114.935096] [034/133] (904s left) kms_big_fb (yf-tiled-addfb)
[115.034986] Starting subtest: yf-tiled-addfb
[115.038828] Subtest yf-tiled-addfb: SKIP (0.000s)
[115.128025] [035/133] (904s left) prime_vgem (wait)
[115.196129] Starting subtest: wait
[115.198256] Starting dynamic subtest: rcs0
[115.232552] Dynamic subtest rcs0: SUCCESS (0.036s)
[115.241119] Starting dynamic subtest: bcs0
[115.277065] Dynamic subtest bcs0: SUCCESS (0.044s)
[115.285883] Starting dynamic subtest: vcs0
[115.324187] Dynamic subtest vcs0: SUCCESS (0.047s)
[115.332822] Starting dynamic subtest: vcs1
[115.368711] Dynamic subtest vcs1: SUCCESS (0.044s)
[115.377681] Starting dynamic subtest: vecs0
[115.415590] Dynamic subtest vecs0: SUCCESS (0.046s)
[115.424642] Starting dynamic subtest: ccs0
[115.462914] Dynamic subtest ccs0: SUCCESS (0.047s)
[115.464986] Subtest wait: SUCCESS (0.267s)
[115.576563] [036/133] (904s left) gem_mmap_offset (partial-remap)
[115.623264] Starting subtest: partial-remap
[115.624944] Starting dynamic subtest: smem0
[115.632588] Dynamic subtest smem0: SUCCESS (0.004s)
[115.634473] Subtest partial-remap: SUCCESS (0.004s)
[115.746147] [037/133] (904s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[115.844594] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[115.846522] Starting dynamic subtest: pipe-A-eDP-1
[121.689942] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.846s)
[121.700726] Starting dynamic subtest: pipe-B-eDP-1
[128.340776] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.649s)
[128.343073] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.498s)
[129.209131] [038/133] (890s left) kms_hdr (static-toggle-suspend)
[129.298707] Starting subtest: static-toggle-suspend
[129.305309] Subtest static-toggle-suspend: SKIP (0.000s)
[129.369036] [039/133] (890s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[129.431352] Starting subtest: yf-tiled-to-vebox-yf-tiled
[129.435934] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[129.630218] [040/133] (890s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[129.724564] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[129.726866] Starting dynamic subtest: pipe-A-eDP-1
[129.750692] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[129.761138] Starting dynamic subtest: pipe-B-eDP-1
[129.782729] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[129.791475] Starting dynamic subtest: pipe-C-eDP-1
[129.813147] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[129.821392] Starting dynamic subtest: pipe-D-eDP-1
[129.843239] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[129.847615] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[131.980850] [041/133] (888s left) kms_pm_rpm (pc8-residency)
[133.513339] Starting subtest: pc8-residency
[133.518643] Subtest pc8-residency: SKIP (0.000s)
[134.250921] [042/133] (885s left) gem_exec_schedule (preemptive-hang)
[134.424938] Starting subtest: preemptive-hang
[134.427715] Starting dynamic subtest: rcs0
[143.404956] Dynamic subtest rcs0: SUCCESS (8.981s)
[143.415820] Starting dynamic subtest: bcs0
[152.430222] Dynamic subtest bcs0: SUCCESS (9.021s)
[152.440480] Starting dynamic subtest: vcs0
[161.388970] Dynamic subtest vcs0: SUCCESS (8.956s)
[161.399680] Starting dynamic subtest: vcs1
[170.405900] Dynamic subtest vcs1: SUCCESS (9.020s)
[170.417787] Starting dynamic subtest: vecs0
[179.430686] Dynamic subtest vecs0: SUCCESS (9.025s)
[179.441386] Starting dynamic subtest: ccs0
[188.399449] Dynamic subtest ccs0: SUCCESS (8.965s)
[188.401502] Subtest preemptive-hang: SUCCESS (53.974s)
[188.653699] [043/133] (831s left) kms_pipe_crc_basic (bad-source)
[188.748147] Starting subtest: bad-source
[188.750509] Subtest bad-source: SUCCESS (0.000s)
[188.843964] [044/133] (831s left) gem_exec_schedule (preempt-user)
[188.913579] Starting subtest: preempt-user
[188.915523] Starting dynamic subtest: rcs0
[188.933326] Dynamic subtest rcs0: SUCCESS (0.029s)
[188.946382] Starting dynamic subtest: bcs0
[188.961539] Dynamic subtest bcs0: SUCCESS (0.027s)
[188.971881] Starting dynamic subtest: vcs0
[188.981102] Dynamic subtest vcs0: SUCCESS (0.019s)
[188.991900] Starting dynamic subtest: vcs1
[189.001575] Dynamic subtest vcs1: SUCCESS (0.020s)
[189.010774] Starting dynamic subtest: vecs0
[189.025493] Dynamic subtest vecs0: SUCCESS (0.023s)
[189.035879] Starting dynamic subtest: ccs0
[189.047230] Dynamic subtest ccs0: SUCCESS (0.021s)
[189.049507] Subtest preempt-user: SUCCESS (0.143s)
[190.354817] [045/133] (829s left) gem_huc_copy (huc-copy)
[190.427346] Starting subtest: huc-copy
[190.432459] Subtest huc-copy: SUCCESS (0.004s)
[190.568980] [046/133] (829s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[190.675542] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[191.766584] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.091s)
[191.906975] [047/133] (828s left) kms_content_protection (dp-mst-lic-type-1)
[192.037562] Starting subtest: dp-mst-lic-type-1
[192.041319] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[192.161099] [048/133] (828s left) core_getclient (basic)
[192.217207] Starting subtest: basic
[192.219227] Subtest basic: SUCCESS (0.000s)
[192.307078] [049/133] (828s left) gem_mmap (short-mmap)
[192.354801] Subtest short-mmap: SKIP (0.000s)
[192.407163] [050/133] (828s left) perf_pmu (busy-check-all)
[192.444243] Starting subtest: busy-check-all
[192.446061] Starting dynamic subtest: rcs0
[193.020557] Dynamic subtest rcs0: SUCCESS (0.576s)
[193.033761] Starting dynamic subtest: bcs0
[193.571872] Dynamic subtest bcs0: SUCCESS (0.549s)
[193.584699] Starting dynamic subtest: vcs0
[195.328969] Dynamic subtest vcs0: SUCCESS (1.754s)
[195.342658] Starting dynamic subtest: vcs1
[197.313232] Dynamic subtest vcs1: SUCCESS (1.981s)
[197.326774] Starting dynamic subtest: vecs0
[199.296786] Dynamic subtest vecs0: SUCCESS (1.981s)
[199.310825] Starting dynamic subtest: ccs0
[199.852219] Dynamic subtest ccs0: SUCCESS (0.555s)
[199.854762] Subtest busy-check-all: SUCCESS (7.409s)
[199.988650] [051/133] (820s left) gem_partial_pwrite_pread (write-display)
[200.048217] Subtest write-display: SKIP (0.000s)
[200.118662] [052/133] (820s left) gem_ctx_sseu (invalid-sseu)
[200.181895] Subtest invalid-sseu: SKIP (0.000s)
[200.257046] [053/133] (820s left) kms_plane_multiple (tiling-none)
[200.352907] Starting subtest: tiling-none
[200.355316] Starting dynamic subtest: pipe-A-eDP-1
[204.026686] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.673s)
[204.040885] Starting dynamic subtest: pipe-B-eDP-1
[208.446804] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.418s)
[208.457880] Starting dynamic subtest: pipe-C-eDP-1
[212.774750] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.327s)
[212.785173] Starting dynamic subtest: pipe-D-eDP-1
[217.106867] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.330s)
[217.109307] Subtest tiling-none: SUCCESS (16.753s)
[217.921767] [054/133] (802s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[217.989402] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[218.067156] [055/133] (802s left) i915_pm_rpm (system-suspend-devices)
[219.592612] Starting subtest: system-suspend-devices
[227.380573] Subtest system-suspend-devices: SUCCESS (7.791s)
[227.784255] [056/133] (792s left) kms_async_flips (test-time-stamp-atomic)
[227.913032] Starting subtest: test-time-stamp-atomic
[228.298533] Starting dynamic subtest: pipe-A-eDP-1
[229.066114] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.765s)
[229.462995] Starting dynamic subtest: pipe-B-eDP-1
[230.216128] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.759s)
[230.594067] Starting dynamic subtest: pipe-C-eDP-1
[231.353286] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.765s)
[231.722255] Starting dynamic subtest: pipe-D-eDP-1
[232.479676] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.767s)
[232.482170] Subtest test-time-stamp-atomic: SUCCESS (4.566s)
[233.638643] [057/133] (787s left) kms_cursor_crc (cursor-offscreen-256x256)
[233.878957] Starting subtest: cursor-offscreen-256x256
[233.881206] Starting dynamic subtest: pipe-A-eDP-1
[235.849962] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.968s)
[235.881358] Starting dynamic subtest: pipe-D-eDP-1
[238.474400] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.600s)
[238.476768] Subtest cursor-offscreen-256x256: SUCCESS (4.596s)
[239.305938] [058/133] (781s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[239.395881] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[239.400334] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[239.527533] [059/133] (781s left) gem_exec_await (wide-contexts)
[239.731900] Starting subtest: wide-contexts
[263.137484] Subtest wide-contexts: SUCCESS (23.402s)
[263.339535] [060/133] (757s left) kms_flip (nonexisting-fb-interruptible)
[263.489112] Starting subtest: nonexisting-fb-interruptible
[263.491421] Starting dynamic subtest: A-eDP1
[264.690339] Dynamic subtest A-eDP1: SUCCESS (1.200s)
[264.704507] Starting dynamic subtest: B-eDP1
[265.816223] Dynamic subtest B-eDP1: SUCCESS (1.123s)
[265.830194] Starting dynamic subtest: C-eDP1
[266.935860] Dynamic subtest C-eDP1: SUCCESS (1.118s)
[266.947130] Starting dynamic subtest: D-eDP1
[268.065319] Dynamic subtest D-eDP1: SUCCESS (1.129s)
[268.071224] Subtest nonexisting-fb-interruptible: SUCCESS (4.580s)
[269.240493] [061/133] (751s left) kms_psr (psr2-no-drrs)
[269.340164] Starting subtest: psr2-no-drrs
[269.342497] Starting dynamic subtest: eDP-1
[270.920189] Dynamic subtest eDP-1: SUCCESS (1.580s)
[270.923296] Subtest psr2-no-drrs: SUCCESS (1.582s)
[271.725205] [062/133] (749s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping)
[271.831169] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping
[271.857781] Starting dynamic subtest: pipe-A-plane-0
[272.146438] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[272.157858] Starting dynamic subtest: pipe-A-plane-3
[272.379739] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s)
[273.513758] Starting dynamic subtest: pipe-B-plane-0
[273.801175] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[273.812084] Starting dynamic subtest: pipe-B-plane-3
[274.046233] Dynamic subtest pipe-B-plane-3: SUCCESS (0.244s)
[274.358657] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.527s)
[275.186447] [063/133] (745s left) gem_exec_balancer (bonded-true-hang)
[275.458897] Starting subtest: bonded-true-hang
[275.464078] Subtest bonded-true-hang: SKIP (0.000s)
[275.591386] [064/133] (745s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[275.982089] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[276.785546] [065/133] (744s left) gem_exec_reloc (basic-write-cpu-noreloc)
[276.847738] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[276.924057] [066/133] (744s left) kms_hdmi_inject (inject-4k)
[277.282543] Starting subtest: inject-4k
[277.606512] Subtest inject-4k: SUCCESS (0.325s)
[278.175617] [067/133] (743s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[278.234448] Starting subtest: etime-single-wait-all-for-submit-submitted
[278.341248] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.107s)
[278.432740] [068/133] (742s left) kms_flip (flip-vs-modeset-vs-hang)
[278.531021] Starting subtest: flip-vs-modeset-vs-hang
[278.533344] Starting dynamic subtest: A-eDP1
[329.757427] Dynamic subtest A-eDP1: SUCCESS (51.225s)
[329.769588] Starting dynamic subtest: D-eDP1
[378.779669] Dynamic subtest D-eDP1: SUCCESS (49.017s)
[378.782098] Subtest flip-vs-modeset-vs-hang: SUCCESS (100.250s)
[379.171735] [069/133] (642s left) kms_lease (master-vs-lease)
[379.258940] Starting subtest: master-vs-lease
[379.264156] Subtest master-vs-lease: SUCCESS (0.003s)
[379.393328] [070/133] (641s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[379.492944] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[379.495292] Starting dynamic subtest: pipe-A-eDP-1
[380.049532] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.527s)
[380.060686] Starting dynamic subtest: pipe-B-eDP-1
[381.583923] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.533s)
[381.597092] Starting dynamic subtest: pipe-C-eDP-1
[383.031162] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.446s)
[383.044969] Starting dynamic subtest: pipe-D-eDP-1
[384.435968] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.405s)
[384.438319] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.916s)
[385.633495] [071/133] (635s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[385.696103] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[385.700522] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[385.895088] [072/133] (635s left) gem_ctx_engines (invalid-engines)
[385.952013] Starting subtest: invalid-engines
[385.959926] Subtest invalid-engines: SUCCESS (0.008s)
[386.180762] [073/133] (635s left) gem_exec_params (dr4-dirt)
[386.244734] Starting subtest: DR4-dirt
[386.247280] Subtest DR4-dirt: SUCCESS (0.000s)
[386.342926] [074/133] (635s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[386.427990] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[386.432167] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[386.536978] [075/133] (635s left) sw_sync (sync_multi_producer_single_consumer)
[386.576390] Starting subtest: sync_multi_producer_single_consumer
[387.649731] Subtest sync_multi_producer_single_consumer: SUCCESS (1.076s)
[387.712560] [076/133] (633s left) syncobj_timeline (wait-all-for-submit-complex)
[387.761536] Starting subtest: wait-all-for-submit-complex
[387.974887] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[388.051640] [077/133] (633s left) gem_eio (execbuf)
[388.252915] Starting subtest: execbuf
[388.550973] Subtest execbuf: SUCCESS (0.297s)
[388.679277] [078/133] (633s left) gem_partial_pwrite_pread (writes-after-reads)
[388.743535] Subtest writes-after-reads: SKIP (0.000s)
[388.818493] [079/133] (632s left) kms_feature_discovery (dp-mst)
[388.906809] Starting subtest: dp-mst
[388.911320] Subtest dp-mst: SKIP (0.000s)
[388.997305] [080/133] (632s left) perf (low-oa-exponent-permissions)
[389.142998] Starting subtest: low-oa-exponent-permissions
[389.180795] Subtest low-oa-exponent-permissions: SUCCESS (0.038s)
[389.233184] [081/133] (632s left) gem_exec_fence (syncobj-import)
[389.648141] Starting subtest: syncobj-import
[389.653443] Subtest syncobj-import: SUCCESS (0.005s)
[391.377068] [082/133] (630s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[391.486029] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[391.488422] Starting dynamic subtest: pipe-A-eDP-1
[391.584724] Dynamic subtest pipe-A-eDP-1: SKIP (0.101s)
[391.598602] Starting dynamic subtest: pipe-B-eDP-1
[392.773494] Dynamic subtest pipe-B-eDP-1: SKIP (1.186s)
[392.777918] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.290s)
[394.018379] [083/133] (627s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[394.141411] Starting subtest: cursorB-vs-flipB-atomic
[394.145879] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[394.288814] [084/133] (627s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[394.386321] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[394.398352] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.011s)
[394.475299] [085/133] (627s left) kms_vblank (ts-continuation-idle)
[394.560684] Starting subtest: ts-continuation-idle
[394.562909] Starting dynamic subtest: pipe-A-eDP-1
[394.963343] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.401s)
[394.979364] Starting dynamic subtest: pipe-D-eDP-1
[396.079420] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.114s)
[396.081408] Subtest ts-continuation-idle: SUCCESS (1.518s)
[396.926120] [086/133] (625s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[397.018080] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[397.022803] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[398.118148] [087/133] (623s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[398.211745] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[398.216569] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[398.307850] [088/133] (623s left) syncobj_eventfd (invalid-bad-flags)
[398.360213] Starting subtest: invalid-bad-flags
[398.362515] Subtest invalid-bad-flags: SUCCESS (0.000s)
[398.454867] [089/133] (623s left) kms_pwrite_crc (basic)
[398.544238] Starting subtest: basic
[399.251209] Subtest basic: SUCCESS (0.708s)
[400.127771] [090/133] (622s left) gem_sync (basic-store-each)
[400.206198] Starting subtest: basic-store-each
[402.715720] Subtest basic-store-each: SUCCESS (2.519s)
[402.904363] [091/133] (619s left) kms_universal_plane (universal-plane-sanity)
[402.992918] Starting subtest: universal-plane-sanity
[402.995235] Starting dynamic subtest: pipe-A-eDP-1
[403.589040] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.596s)
[403.600039] Starting dynamic subtest: pipe-B-eDP-1
[404.812341] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.222s)
[404.824645] Starting dynamic subtest: pipe-C-eDP-1
[405.990424] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.177s)
[406.001894] Starting dynamic subtest: pipe-D-eDP-1
[407.185063] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.192s)
[407.187115] Subtest universal-plane-sanity: SUCCESS (4.193s)
[408.028532] [092/133] (614s left) gem_spin_batch (legacy)
[408.092337] Starting subtest: legacy
[408.094756] Starting dynamic subtest: default
[411.330125] Dynamic subtest default: SUCCESS (3.232s)
[411.343887] Starting dynamic subtest: render
[414.566618] Dynamic subtest render: SUCCESS (3.233s)
[414.579475] Starting dynamic subtest: bsd
[417.804686] Dynamic subtest bsd: SUCCESS (3.234s)
[417.816073] Starting dynamic subtest: bsd1
[421.037427] Dynamic subtest bsd1: SUCCESS (3.230s)
[421.050679] Starting dynamic subtest: bsd2
[424.274189] Dynamic subtest bsd2: SUCCESS (3.234s)
[424.286349] Starting dynamic subtest: blt
[427.508569] Dynamic subtest blt: SUCCESS (3.231s)
[427.521678] Starting dynamic subtest: vebox
[430.750069] Dynamic subtest vebox: SUCCESS (3.238s)
[430.752368] Subtest legacy: SUCCESS (22.654s)
[431.299492] [093/133] (591s left) kms_rotation_crc (primary-rotation-90)
[431.402554] Starting subtest: primary-rotation-90
[431.406643] Subtest primary-rotation-90: SKIP (0.001s)
[431.490953] [094/133] (590s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[431.596177] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[440.271336] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.678s)
[440.398896] [095/133] (582s left) api_intel_allocator (default-alignment)
[440.456047] Starting subtest: default-alignment
[440.458355] Subtest default-alignment: SUCCESS (0.003s)
[440.580529] [096/133] (581s left) kms_chamelium_frames (hdmi-frame-dump)
[440.964451] Subtest hdmi-frame-dump: SKIP (0.000s)
[441.790188] [097/133] (580s left) kms_chamelium_audio (hdmi-audio)
[442.180603] Subtest hdmi-audio: SKIP (0.000s)
[442.996026] [098/133] (579s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[443.100822] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[443.936402] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.837s)
[444.100478] [099/133] (578s left) gen7_exec_parse (bitmasks)
[444.160622] Subtest bitmasks: SKIP (0.000s)
[444.230079] [100/133] (578s left) gem_mmap_wc (set-cache-level)
[444.291668] Subtest set-cache-level: SKIP (0.000s)
[444.351308] [101/133] (578s left) gem_madvise (dontneed-before-exec)
[444.386702] Starting subtest: dontneed-before-exec
[444.404793] Subtest dontneed-before-exec: SKIP (0.016s)
[444.468671] [102/133] (578s left) i915_module_load (resize-bar)
[444.506842] Starting subtest: resize-bar
[444.516753] Subtest resize-bar: SKIP (0.007s)
[444.557104] [103/133] (578s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[444.651157] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[444.653418] Starting dynamic subtest: pipe-A-eDP-1
[444.662414] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[444.674375] Starting dynamic subtest: pipe-B-eDP-1
[444.683307] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[444.693984] Starting dynamic subtest: pipe-C-eDP-1
[444.702656] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[444.713737] Starting dynamic subtest: pipe-D-eDP-1
[444.722213] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[444.726519] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.005s)
[446.919456] [104/133] (575s left) gem_eio (wait-immediate)
[447.124996] Starting subtest: wait-immediate
[447.495712] Subtest wait-immediate: SUCCESS (0.371s)
[447.633315] [105/133] (575s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[447.756795] Starting subtest: 2x-long-flip-vs-cursor-legacy
[447.761197] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s)
[447.905160] [106/133] (575s left) gem_exec_reloc (basic-gtt-wc-active)
[447.961223] Subtest basic-gtt-wc-active: SKIP (0.000s)
[448.044511] [107/133] (574s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[448.139354] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[448.142832] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[448.208238] [108/133] (574s left) kms_frontbuffer_tracking (fbc-tiling-4)
[448.303040] Starting subtest: fbc-tiling-4
[452.451253] Subtest fbc-tiling-4: SUCCESS (4.151s)
[453.645576] [109/133] (569s left) kms_big_fb (linear-32bpp-rotate-270)
[453.738574] Starting subtest: linear-32bpp-rotate-270
[453.758029] Subtest linear-32bpp-rotate-270: SKIP (0.019s)
[453.899248] [110/133] (569s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[453.993244] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[453.997394] Starting dynamic subtest: pipe-A
[454.111457] Dynamic subtest pipe-A: SKIP (0.119s)
[454.123100] Starting dynamic subtest: pipe-B
[455.254452] Dynamic subtest pipe-B: SKIP (1.142s)
[455.266828] Starting dynamic subtest: pipe-C
[456.453894] Dynamic subtest pipe-C: SUCCESS (1.205s)
[456.466776] Starting dynamic subtest: pipe-D
[457.653461] Dynamic subtest pipe-D: SUCCESS (1.199s)
[457.655875] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.668s)
[458.821389] [111/133] (564s left) fbdev (pan)
[458.854667] Starting subtest: pan
[458.879908] Subtest pan: SUCCESS (0.027s)
[458.952523] [112/133] (564s left) gem_exec_capture (pi)
[459.016159] Starting subtest: pi
[459.018431] Starting dynamic subtest: rcs0
[463.148847] Dynamic subtest rcs0: SUCCESS (4.132s)
[463.162284] Starting dynamic subtest: bcs0
[467.136275] Dynamic subtest bcs0: SUCCESS (3.984s)
[467.149923] Starting dynamic subtest: vcs0
[471.121053] Dynamic subtest vcs0: SUCCESS (3.984s)
[471.132806] Starting dynamic subtest: vcs1
[475.100061] Dynamic subtest vcs1: SUCCESS (3.978s)
[475.112852] Starting dynamic subtest: vecs0
[479.078707] Dynamic subtest vecs0: SUCCESS (3.977s)
[479.089901] Starting dynamic subtest: ccs0
[483.168889] Dynamic subtest ccs0: SUCCESS (4.088s)
[483.172060] Subtest pi: SUCCESS (24.153s)
[483.251775] [113/133] (539s left) i915_query (query-regions-garbage-items)
[483.351729] Starting subtest: query-regions-garbage-items
[483.353819] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[483.439608] [114/133] (539s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[483.538996] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[483.543239] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[483.630444] [115/133] (539s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[483.721376] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[483.725919] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[483.816997] [116/133] (539s left) gem_userptr_blits (sd-probe)
[483.901642] Starting subtest: sd-probe
[483.903581] Subtest sd-probe: SUCCESS (0.000s)
[484.043432] [117/133] (539s left) i915_drm_fdinfo (busy-check-all)
[484.091624] Starting subtest: busy-check-all
[484.093620] Starting dynamic subtest: rcs0
[484.099542] Dynamic subtest rcs0: SKIP (0.005s)
[484.110837] Starting dynamic subtest: bcs0
[484.114523] Dynamic subtest bcs0: SKIP (0.000s)
[484.125078] Starting dynamic subtest: vcs0
[484.128505] Dynamic subtest vcs0: SKIP (0.000s)
[484.139081] Starting dynamic subtest: vcs1
[484.142745] Dynamic subtest vcs1: SKIP (0.000s)
[484.153122] Starting dynamic subtest: vecs0
[484.156757] Dynamic subtest vecs0: SKIP (0.000s)
[484.167306] Starting dynamic subtest: ccs0
[484.170886] Dynamic subtest ccs0: SKIP (0.000s)
[484.174551] Subtest busy-check-all: SKIP (0.012s)
[484.215662] [118/133] (539s left) syncobj_timeline (wait-zero-handles)
[484.302745] Starting subtest: wait-zero-handles
[484.304839] Subtest wait-zero-handles: SUCCESS (0.000s)
[484.392040] [119/133] (539s left) syncobj_basic (bad-create-flags)
[484.443148] Starting subtest: bad-create-flags
[484.444970] Subtest bad-create-flags: SUCCESS (0.000s)
[484.560042] [120/133] (538s left) perf_pmu (busy-start)
[484.598469] Starting subtest: busy-start
[484.600454] Starting dynamic subtest: rcs0
[487.152068] Dynamic subtest rcs0: SUCCESS (2.552s)
[487.166112] Starting dynamic subtest: bcs0
[489.702299] Dynamic subtest bcs0: SUCCESS (2.547s)
[489.716930] Starting dynamic subtest: vcs0
[493.312798] Dynamic subtest vcs0: SUCCESS (3.606s)
[493.326873] Starting dynamic subtest: vcs1
[497.280870] Dynamic subtest vcs1: SUCCESS (3.966s)
[497.293093] Starting dynamic subtest: vecs0
[501.315707] Dynamic subtest vecs0: SUCCESS (4.031s)
[501.328610] Starting dynamic subtest: ccs0
[503.864285] Dynamic subtest ccs0: SUCCESS (2.547s)
[503.866792] Subtest busy-start: SUCCESS (19.266s)
[503.992431] [121/133] (519s left) gem_ctx_persistence (processes)
[504.059615] Starting subtest: processes
[505.295730] Subtest processes: SUCCESS (1.239s)
[505.381296] [122/133] (518s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[505.497396] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[505.501820] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[505.584763] [123/133] (518s left) gen3_mixed_blits
[505.702768] [124/133] (517s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[505.787592] Starting subtest: async-flip-with-page-flip-events-tiled
[506.170603] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[508.943157] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.773s)
[508.954672] Starting dynamic subtest: pipe-A-eDP-1-4
[511.117548] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.173s)
[511.129148] Starting dynamic subtest: pipe-A-eDP-1-4
[513.129401] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[513.142275] Starting dynamic subtest: pipe-A-eDP-1-x
[515.318203] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.188s)
[515.700816] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[518.451465] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.759s)
[518.464188] Starting dynamic subtest: pipe-B-eDP-1-4
[520.636190] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.183s)
[520.649665] Starting dynamic subtest: pipe-B-eDP-1-4
[522.646854] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.008s)
[522.661108] Starting dynamic subtest: pipe-B-eDP-1-x
[524.836350] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[525.207728] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[527.952738] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.755s)
[527.966977] Starting dynamic subtest: pipe-C-eDP-1-4
[530.127080] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s)
[530.141060] Starting dynamic subtest: pipe-C-eDP-1-4
[532.138050] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[532.150877] Starting dynamic subtest: pipe-C-eDP-1-x
[534.316704] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[534.685940] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[537.446513] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.770s)
[537.459674] Starting dynamic subtest: pipe-D-eDP-1-4
[539.631365] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.184s)
[539.645187] Starting dynamic subtest: pipe-D-eDP-1-4
[541.642085] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[541.656338] Starting dynamic subtest: pipe-D-eDP-1-x
[543.819819] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.177s)
[543.822115] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.033s)
[545.014313] [125/133] (478s left) gem_exec_whisper (basic-contexts)
[545.086037] Starting subtest: basic-contexts
[552.334642] Subtest basic-contexts: SUCCESS (7.246s)
[552.517314] [126/133] (471s left) kms_cursor_crc (cursor-random-512x170)
[552.826058] Starting subtest: cursor-random-512x170
[552.830202] Subtest cursor-random-512x170: SKIP (0.001s)
[552.982737] [127/133] (470s left) kms_color_pipeline (plane-ctm3x4)
[553.084934] Starting subtest: plane-ctm3x4
[553.253533] Starting dynamic subtest: pipe-A-plane-0
[553.430944] Dynamic subtest pipe-A-plane-0: SUCCESS (0.178s)
[553.442619] Starting dynamic subtest: pipe-A-plane-1
[553.575173] Dynamic subtest pipe-A-plane-1: SUCCESS (0.144s)
[553.586267] Starting dynamic subtest: pipe-A-plane-2
[553.732829] Dynamic subtest pipe-A-plane-2: SUCCESS (0.155s)
[554.928407] Starting dynamic subtest: pipe-B-plane-0
[555.060615] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s)
[555.079326] Starting dynamic subtest: pipe-B-plane-1
[555.193824] Dynamic subtest pipe-B-plane-1: SUCCESS (0.133s)
[555.205549] Starting dynamic subtest: pipe-B-plane-2
[555.349566] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s)
[556.599211] Starting dynamic subtest: pipe-C-plane-0
[556.723075] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[556.735073] Starting dynamic subtest: pipe-C-plane-1
[556.857055] Dynamic subtest pipe-C-plane-1: SUCCESS (0.133s)
[556.872516] Starting dynamic subtest: pipe-C-plane-2
[557.001050] Dynamic subtest pipe-C-plane-2: SUCCESS (0.141s)
[558.201480] Starting dynamic subtest: pipe-D-plane-0
[558.326589] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s)
[558.338067] Starting dynamic subtest: pipe-D-plane-1
[558.457720] Dynamic subtest pipe-D-plane-1: SUCCESS (0.132s)
[558.469685] Starting dynamic subtest: pipe-D-plane-2
[558.591111] Dynamic subtest pipe-D-plane-2: SUCCESS (0.132s)
[558.876664] Subtest plane-ctm3x4: SUCCESS (5.791s)
[559.707884] [128/133] (464s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[559.803206] Starting subtest: fbcpsr-1p-rte
[566.794373] Subtest fbcpsr-1p-rte: SUCCESS (6.995s)
[566.971554] [129/133] (456s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[567.097607] Starting subtest: basic-flip-before-cursor-legacy
[568.047628] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.949s)
[568.910335] [130/133] (455s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[569.002120] Starting subtest: plane-upscale-factor-0-25-with-rotation
[569.004594] Starting dynamic subtest: pipe-A
[569.227356] Dynamic subtest pipe-A: SUCCESS (0.227s)
[569.239525] Starting dynamic subtest: pipe-B
[570.549840] Dynamic subtest pipe-B: SUCCESS (1.322s)
[570.561212] Starting dynamic subtest: pipe-C
[571.855472] Dynamic subtest pipe-C: SUCCESS (1.304s)
[571.869169] Starting dynamic subtest: pipe-D
[573.153971] Dynamic subtest pipe-D: SUCCESS (1.296s)
[573.156572] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.154s)
[574.309420] [131/133] (449s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[574.436661] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[606.326881] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.888s)
[607.194473] [132/133] (416s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[607.284884] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[607.289123] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[607.394303] [133/133] (416s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[609.434622] Starting subtest: dpms-mode-unset-lpsp
[613.517792] Subtest dpms-mode-unset-lpsp: SUCCESS (4.084s)
[613.902832] 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.