[58.743427] Initializing watchdogs
[58.743471]   /dev/watchdog0
[58.758067] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[58.761931] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.763997] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.767216] [001/133] (960s left) gem_mmap_wc (copy)
[58.841266] Subtest copy: SKIP (0.000s)
[58.891631] [002/133] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[58.971472] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[58.975968] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[59.070740] [003/133] (960s left) kms_psr (psr-suspend)
[59.144963] Starting subtest: psr-suspend
[59.147410] Starting dynamic subtest: eDP-1
[76.879249] Dynamic subtest eDP-1: SUCCESS (3.056s)
[76.881668] Subtest psr-suspend: SUCCESS (3.057s)
[77.732611] [004/133] (941s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[77.832518] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[77.837099] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[77.924700] [005/133] (941s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[77.996952] Starting subtest: fbc-pr-cursor-mmap-cpu
[78.001357] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[78.072153] [006/133] (941s left) template (b)
[78.126931] Starting subtest: B
[78.128867] Subtest B: SUCCESS (0.000s)
[78.228698] [007/133] (941s left) kms_lease (lease-unleased-connector)
[78.303983] Starting subtest: lease-unleased-connector
[78.306311] Starting dynamic subtest: pipe-A-eDP-1
[78.311322] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s)
[78.320599] Starting dynamic subtest: pipe-B-eDP-1
[78.322701] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.007s)
[78.331427] Starting dynamic subtest: pipe-C-eDP-1
[78.333658] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.008s)
[78.341169] Starting dynamic subtest: pipe-D-eDP-1
[78.343252] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[78.345389] Subtest lease-unleased-connector: SUCCESS (0.033s)
[78.445254] [008/133] (941s left) kms_addfb_basic (invalid-set-prop)
[78.513831] Starting subtest: invalid-set-prop
[78.515994] Subtest invalid-set-prop: SUCCESS (0.000s)
[78.634710] [009/133] (940s left) kms_cursor_crc (cursor-onscreen-32x32)
[78.774785] Starting subtest: cursor-onscreen-32x32
[78.823403] Subtest cursor-onscreen-32x32: SKIP (0.044s)
[79.087642] [010/133] (940s left) gem_vm_create (create-ext)
[79.146205] Starting subtest: create-ext
[79.152805] Subtest create-ext: SUCCESS (0.007s)
[79.263130] [011/133] (940s left) kms_plane_lowres (tiling-yf)
[79.348799] Starting subtest: tiling-yf
[79.352388] Subtest tiling-yf: SKIP (0.000s)
[79.418023] [012/133] (940s left) kms_sequence (get-busy)
[79.480140] Starting subtest: get-busy
[79.481715] Starting dynamic subtest: pipe-A-eDP-1
[81.407432] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.926s)
[81.418227] Starting dynamic subtest: pipe-B-eDP-1
[84.040916] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.630s)
[84.048988] Starting dynamic subtest: pipe-C-eDP-1
[86.648489] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.606s)
[86.657683] Starting dynamic subtest: pipe-D-eDP-1
[89.175473] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.527s)
[89.177790] Subtest get-busy: SUCCESS (9.693s)
[90.066908] [013/133] (929s left) gem_ctx_param (invalid-set-ringsize)
[90.123818] Starting subtest: invalid-set-ringsize
[90.126327] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[90.209903] [014/133] (929s left) syncobj_wait (invalid-signal-one-illegal-handle)
[90.267149] Starting subtest: invalid-signal-one-illegal-handle
[90.269182] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[90.355491] [015/133] (929s left) kms_chamelium_frames (dp-frame-dump)
[90.715671] Subtest dp-frame-dump: SKIP (0.000s)
[91.561985] [016/133] (928s left) kms_content_protection (dp-mst-type-0-hdcp14)
[91.682191] Starting subtest: dp-mst-type-0-hdcp14
[91.686820] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s)
[91.805409] [017/133] (928s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[91.890804] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[91.895052] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[91.996479] [018/133] (927s left) gem_pxp (create-valid-protected-context)
[92.135074] Starting subtest: create-valid-protected-context
[92.137831] Subtest create-valid-protected-context: SUCCESS (0.002s)
[92.236315] [019/133] (927s left) syncobj_timeline (single-wait-for-submit-signaled)
[92.299972] Starting subtest: single-wait-for-submit-signaled
[92.302368] Subtest single-wait-for-submit-signaled: SUCCESS (0.001s)
[92.393650] [020/133] (927s left) gem_exec_fence (syncobj-channel)
[92.857026] Starting subtest: syncobj-channel
[93.877252] Subtest syncobj-channel: SUCCESS (1.017s)
[94.594046] [FACT gem_exec_fence (syncobj-channel)] new: kernel.kmod_is_loaded.vgem: true
[94.597197] [021/133] (925s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[94.681474] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[94.685444] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[94.779495] [022/133] (925s left) perf_pmu (busy-check-all)
[94.819661] Starting subtest: busy-check-all
[94.821675] Starting dynamic subtest: rcs0
[95.391209] Dynamic subtest rcs0: SUCCESS (0.573s)
[95.402974] Starting dynamic subtest: bcs0
[95.939963] Dynamic subtest bcs0: SUCCESS (0.548s)
[95.951734] Starting dynamic subtest: vcs0
[97.518802] Dynamic subtest vcs0: SUCCESS (1.576s)
[97.532086] Starting dynamic subtest: vcs1
[99.503211] Dynamic subtest vcs1: SUCCESS (1.983s)
[99.514721] Starting dynamic subtest: vecs0
[101.553113] Dynamic subtest vecs0: SUCCESS (2.049s)
[101.566923] Starting dynamic subtest: ccs0
[102.109097] Dynamic subtest ccs0: SUCCESS (0.557s)
[102.111802] Subtest busy-check-all: SUCCESS (7.291s)
[102.216272] [023/133] (917s left) api_intel_bb (blit-reloc-keep-cache)
[102.274367] Starting subtest: blit-reloc-keep-cache
[102.278962] Subtest blit-reloc-keep-cache: SKIP (0.000s)
[102.379185] [024/133] (917s left) gen9_exec_parse (unaligned-access)
[102.451392] Subtest unaligned-access: SKIP (0.000s)
[102.509834] [025/133] (917s left) gem_exec_flush (basic-wb-ro-default)
[102.563192] Starting subtest: basic-wb-ro-default
[108.029791] Subtest basic-wb-ro-default: SUCCESS (5.467s)
[108.213344] [026/133] (912s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted)
[108.265957] Starting subtest: etime-single-wait-all-available-unsubmitted
[108.371113] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.104s)
[108.459692] [027/133] (911s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[108.548594] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[117.139326] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.598s)
[117.252492] [028/133] (903s left) kms_cursor_legacy (torture-move)
[117.353182] Starting subtest: torture-move
[117.355399] Starting dynamic subtest: pipe-A
[123.790680] Dynamic subtest pipe-A: SUCCESS (6.435s)
[123.802376] Starting dynamic subtest: pipe-B
[130.323670] Dynamic subtest pipe-B: SUCCESS (6.534s)
[130.332736] Starting dynamic subtest: pipe-C
[137.817983] Dynamic subtest pipe-C: SUCCESS (7.495s)
[137.826833] Starting dynamic subtest: pipe-D
[144.481409] Dynamic subtest pipe-D: SUCCESS (6.661s)
[144.491762] Starting dynamic subtest: all-pipes
[151.091578] Dynamic subtest all-pipes: SUCCESS (6.611s)
[151.093896] Subtest torture-move: SUCCESS (33.740s)
[151.250652] [029/133] (869s left) syncobj_wait (invalid-wait-illegal-handle)
[151.311909] Starting subtest: invalid-wait-illegal-handle
[151.314126] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[151.410667] [030/133] (868s left) syncobj_timeline (wait-any-snapshot)
[151.469893] Starting subtest: wait-any-snapshot
[151.552018] Subtest wait-any-snapshot: SUCCESS (0.084s)
[151.639793] [031/133] (868s left) gem_mmap_gtt (basic-small-bo)
[151.686314] Subtest basic-small-bo: SKIP (0.000s)
[151.741545] [032/133] (868s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[151.814020] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[151.816308] Starting dynamic subtest: pipe-A-eDP-1
[151.836366] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[151.846566] Starting dynamic subtest: pipe-B-eDP-1
[151.865528] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[151.874326] Starting dynamic subtest: pipe-C-eDP-1
[151.892819] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[151.901431] Starting dynamic subtest: pipe-D-eDP-1
[151.920948] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[151.923153] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.007s)
[153.995366] [033/133] (866s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[154.080701] Starting subtest: psr-rgb565-draw-render
[161.112109] Subtest psr-rgb565-draw-render: SUCCESS (7.034s)
[161.224879] [034/133] (859s left) kms_vblank (wait-busy)
[161.300446] Starting subtest: wait-busy
[161.302434] Starting dynamic subtest: pipe-A-eDP-1
[163.175916] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.876s)
[163.189180] Starting dynamic subtest: pipe-D-eDP-1
[165.779819] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.601s)
[165.782114] Subtest wait-busy: SUCCESS (4.480s)
[166.577307] [035/133] (854s left) kms_psr (fbc-psr-primary-mmap-gtt)
[166.655378] Starting subtest: fbc-psr-primary-mmap-gtt
[166.657722] Starting dynamic subtest: eDP-1
[166.662068] Dynamic subtest eDP-1: SKIP (0.000s)
[166.666561] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[166.728655] [036/133] (853s left) kms_getfb (getfb2-handle-zero)
[166.796579] Starting subtest: getfb2-handle-zero
[166.799106] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[166.895979] [037/133] (853s left) gem_exec_params (rs-invalid)
[166.956511] Starting subtest: rs-invalid
[166.961685] Subtest rs-invalid: SUCCESS (0.003s)
[167.075318] [038/133] (853s left) i915_module_load (resize-bar)
[167.111130] Starting subtest: resize-bar
[167.118107] Subtest resize-bar: SKIP (0.006s)
[167.158774] [039/133] (853s left) gem_exec_params (secure-non-root)
[167.223425] Starting subtest: secure-non-root
[167.228059] Subtest secure-non-root: SKIP (0.000s)
[167.344250] [040/133] (853s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[167.436127] Starting subtest: fbc-modesetfrombusy
[171.249548] Subtest fbc-modesetfrombusy: SUCCESS (3.820s)
[172.441044] [041/133] (848s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[172.518124] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs
[172.520393] Starting dynamic subtest: pipe-A-eDP-1
[172.542291] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[172.553082] Starting dynamic subtest: pipe-B-eDP-1
[172.573590] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[172.581587] Starting dynamic subtest: pipe-C-eDP-1
[172.601576] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[172.609314] Starting dynamic subtest: pipe-D-eDP-1
[172.630000] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[172.634133] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[174.755936] [042/133] (846s left) gem_ctx_engines (invalid-engines)
[174.822083] Starting subtest: invalid-engines
[174.827942] Subtest invalid-engines: SUCCESS (0.008s)
[175.061525] [043/133] (845s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[175.126610] Starting subtest: mixed-tiled-to-y-tiled-ccs
[175.131380] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[175.308044] [044/133] (845s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[175.396330] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[176.431973] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.035s)
[176.562720] [045/133] (844s left) gem_exec_whisper (basic-queues-forked)
[176.624439] Starting subtest: basic-queues-forked
[199.674926] Subtest basic-queues-forked: SUCCESS (23.044s)
[199.857038] [046/133] (821s left) kms_chamelium_color (ctm-0-75)
[199.942633] Subtest ctm-0-75: SKIP (0.000s)
[199.988955] [047/133] (821s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[200.073080] Starting subtest: y-tiled-32bpp-rotate-90
[200.077458] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[200.178743] [048/133] (820s left) gem_exec_schedule (preempt-contexts)
[200.253553] Starting subtest: preempt-contexts
[200.255776] Starting dynamic subtest: rcs0
[200.306153] Dynamic subtest rcs0: SUCCESS (0.058s)
[200.315259] Starting dynamic subtest: bcs0
[200.357253] Dynamic subtest bcs0: SUCCESS (0.051s)
[200.367482] Starting dynamic subtest: vcs0
[200.406148] Dynamic subtest vcs0: SUCCESS (0.048s)
[200.415796] Starting dynamic subtest: vcs1
[200.446810] Dynamic subtest vcs1: SUCCESS (0.040s)
[200.455846] Starting dynamic subtest: vecs0
[200.487147] Dynamic subtest vecs0: SUCCESS (0.038s)
[200.499733] Starting dynamic subtest: ccs0
[200.526988] Dynamic subtest ccs0: SUCCESS (0.042s)
[200.529463] Subtest preempt-contexts: SUCCESS (0.279s)
[201.612305] [049/133] (819s left) syncobj_timeline (invalid-signal-illegal-handle)
[201.659680] Starting subtest: invalid-signal-illegal-handle
[201.661777] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[201.756224] [050/133] (819s left) kms_psr (pr-sprite-mmap-gtt)
[201.822154] Starting subtest: pr-sprite-mmap-gtt
[201.826637] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[201.909291] [051/133] (819s left) kms_psr (psr2-primary-blt)
[201.996100] Starting subtest: psr2-primary-blt
[201.998435] Starting dynamic subtest: eDP-1
[203.753176] Dynamic subtest eDP-1: SUCCESS (1.757s)
[203.755881] Subtest psr2-primary-blt: SUCCESS (1.757s)
[204.634932] [052/133] (816s left) kms_rotation_crc (primary-rotation-180)
[204.703347] Starting subtest: primary-rotation-180
[211.565339] Subtest primary-rotation-180: SUCCESS (6.862s)
[212.781576] [053/133] (808s left) gem_exec_parallel (contexts)
[212.845555] Starting subtest: contexts
[212.848014] Starting dynamic subtest: rcs0
[215.728369] Dynamic subtest rcs0: SUCCESS (2.881s)
[215.737320] Starting dynamic subtest: bcs0
[219.258232] Dynamic subtest bcs0: SUCCESS (3.528s)
[219.269531] Starting dynamic subtest: vcs0
[223.010881] Dynamic subtest vcs0: SUCCESS (3.751s)
[223.020001] Starting dynamic subtest: vcs1
[226.983929] Dynamic subtest vcs1: SUCCESS (3.970s)
[226.993354] Starting dynamic subtest: vecs0
[231.037981] Dynamic subtest vecs0: SUCCESS (4.053s)
[231.049602] Starting dynamic subtest: ccs0
[234.793868] Dynamic subtest ccs0: SUCCESS (3.754s)
[234.796545] Subtest contexts: SUCCESS (21.947s)
[234.978049] [054/133] (786s left) gen9_exec_parse (cmd-crossing-page)
[235.033097] Subtest cmd-crossing-page: SKIP (0.000s)
[235.102050] [055/133] (786s left) i915_query (engine-info-invalid)
[235.154050] Starting subtest: engine-info-invalid
[235.155945] Subtest engine-info-invalid: SUCCESS (0.000s)
[235.250182] [056/133] (786s left) kms_chamelium_hpd (vga-hpd-fast)
[235.623416] Subtest vga-hpd-fast: SKIP (0.000s)
[236.399712] [057/133] (785s left) kms_addfb_basic (small-bo)
[236.475991] Starting subtest: small-bo
[236.478159] Subtest small-bo: SUCCESS (0.000s)
[236.592414] [058/133] (784s left) gem_userptr_blits (relocations)
[236.650554] Starting subtest: relocations
[236.654628] Subtest relocations: SKIP (0.000s)
[236.800765] [059/133] (784s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[236.851309] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[236.955676] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.104s)
[237.035085] [060/133] (784s left) gem_ctx_persistence (saturated-hostile)
[237.105249] Starting subtest: saturated-hostile
[237.107787] Starting dynamic subtest: rcs0
[237.930390] Dynamic subtest rcs0: SUCCESS (0.825s)
[237.943654] Starting dynamic subtest: bcs0
[238.717467] Dynamic subtest bcs0: SUCCESS (0.785s)
[238.729828] Starting dynamic subtest: vcs0
[239.505266] Dynamic subtest vcs0: SUCCESS (0.782s)
[239.515701] Starting dynamic subtest: vcs1
[240.298397] Dynamic subtest vcs1: SUCCESS (0.795s)
[240.312138] Starting dynamic subtest: vecs0
[241.092676] Dynamic subtest vecs0: SUCCESS (0.789s)
[241.104519] Starting dynamic subtest: ccs0
[241.930810] Dynamic subtest ccs0: SUCCESS (0.840s)
[241.933387] Subtest saturated-hostile: SUCCESS (4.826s)
[242.020492] [061/133] (779s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[242.098553] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[242.102627] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[242.191789] [062/133] (779s left) kms_async_flips (crc)
[242.258008] Starting subtest: crc
[242.642024] Starting dynamic subtest: pipe-A-eDP-1
[245.530787] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.888s)
[245.909943] Starting dynamic subtest: pipe-B-eDP-1
[248.770713] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.871s)
[249.156703] Starting dynamic subtest: pipe-C-eDP-1
[252.086154] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.938s)
[252.452467] Starting dynamic subtest: pipe-D-eDP-1
[255.310910] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.871s)
[255.313362] Subtest crc: SUCCESS (13.053s)
[256.474018] [063/133] (765s left) gem_exec_reloc (basic-wc-gtt)
[256.543189] Subtest basic-wc-gtt: SKIP (0.000s)
[256.614389] [064/133] (765s left) gem_exec_reloc (basic-cpu-gtt)
[256.675693] Subtest basic-cpu-gtt: SKIP (0.000s)
[256.744590] [065/133] (765s left) kms_hdr (static-swap)
[256.819635] Starting subtest: static-swap
[256.826113] Subtest static-swap: SKIP (0.000s)
[256.892397] [066/133] (764s left) gem_lmem_swapping (smem-oom)
[256.933402] Subtest smem-oom: SKIP (0.000s)
[256.980711] [067/133] (764s left) kms_async_flips (test-cursor)
[257.052439] Starting subtest: test-cursor
[257.423734] Starting dynamic subtest: pipe-A-eDP-1
[258.176385] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.753s)
[258.556117] Starting dynamic subtest: pipe-B-eDP-1
[259.306866] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.759s)
[259.673871] Starting dynamic subtest: pipe-C-eDP-1
[260.433471] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.766s)
[260.811743] Starting dynamic subtest: pipe-D-eDP-1
[261.568630] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.765s)
[261.571009] Subtest test-cursor: SUCCESS (4.518s)
[262.733616] [068/133] (759s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[262.829159] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[270.204788] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.380s)
[270.318095] [069/133] (751s left) gem_softpin (allocator-basic-reserve)
[270.379881] Starting subtest: allocator-basic-reserve
[270.445810] Subtest allocator-basic-reserve: SUCCESS (0.066s)
[270.601680] [070/133] (751s left) prime_vgem (sync)
[270.664688] Starting subtest: sync
[270.666979] Starting dynamic subtest: rcs0
[270.741383] Dynamic subtest rcs0: SUCCESS (0.071s)
[270.751465] Starting dynamic subtest: bcs0
[270.794013] Dynamic subtest bcs0: SUCCESS (0.058s)
[270.805953] Starting dynamic subtest: vcs0
[270.850852] Dynamic subtest vcs0: SUCCESS (0.056s)
[270.859938] Starting dynamic subtest: vcs1
[270.896113] Dynamic subtest vcs1: SUCCESS (0.044s)
[270.905774] Starting dynamic subtest: vecs0
[270.941481] Dynamic subtest vecs0: SUCCESS (0.044s)
[270.950857] Starting dynamic subtest: ccs0
[270.986860] Dynamic subtest ccs0: SUCCESS (0.044s)
[270.989083] Subtest sync: SUCCESS (0.323s)
[271.108876] [071/133] (750s left) gem_userptr_blits (sync-unmap-cycles)
[271.167810] Starting subtest: sync-unmap-cycles
[276.538941] Subtest sync-unmap-cycles: SUCCESS (5.372s)
[276.659987] [072/133] (745s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[276.765770] Starting subtest: basic-busy-flip-before-cursor-atomic
[276.769432] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[276.909095] [073/133] (745s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[277.001312] Starting subtest: short-flip-before-cursor-atomic-transitions
[277.950965] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.948s)
[278.793177] [074/133] (743s left) kms_feature_discovery (display)
[278.861393] Starting subtest: display
[278.863687] Subtest display: SUCCESS (0.000s)
[278.942083] [075/133] (743s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[279.016602] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[279.018938] Starting dynamic subtest: pipe-A-default-mode
[281.733811] Dynamic subtest pipe-A-default-mode: SUCCESS (2.717s)
[281.736141] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.719s)
[282.565602] [076/133] (739s left) gem_ctx_shared (q-smoketest-all)
[282.626366] Starting subtest: Q-smoketest-all
[315.023787] Subtest Q-smoketest-all: SUCCESS (32.346s)
[316.647789] [077/133] (705s left) gem_mmap_gtt (basic-wc)
[316.714269] Subtest basic-wc: SKIP (0.000s)
[316.777455] [078/133] (705s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[316.868541] Starting subtest: yf-tiled-8bpp-rotate-180
[316.872847] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[316.969900] [079/133] (705s left) gem_exec_suspend (basic-s4-devices)
[317.022559] Starting subtest: basic-S4-devices
[317.024973] Starting dynamic subtest: smem
[328.495157] Dynamic subtest smem: SUCCESS (11.469s)
[328.497868] Subtest basic-S4-devices: SUCCESS (11.472s)
[333.687845] [080/133] (693s left) kms_plane (plane-position-hole)
[333.783979] Starting subtest: plane-position-hole
[334.294056] Starting dynamic subtest: pipe-A-plane-1
[335.538379] Dynamic subtest pipe-A-plane-1: SUCCESS (1.245s)
[335.549189] Starting dynamic subtest: pipe-A-plane-2
[336.787390] Dynamic subtest pipe-A-plane-2: SUCCESS (1.249s)
[336.808334] Starting dynamic subtest: pipe-A-plane-3
[338.103463] Dynamic subtest pipe-A-plane-3: SUCCESS (1.314s)
[338.113090] Starting dynamic subtest: pipe-A-plane-4
[339.339511] Dynamic subtest pipe-A-plane-4: SUCCESS (1.235s)
[339.360767] Starting dynamic subtest: pipe-A-plane-5
[339.367671] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[340.500674] Starting dynamic subtest: pipe-B-plane-1
[341.801819] Dynamic subtest pipe-B-plane-1: SUCCESS (1.310s)
[341.817996] Starting dynamic subtest: pipe-B-plane-2
[343.022911] Dynamic subtest pipe-B-plane-2: SUCCESS (1.221s)
[343.033014] Starting dynamic subtest: pipe-B-plane-3
[344.255202] Dynamic subtest pipe-B-plane-3: SUCCESS (1.231s)
[344.265782] Starting dynamic subtest: pipe-B-plane-4
[345.471959] Dynamic subtest pipe-B-plane-4: SUCCESS (1.213s)
[345.482021] Starting dynamic subtest: pipe-B-plane-5
[345.495482] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[345.497618] Subtest plane-position-hole: SUCCESS (11.710s)
[346.291078] [081/133] (681s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[346.373757] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[353.217149] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.847s)
[353.355803] [082/133] (674s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[353.451891] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[353.454254] Starting dynamic subtest: pipe-A-eDP-1
[353.476973] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[353.487446] Starting dynamic subtest: pipe-B-eDP-1
[353.508399] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[353.516849] Starting dynamic subtest: pipe-C-eDP-1
[353.537349] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[353.546028] Starting dynamic subtest: pipe-D-eDP-1
[353.566909] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[353.570988] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[355.583164] [083/133] (671s left) kms_cursor_crc (cursor-sliding-128x128)
[355.780604] Starting subtest: cursor-sliding-128x128
[355.785543] Starting dynamic subtest: pipe-A-eDP-1
[358.991777] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.205s)
[359.021135] Starting dynamic subtest: pipe-D-eDP-1
[362.849683] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.834s)
[362.851884] Subtest cursor-sliding-128x128: SUCCESS (7.066s)
[363.636052] [084/133] (663s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[363.728213] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[363.730592] Starting dynamic subtest: pipe-A-eDP-1
[363.823773] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s)
[363.835180] Starting dynamic subtest: pipe-B-eDP-1
[365.024756] Dynamic subtest pipe-B-eDP-1: SKIP (1.198s)
[365.029070] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.300s)
[366.218677] [085/133] (661s left) kms_addfb_basic (no-handle)
[366.283509] Starting subtest: no-handle
[366.285438] Subtest no-handle: SUCCESS (0.000s)
[366.413391] [086/133] (661s left) gem_mmap_gtt (big-copy)
[366.468518] Subtest big-copy: SKIP (0.000s)
[366.524752] [087/133] (661s left) kms_color (ctm-max)
[366.604686] Starting subtest: ctm-max
[366.606640] Starting dynamic subtest: pipe-A-eDP-1
[367.333126] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.725s)
[367.355741] Starting dynamic subtest: pipe-B-eDP-1
[368.770784] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.441s)
[368.781972] Starting dynamic subtest: pipe-C-eDP-1
[370.118584] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.345s)
[370.128547] Starting dynamic subtest: pipe-D-eDP-1
[371.440220] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.323s)
[371.442500] Subtest ctm-max: SUCCESS (4.838s)
[372.252689] [088/133] (655s left) gem_workarounds (reset-context)
[372.334149] Starting subtest: reset-context
[372.510963] Subtest reset-context: SUCCESS (0.177s)
[372.640654] [089/133] (655s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[372.718075] Starting subtest: 4-tiled-32bpp-rotate-270
[372.737992] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.019s)
[372.884802] [090/133] (655s left) i915_pm_rps (engine-order)
[372.954510] Starting subtest: engine-order
[379.043339] Subtest engine-order: SUCCESS (6.092s)
[379.191695] [091/133] (648s left) gem_exec_whisper (basic-contexts-all)
[379.258761] Starting subtest: basic-contexts-all
[388.559598] Subtest basic-contexts-all: SUCCESS (9.300s)
[388.745104] [092/133] (639s left) i915_query (query-topology-unsupported)
[388.799923] Starting subtest: query-topology-unsupported
[388.804576] Subtest query-topology-unsupported: SKIP (0.000s)
[388.900072] [093/133] (639s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[388.954920] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[388.959500] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[389.143543] [094/133] (638s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[389.226046] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[389.230230] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[389.388352] [095/133] (638s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[389.469525] Starting subtest: read-crc-frame-sequence
[389.471828] Starting dynamic subtest: pipe-A-eDP-1
[390.174732] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.705s)
[390.185501] Starting dynamic subtest: pipe-B-eDP-1
[391.524009] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.347s)
[391.535248] Starting dynamic subtest: pipe-C-eDP-1
[392.804236] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.278s)
[392.814473] Starting dynamic subtest: pipe-D-eDP-1
[394.142556] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.338s)
[394.144911] Subtest read-crc-frame-sequence: SUCCESS (4.674s)
[394.987495] [096/133] (633s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[395.063095] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[402.270786] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.211s)
[402.407475] [097/133] (625s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[402.486516] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[402.490868] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s)
[402.557061] [098/133] (625s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[402.620247] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[402.622515] Starting dynamic subtest: pipe-A
[402.643635] Dynamic subtest pipe-A: SKIP (0.019s)
[402.660042] Starting dynamic subtest: pipe-B
[402.672977] Dynamic subtest pipe-B: SKIP (0.029s)
[402.684081] Starting dynamic subtest: pipe-C
[402.706224] Dynamic subtest pipe-C: SKIP (0.031s)
[402.717525] Starting dynamic subtest: pipe-D
[402.734887] Dynamic subtest pipe-D: SKIP (0.030s)
[402.738692] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.111s)
[402.852916] [099/133] (625s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[402.929766] Starting subtest: fbc-rgb565-draw-pwrite
[407.457517] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.531s)
[408.632523] [100/133] (619s left) kms_psr (fbc-psr2-cursor-plane-move)
[408.716146] Starting subtest: fbc-psr2-cursor-plane-move
[408.718519] Starting dynamic subtest: eDP-1
[408.723007] Dynamic subtest eDP-1: SKIP (0.000s)
[408.727085] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s)
[408.790953] [101/133] (619s left) perf (non-system-wide-paranoid)
[408.915607] Starting subtest: non-system-wide-paranoid
[408.940492] Subtest non-system-wide-paranoid: SUCCESS (0.027s)
[408.989038] [102/133] (619s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[410.699138] Starting subtest: modeset-lpsp-stress-no-wait
[420.494539] Subtest modeset-lpsp-stress-no-wait: SUCCESS (9.792s)
[420.582109] [103/133] (607s left) fbdev (write)
[420.624326] Starting subtest: write
[420.977306] Subtest write: SUCCESS (0.353s)
[421.046209] [104/133] (607s left) gem_exec_create (basic)
[421.102048] Starting subtest: basic
[421.104420] Starting dynamic subtest: smem
[424.495981] Dynamic subtest smem: SUCCESS (3.391s)
[424.499373] Subtest basic: SUCCESS (3.394s)
[424.697655] [105/133] (603s left) gem_mmap_offset (bad-flags)
[424.753271] Starting subtest: bad-flags
[424.755460] Subtest bad-flags: SUCCESS (0.000s)
[424.849979] [106/133] (603s left) api_intel_bb (simple-bb)
[424.903104] Starting subtest: simple-bb
[424.915444] Subtest simple-bb: SUCCESS (0.013s)
[425.027595] [107/133] (603s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[425.105683] Starting subtest: flip-vs-dpms-on-nop-interruptible
[425.108006] Starting dynamic subtest: A-eDP1
[426.941168] Dynamic subtest A-eDP1: SUCCESS (1.835s)
[426.956237] Starting dynamic subtest: B-eDP1
[428.763944] Dynamic subtest B-eDP1: SUCCESS (1.820s)
[428.778751] Starting dynamic subtest: C-eDP1
[430.586953] Dynamic subtest C-eDP1: SUCCESS (1.820s)
[430.598343] Starting dynamic subtest: D-eDP1
[432.417351] Dynamic subtest D-eDP1: SUCCESS (1.829s)
[432.422126] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.316s)
[433.617844] [108/133] (595s left) gem_exec_reloc (basic-cpu)
[433.674606] Subtest basic-cpu: SKIP (0.000s)
[433.748749] [109/133] (595s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[433.827994] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[434.629541] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.803s)
[434.803425] [110/133] (594s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[434.858053] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[434.860257] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[434.948053] [111/133] (593s left) gem_mmap_gtt (basic-read-write)
[435.001867] Subtest basic-read-write: SKIP (0.000s)
[435.066114] [112/133] (593s left) kms_pm_dc (dc3co-vpb-simulation)
[436.149299] Starting subtest: dc3co-vpb-simulation
[445.136729] Subtest dc3co-vpb-simulation: SKIP (8.983s)
[445.283960] [113/133] (583s left) kms_cursor_crc (cursor-sliding-32x32)
[445.395537] Starting subtest: cursor-sliding-32x32
[445.442873] Subtest cursor-sliding-32x32: SKIP (0.042s)
[445.726420] [114/133] (583s left) kms_flip (plain-flip-ts-check-interruptible)
[445.811751] Starting subtest: plain-flip-ts-check-interruptible
[445.814045] Starting dynamic subtest: A-eDP1
[454.693406] Dynamic subtest A-eDP1: SUCCESS (8.880s)
[454.705511] Starting dynamic subtest: B-eDP1
[463.524740] Dynamic subtest B-eDP1: SUCCESS (8.830s)
[463.536202] Starting dynamic subtest: C-eDP1
[472.342326] Dynamic subtest C-eDP1: SUCCESS (8.816s)
[472.353164] Starting dynamic subtest: D-eDP1
[481.181345] Dynamic subtest D-eDP1: SUCCESS (8.838s)
[481.186556] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.373s)
[482.368317] [115/133] (546s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[482.471975] Starting subtest: x-tiled-64bpp-rotate-270
[482.492364] Subtest x-tiled-64bpp-rotate-270: SKIP (0.020s)
[482.599562] [116/133] (546s left) gem_sync (basic-store-each)
[482.665947] Starting subtest: basic-store-each
[485.262420] Subtest basic-store-each: SUCCESS (2.607s)
[485.447980] [117/133] (543s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[485.532639] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[485.536567] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[485.621049] [118/133] (543s left) device_reset (unbind-cold-reset-rebind)
[485.668133] Starting subtest: unbind-cold-reset-rebind
[485.672851] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[485.732925] [119/133] (543s left) gem_exec_schedule (semaphore-user)
[485.808020] Starting subtest: semaphore-user
[485.858207] Subtest semaphore-user: SUCCESS (0.059s)
[487.575892] [120/133] (541s left) perf_pmu (idle)
[487.622036] Starting subtest: idle
[487.624312] Starting dynamic subtest: rcs0
[488.160644] Dynamic subtest rcs0: SUCCESS (0.540s)
[488.173142] Starting dynamic subtest: bcs0
[488.683821] Dynamic subtest bcs0: SUCCESS (0.520s)
[488.696356] Starting dynamic subtest: vcs0
[489.218338] Dynamic subtest vcs0: SUCCESS (0.532s)
[489.231166] Starting dynamic subtest: vcs1
[489.744662] Dynamic subtest vcs1: SUCCESS (0.523s)
[489.757551] Starting dynamic subtest: vecs0
[490.262891] Dynamic subtest vecs0: SUCCESS (0.515s)
[490.282476] Starting dynamic subtest: ccs0
[490.780095] Dynamic subtest ccs0: SUCCESS (0.516s)
[490.783225] Subtest idle: SUCCESS (3.161s)
[490.899263] [121/133] (538s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[490.986343] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[497.484107] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.502s)
[497.637288] [122/133] (531s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[497.711326] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[497.713657] Starting dynamic subtest: pipe-A-eDP-1
[497.736745] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[497.749339] Starting dynamic subtest: pipe-B-eDP-1
[497.771112] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[497.780891] Starting dynamic subtest: pipe-C-eDP-1
[497.802795] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[497.814127] Starting dynamic subtest: pipe-D-eDP-1
[497.836318] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[497.840614] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[499.951690] [123/133] (529s left) kms_plane (pixel-format-linear-modifier)
[500.034345] Starting subtest: pixel-format-linear-modifier
[500.060428] Starting dynamic subtest: pipe-A-plane-0
[503.562674] Dynamic subtest pipe-A-plane-0: SUCCESS (3.500s)
[503.572997] Starting dynamic subtest: pipe-A-plane-3
[505.249010] Dynamic subtest pipe-A-plane-3: SUCCESS (1.688s)
[505.259129] Starting dynamic subtest: pipe-A-plane-5
[505.460164] Dynamic subtest pipe-A-plane-5: SUCCESS (0.210s)
[506.546301] Starting dynamic subtest: pipe-B-plane-0
[510.004090] Dynamic subtest pipe-B-plane-0: SUCCESS (3.466s)
[510.016532] Starting dynamic subtest: pipe-B-plane-3
[511.626724] Dynamic subtest pipe-B-plane-3: SUCCESS (1.620s)
[511.637530] Starting dynamic subtest: pipe-B-plane-5
[511.837628] Dynamic subtest pipe-B-plane-5: SUCCESS (0.211s)
[512.166658] Subtest pixel-format-linear-modifier: SUCCESS (12.131s)
[513.028515] [124/133] (516s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[513.116221] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[513.120570] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[513.235009] [125/133] (516s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[513.307861] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[513.312232] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[513.409805] [126/133] (516s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[513.476293] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[513.480864] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[514.569485] [127/133] (514s left) syncobj_wait (wait-all-complex)
[514.626438] Starting subtest: wait-all-complex
[514.839900] Subtest wait-all-complex: SUCCESS (0.213s)
[514.928131] [128/133] (514s left) gem_exec_balancer (bonded-chain)
[514.982934] Starting subtest: bonded-chain
[521.966601] Subtest bonded-chain: SUCCESS (6.982s)
[522.523769] [129/133] (507s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[522.632085] Starting subtest: cursorB-vs-flipB-atomic
[522.636699] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[522.778886] [130/133] (506s left) kms_properties (colorop-properties-legacy)
[522.865430] Starting subtest: colorop-properties-legacy
[522.867576] Starting dynamic subtest: pipe-A-eDP-1
[523.224679] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.359s)
[523.237992] Starting dynamic subtest: pipe-B-eDP-1
[524.319495] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.092s)
[524.332124] Starting dynamic subtest: pipe-C-eDP-1
[525.357018] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.036s)
[525.368086] Starting dynamic subtest: pipe-D-eDP-1
[526.392073] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.032s)
[526.394421] Subtest colorop-properties-legacy: SUCCESS (3.526s)
[527.189126] [131/133] (502s left) gem_exec_fence (basic-busy)
[527.375408] Starting subtest: basic-busy
[527.377952] Starting dynamic subtest: rcs0
[527.435656] Dynamic subtest rcs0: SUCCESS (0.060s)
[527.448790] Starting dynamic subtest: bcs0
[527.490770] Dynamic subtest bcs0: SUCCESS (0.053s)
[527.502897] Starting dynamic subtest: vcs0
[527.550015] Dynamic subtest vcs0: SUCCESS (0.057s)
[527.562426] Starting dynamic subtest: vcs1
[527.604581] Dynamic subtest vcs1: SUCCESS (0.053s)
[527.615990] Starting dynamic subtest: vecs0
[527.663816] Dynamic subtest vecs0: SUCCESS (0.057s)
[527.678995] Starting dynamic subtest: ccs0
[527.723906] Dynamic subtest ccs0: SUCCESS (0.057s)
[527.726445] Subtest basic-busy: SUCCESS (0.350s)
[529.579654] [132/133] (500s left) gem_eio (wait-10ms)
[529.806075] Starting subtest: wait-10ms
[530.169882] Subtest wait-10ms: SUCCESS (0.365s)
[530.294664] [133/133] (499s left) kms_atomic_transition (plane-all-transition-fencing)
[530.370318] Starting subtest: plane-all-transition-fencing
[530.372647] Starting dynamic subtest: pipe-A-eDP-1
[532.865393] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[533.171996] Starting dynamic subtest: pipe-B-eDP-1
[536.413654] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.251s)
[536.719205] Subtest plane-all-transition-fencing: SUCCESS (6.348s)
[537.550392] Closing watchdogs
results: parsing output: 0/ for test: gem_mmap_wc
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_psr
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_psr
results: parsing output: 5/ for test: template
results: parsing output: 6/ for test: kms_lease
results: parsing output: 7/ for test: kms_addfb_basic
results: parsing output: 8/ for test: kms_cursor_crc
results: parsing output: 9/ for test: gem_vm_create
results: parsing output: 10/ for test: kms_plane_lowres
results: parsing output: 11/ for test: kms_sequence
results: parsing output: 12/ for test: gem_ctx_param
results: parsing output: 13/ for test: syncobj_wait
results: parsing output: 14/ for test: kms_chamelium_frames
results: parsing output: 15/ for test: kms_content_protection
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: gem_pxp
results: parsing output: 18/ for test: syncobj_timeline
results: parsing output: 19/ for test: gem_exec_fence
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: perf_pmu
results: parsing output: 22/ for test: api_intel_bb
results: parsing output: 23/ for test: gen9_exec_parse
results: parsing output: 24/ for test: gem_exec_flush
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_cursor_legacy
results: parsing output: 28/ for test: syncobj_wait
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: gem_mmap_gtt
results: parsing output: 31/ for test: kms_ccs
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_vblank
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: kms_getfb
results: parsing output: 36/ for test: gem_exec_params
results: parsing output: 37/ for test: i915_module_load
results: parsing output: 38/ for test: gem_exec_params
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_ccs
results: parsing output: 41/ for test: gem_ctx_engines
results: parsing output: 42/ for test: gem_render_copy
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: gem_exec_whisper
results: parsing output: 45/ for test: kms_chamelium_color
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: gem_exec_schedule
results: parsing output: 48/ for test: syncobj_timeline
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: kms_psr
results: parsing output: 51/ for test: kms_rotation_crc
results: parsing output: 52/ for test: gem_exec_parallel
results: parsing output: 53/ for test: gen9_exec_parse
results: parsing output: 54/ for test: i915_query
results: parsing output: 55/ for test: kms_chamelium_hpd
results: parsing output: 56/ for test: kms_addfb_basic
results: parsing output: 57/ for test: gem_userptr_blits
results: parsing output: 58/ for test: syncobj_timeline
results: parsing output: 59/ for test: gem_ctx_persistence
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_async_flips
results: parsing output: 62/ for test: gem_exec_reloc
results: parsing output: 63/ for test: gem_exec_reloc
results: parsing output: 64/ for test: kms_hdr
results: parsing output: 65/ for test: gem_lmem_swapping
results: parsing output: 66/ for test: kms_async_flips
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_softpin
results: parsing output: 69/ for test: prime_vgem
results: parsing output: 70/ for test: gem_userptr_blits
results: parsing output: 71/ for test: kms_cursor_legacy
results: parsing output: 72/ for test: kms_cursor_legacy
results: parsing output: 73/ for test: kms_feature_discovery
results: parsing output: 74/ for test: kms_flip_scaled_crc
results: parsing output: 75/ for test: gem_ctx_shared
results: parsing output: 76/ for test: gem_mmap_gtt
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: gem_exec_suspend
results: parsing output: 79/ for test: kms_plane
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_ccs
results: parsing output: 82/ for test: kms_cursor_crc
results: parsing output: 83/ for test: kms_psr2_sf
results: parsing output: 84/ for test: kms_addfb_basic
results: parsing output: 85/ for test: gem_mmap_gtt
results: parsing output: 86/ for test: kms_color
results: parsing output: 87/ for test: gem_workarounds
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: i915_pm_rps
results: parsing output: 90/ for test: gem_exec_whisper
results: parsing output: 91/ for test: i915_query
results: parsing output: 92/ for test: gem_render_copy
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_pipe_crc_basic
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_flip_scaled_crc
results: parsing output: 97/ for test: kms_plane_scaling
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: perf
results: parsing output: 101/ for test: kms_pm_rpm
results: parsing output: 102/ for test: fbdev
results: parsing output: 103/ for test: gem_exec_create
results: parsing output: 104/ for test: gem_mmap_offset
results: parsing output: 105/ for test: api_intel_bb
results: parsing output: 106/ for test: kms_flip
results: parsing output: 107/ for test: gem_exec_reloc
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: syncobj_timeline
results: parsing output: 110/ for test: gem_mmap_gtt
results: parsing output: 111/ for test: kms_pm_dc
results: parsing output: 112/ for test: kms_cursor_crc
results: parsing output: 113/ for test: kms_flip
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: gem_sync
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: device_reset
results: parsing output: 118/ for test: gem_exec_schedule
results: parsing output: 119/ for test: perf_pmu
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_ccs
results: parsing output: 122/ for test: kms_plane
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_ccs
results: parsing output: 126/ for test: syncobj_wait
results: parsing output: 127/ for test: gem_exec_balancer
results: parsing output: 128/ for test: kms_cursor_legacy
results: parsing output: 129/ for test: kms_properties
results: parsing output: 130/ for test: gem_exec_fence
results: parsing output: 131/ for test: gem_eio
results: parsing output: 132/ for test: kms_atomic_transition
Done.