[59.098609] Initializing watchdogs
[59.098656]   /dev/watchdog0
[59.112143] [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]
[59.116428] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.119037] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.122386] [001/133] (960s left) kms_chamelium_audio (hdmi-audio)
[59.536120] Subtest hdmi-audio: SKIP (0.000s)
[60.356167] [002/133] (959s left) prime_mmap_coherency (write)
[60.420171] Starting subtest: write
[65.784214] Subtest write: SUCCESS (5.378s)
[65.918343] [003/133] (953s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping)
[66.012082] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping
[66.016407] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (0.000s)
[66.080939] [004/133] (953s left) sysfs_heartbeat_interval (nopreempt)
[66.137247] Starting subtest: nopreempt
[66.139333] Starting dynamic subtest: vecs0
[75.922011] Dynamic subtest vecs0: SUCCESS (9.793s)
[75.933287] Starting dynamic subtest: ccs0
[79.965822] Dynamic subtest ccs0: SUCCESS (4.043s)
[79.975618] Starting dynamic subtest: vcs0
[89.949310] Dynamic subtest vcs0: SUCCESS (9.980s)
[89.960998] Starting dynamic subtest: bcs0
[93.822983] Dynamic subtest bcs0: SUCCESS (3.874s)
[93.832805] Starting dynamic subtest: rcs0
[97.935419] Dynamic subtest rcs0: SUCCESS (4.110s)
[97.945234] Starting dynamic subtest: vcs1
[107.930791] Dynamic subtest vcs1: SUCCESS (9.991s)
[107.933429] Subtest nopreempt: SUCCESS (41.797s)
[108.016332] [005/133] (911s left) gem_mmap_gtt (medium-copy)
[108.076983] Subtest medium-copy: SKIP (0.000s)
[108.130350] [006/133] (911s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[108.247776] Starting subtest: basic-busy-flip-before-cursor-legacy
[108.252094] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[108.388171] [007/133] (911s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[108.488834] Starting subtest: fbc-rgb101010-draw-mmap-wc
[113.055640] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.569s)
[114.155047] [008/133] (905s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[114.257351] Starting subtest: fbcpsr-1p-rte
[121.261845] Subtest fbcpsr-1p-rte: SUCCESS (7.010s)
[121.416847] [009/133] (898s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[121.522256] Starting subtest: y-tiled-64bpp-rotate-180
[121.526332] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[121.608288] [010/133] (898s left) kms_tiled_display (basic-test-pattern)
[121.717169] Subtest basic-test-pattern: SKIP (0.000s)
[121.767443] [011/133] (898s left) perf_pmu (rc6-suspend)
[121.808414] Starting subtest: rc6-suspend
[144.217930] Subtest rc6-suspend: SUCCESS (7.693s)
[145.088921] [012/133] (874s left) api_intel_allocator (reloc-allocator)
[145.163682] Starting subtest: reloc-allocator
[145.165856] Starting dynamic subtest: basic
[145.168163] Dynamic subtest basic: SUCCESS (0.006s)
[145.179279] Starting dynamic subtest: parallel-one
[145.181562] Dynamic subtest parallel-one: SUCCESS (0.008s)
[145.191361] Starting dynamic subtest: print
[145.193301] Dynamic subtest print: SUCCESS (0.000s)
[145.200708] Starting dynamic subtest: reuse
[145.202662] Dynamic subtest reuse: SUCCESS (0.000s)
[145.209751] Starting dynamic subtest: fork-reopen-allocator
[145.211603] Dynamic subtest fork-reopen-allocator: SUCCESS (0.010s)
[145.213441] Subtest reloc-allocator: SUCCESS (0.025s)
[145.315750] [013/133] (874s left) gem_ctx_persistence (legacy-engines-hostile)
[145.381345] Starting subtest: legacy-engines-hostile
[145.383229] Starting dynamic subtest: render
[145.438072] Dynamic subtest render: SUCCESS (0.058s)
[145.446148] Starting dynamic subtest: bsd1
[145.565481] Dynamic subtest bsd1: SUCCESS (0.128s)
[145.575340] Starting dynamic subtest: bsd2
[145.669568] Dynamic subtest bsd2: SUCCESS (0.104s)
[145.679990] Starting dynamic subtest: blt
[145.743158] Dynamic subtest blt: SUCCESS (0.074s)
[145.752309] Starting dynamic subtest: vebox
[145.865492] Dynamic subtest vebox: SUCCESS (0.123s)
[145.867727] Subtest legacy-engines-hostile: SUCCESS (0.492s)
[145.954346] [014/133] (874s left) sw_sync (sync_merge_invalid)
[145.995211] Starting subtest: sync_merge_invalid
[146.009560] Subtest sync_merge_invalid: SUCCESS (0.015s)
[146.079533] [015/133] (874s left) gem_exec_whisper (basic-queues-forked-all)
[146.148821] Starting subtest: basic-queues-forked-all
[167.834153] Subtest basic-queues-forked-all: SUCCESS (21.783s)
[168.016954] [016/133] (852s left) kms_psr (fbc-pr-no-drrs)
[168.106844] Starting subtest: fbc-pr-no-drrs
[168.110891] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[168.174345] [017/133] (852s left) gen9_exec_parse (allowed-all)
[168.224083] Subtest allowed-all: SKIP (0.000s)
[168.276038] [018/133] (851s left) kms_atomic_interruptible (universal-setplane-cursor)
[168.365039] Starting subtest: universal-setplane-cursor
[168.367279] Starting dynamic subtest: pipe-A-eDP-1
[175.800194] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.433s)
[175.802152] Subtest universal-setplane-cursor: SUCCESS (7.434s)
[176.658752] [019/133] (843s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[176.710883] Starting subtest: etime-multi-wait-all-submitted-signaled
[176.817043] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.106s)
[176.892568] [020/133] (843s left) gem_ctx_bad_destroy (invalid-pad)
[176.951951] Starting subtest: invalid-pad
[176.954480] Subtest invalid-pad: SUCCESS (0.000s)
[177.029040] [021/133] (843s left) gem_exec_basic (basic)
[177.092716] Starting subtest: basic
[177.095240] Starting dynamic subtest: rcs0-smem
[177.097641] Dynamic subtest rcs0-smem: SUCCESS (0.004s)
[177.111850] Starting dynamic subtest: bcs0-smem
[177.114137] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[177.122053] Starting dynamic subtest: vcs0-smem
[177.124297] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[177.131994] Starting dynamic subtest: vcs1-smem
[177.134217] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[177.142233] Starting dynamic subtest: vecs0-smem
[177.144509] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[177.153027] Starting dynamic subtest: ccs0-smem
[177.154958] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[177.156901] Subtest basic: SUCCESS (0.012s)
[178.759885] [022/133] (841s left) gem_ctx_param (invalid-ctx-set)
[178.814687] Starting subtest: invalid-ctx-set
[178.816988] Subtest invalid-ctx-set: SUCCESS (0.001s)
[178.903224] [023/133] (841s left) gem_render_copy (x-tiled)
[178.958649] Starting subtest: x-tiled
[178.960778] Starting dynamic subtest: smem
[179.008525] Dynamic subtest smem: SUCCESS (0.049s)
[179.011049] Subtest x-tiled: SUCCESS (0.050s)
[179.235061] [024/133] (841s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[179.349446] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[179.353409] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[179.463985] [025/133] (841s left) gem_exec_schedule (fifo)
[179.543232] Starting subtest: fifo
[179.545447] Starting dynamic subtest: rcs0
[179.631066] Dynamic subtest rcs0: SUCCESS (0.097s)
[179.647672] Starting dynamic subtest: vcs0
[179.712493] Dynamic subtest vcs0: SUCCESS (0.081s)
[179.723852] Starting dynamic subtest: vcs1
[179.823612] Dynamic subtest vcs1: SUCCESS (0.112s)
[179.831832] Starting dynamic subtest: vecs0
[179.910101] Dynamic subtest vecs0: SUCCESS (0.086s)
[179.928554] Starting dynamic subtest: ccs0
[179.994103] Dynamic subtest ccs0: SUCCESS (0.083s)
[179.996970] Subtest fifo: SUCCESS (0.460s)
[180.802815] [026/133] (839s left) core_setmaster (master-drop-set-shared-fd)
[180.890504] Starting subtest: master-drop-set-shared-fd
[180.908903] Subtest master-drop-set-shared-fd: SUCCESS (0.021s)
[180.947871] [027/133] (839s left) gem_bad_reloc (negative-reloc-bltcopy)
[181.011754] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[181.092228] [028/133] (839s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[181.481327] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[182.261519] [029/133] (838s left) kms_properties (plane-properties-atomic)
[182.351979] Starting subtest: plane-properties-atomic
[182.354518] Starting dynamic subtest: pipe-A-eDP-1
[182.930358] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.579s)
[182.939965] Starting dynamic subtest: pipe-B-eDP-1
[184.163091] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.232s)
[184.173340] Starting dynamic subtest: pipe-C-eDP-1
[185.403962] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.239s)
[185.419051] Starting dynamic subtest: pipe-D-eDP-1
[186.635684] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.229s)
[186.637769] Subtest plane-properties-atomic: SUCCESS (4.283s)
[187.427554] [030/133] (833s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[187.476287] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[187.585090] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.109s)
[187.663299] [031/133] (833s left) gen3_render_tiledy_blits
[187.783873] [032/133] (833s left) kms_cursor_crc (cursor-offscreen-64x64)
[187.949949] Starting subtest: cursor-offscreen-64x64
[187.954634] Starting dynamic subtest: pipe-A-eDP-1
[189.906901] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.953s)
[189.936317] Starting dynamic subtest: pipe-D-eDP-1
[192.540191] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.610s)
[192.542224] Subtest cursor-offscreen-64x64: SUCCESS (4.588s)
[193.408675] [033/133] (827s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[193.500737] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[193.505338] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[193.627627] [034/133] (827s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[193.723550] Starting subtest: yf-tiled-64bpp-rotate-90
[193.727708] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[193.805761] [035/133] (827s left) api_intel_bb (destroy-bb)
[193.856172] Starting subtest: destroy-bb
[193.863220] Subtest destroy-bb: SUCCESS (0.007s)
[193.975128] [036/133] (826s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[194.030507] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[194.034816] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[194.227678] [037/133] (826s left) kms_lease (cursor-implicit-plane)
[194.318464] Starting subtest: cursor-implicit-plane
[194.320832] Starting dynamic subtest: pipe-A-eDP-1
[194.777677] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.460s)
[194.792653] Starting dynamic subtest: pipe-B-eDP-1
[195.912133] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.131s)
[195.922872] Starting dynamic subtest: pipe-C-eDP-1
[197.037822] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.126s)
[197.046596] Starting dynamic subtest: pipe-D-eDP-1
[198.166193] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.128s)
[198.168612] Subtest cursor-implicit-plane: SUCCESS (3.850s)
[199.031789] [038/133] (821s left) gem_partial_pwrite_pread (reads)
[199.091218] Subtest reads: SKIP (0.000s)
[199.163746] [039/133] (821s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[199.256562] Starting subtest: bad-aux-stride-y-tiled-ccs
[199.258923] Starting dynamic subtest: pipe-A-eDP-1
[199.282037] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[199.300644] Starting dynamic subtest: pipe-B-eDP-1
[199.322767] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[199.334887] Starting dynamic subtest: pipe-C-eDP-1
[199.355432] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[199.363582] Starting dynamic subtest: pipe-D-eDP-1
[199.386464] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[199.390792] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.004s)
[201.403277] [040/133] (819s left) gem_exec_schedule (u-semaphore-resolve)
[201.480844] Starting subtest: u-semaphore-resolve
[201.517163] Subtest u-semaphore-resolve: SUCCESS (0.038s)
[201.860223] [041/133] (819s left) kms_cursor_crc (cursor-random-64x64)
[202.040095] Starting subtest: cursor-random-64x64
[202.042569] Starting dynamic subtest: pipe-A-eDP-1
[205.394460] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.352s)
[205.422288] Starting dynamic subtest: pipe-D-eDP-1
[209.427251] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.014s)
[209.429575] Subtest cursor-random-64x64: SUCCESS (7.391s)
[210.261875] [042/133] (810s left) syncobj_timeline (reset-signaled)
[210.324031] Starting subtest: reset-signaled
[210.326387] Subtest reset-signaled: SUCCESS (0.000s)
[210.404622] [043/133] (810s left) syncobj_eventfd (timeline-wait)
[210.454398] Starting subtest: timeline-wait
[210.463479] Subtest timeline-wait: SUCCESS (0.010s)
[210.548241] [044/133] (810s left) gem_mmap_gtt (basic-small-copy-odd)
[210.616379] Subtest basic-small-copy-odd: SKIP (0.000s)
[210.676840] [045/133] (810s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[210.790949] Starting subtest: psr-2p-pri-indfb-multidraw
[210.795092] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[210.902985] [046/133] (810s left) gem_exec_balancer (bonded-false-hang)
[211.146346] Starting subtest: bonded-false-hang
[211.150908] Subtest bonded-false-hang: SKIP (0.000s)
[211.239997] [047/133] (810s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[211.616610] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[212.393738] [048/133] (809s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[212.493438] Starting subtest: fbc-psr2-primary-mmap-gtt
[212.495762] Starting dynamic subtest: eDP-1
[212.500355] Dynamic subtest eDP-1: SKIP (0.000s)
[212.504909] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s)
[212.563721] [049/133] (808s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[212.679780] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[212.683989] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[212.766444] [050/133] (808s left) kms_color (invalid-gamma-lut-sizes)
[212.856741] Starting subtest: invalid-gamma-lut-sizes
[212.859164] Starting dynamic subtest: pipe-A
[213.149580] Dynamic subtest pipe-A: SUCCESS (0.291s)
[213.159269] Starting dynamic subtest: pipe-B
[213.161451] Dynamic subtest pipe-B: SUCCESS (0.000s)
[213.170137] Starting dynamic subtest: pipe-C
[213.172373] Dynamic subtest pipe-C: SUCCESS (0.000s)
[213.181781] Starting dynamic subtest: pipe-D
[213.183949] Dynamic subtest pipe-D: SUCCESS (0.000s)
[213.186770] Subtest invalid-gamma-lut-sizes: SUCCESS (0.294s)
[213.945319] [051/133] (807s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[214.039814] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[214.044330] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[214.111053] [052/133] (807s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[214.193902] Starting subtest: primary-yf-tiled-reflect-x-180
[214.254831] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.059s)
[214.356477] [053/133] (807s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[214.456947] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[214.461162] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[214.561458] [054/133] (807s left) perf_pmu (busy-check-all)
[214.603529] Starting subtest: busy-check-all
[214.605676] Starting dynamic subtest: rcs0
[215.150909] Dynamic subtest rcs0: SUCCESS (0.550s)
[215.163403] Starting dynamic subtest: bcs0
[215.701911] Dynamic subtest bcs0: SUCCESS (0.549s)
[215.713303] Starting dynamic subtest: vcs0
[217.700711] Dynamic subtest vcs0: SUCCESS (1.996s)
[217.712920] Starting dynamic subtest: vcs1
[219.685147] Dynamic subtest vcs1: SUCCESS (1.983s)
[219.695373] Starting dynamic subtest: vecs0
[221.669545] Dynamic subtest vecs0: SUCCESS (1.982s)
[221.681262] Starting dynamic subtest: ccs0
[222.223310] Dynamic subtest ccs0: SUCCESS (0.554s)
[222.225756] Subtest busy-check-all: SUCCESS (7.626s)
[222.354680] [055/133] (799s left) gem_sync (basic-store-each)
[222.417869] Starting subtest: basic-store-each
[224.954564] Subtest basic-store-each: SUCCESS (2.547s)
[225.141663] [056/133] (796s left) gem_spin_batch (spin-all-new)
[225.191169] Starting subtest: spin-all-new
[225.213566] Subtest spin-all-new: SUCCESS (0.022s)
[226.764193] [057/133] (794s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[226.862698] Starting subtest: 2x-flip-vs-rmfb-interruptible
[226.873977] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.010s)
[226.949982] [058/133] (794s left) gem_exec_schedule (preempt)
[227.020702] Starting subtest: preempt
[227.022836] Starting dynamic subtest: rcs0
[227.034661] Dynamic subtest rcs0: SUCCESS (0.022s)
[227.043762] Starting dynamic subtest: bcs0
[227.055131] Dynamic subtest bcs0: SUCCESS (0.020s)
[227.064984] Starting dynamic subtest: vcs0
[227.075164] Dynamic subtest vcs0: SUCCESS (0.020s)
[227.084831] Starting dynamic subtest: vcs1
[227.096528] Dynamic subtest vcs1: SUCCESS (0.020s)
[227.106448] Starting dynamic subtest: vecs0
[227.117910] Dynamic subtest vecs0: SUCCESS (0.021s)
[227.127743] Starting dynamic subtest: ccs0
[227.141491] Dynamic subtest ccs0: SUCCESS (0.023s)
[227.143831] Subtest preempt: SUCCESS (0.129s)
[228.810984] [059/133] (793s left) kms_dsc (dsc-with-bpc-formats)
[228.903296] Starting subtest: dsc-with-bpc-formats
[229.016855] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[229.053397] [060/133] (792s left) kms_cursor_legacy (forked-move)
[229.169478] Starting subtest: forked-move
[229.171377] Starting dynamic subtest: pipe-A
[234.623757] Dynamic subtest pipe-A: SUCCESS (5.453s)
[234.644061] Starting dynamic subtest: pipe-B
[240.092472] Dynamic subtest pipe-B: SUCCESS (5.465s)
[240.107460] Starting dynamic subtest: pipe-C
[245.566980] Dynamic subtest pipe-C: SUCCESS (5.471s)
[245.578412] Starting dynamic subtest: pipe-D
[251.044165] Dynamic subtest pipe-D: SUCCESS (5.474s)
[251.054774] Starting dynamic subtest: all-pipes
[256.534669] Dynamic subtest all-pipes: SUCCESS (5.487s)
[256.537354] Subtest forked-move: SUCCESS (27.359s)
[256.689905] [061/133] (765s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[256.783844] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[256.787971] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[256.889525] [062/133] (765s left) i915_drm_fdinfo (busy-idle-check-all)
[256.932744] Starting subtest: busy-idle-check-all
[256.935080] Starting dynamic subtest: rcs0
[256.939738] Dynamic subtest rcs0: SKIP (0.003s)
[256.949306] Starting dynamic subtest: bcs0
[256.958573] Dynamic subtest bcs0: SKIP (0.000s)
[256.966636] Starting dynamic subtest: vcs0
[256.971065] Dynamic subtest vcs0: SKIP (0.000s)
[256.979095] Starting dynamic subtest: vcs1
[256.983507] Dynamic subtest vcs1: SKIP (0.000s)
[256.991502] Starting dynamic subtest: vecs0
[256.995914] Dynamic subtest vecs0: SKIP (0.000s)
[257.003911] Starting dynamic subtest: ccs0
[257.008360] Dynamic subtest ccs0: SKIP (0.000s)
[257.012709] Subtest busy-idle-check-all: SKIP (0.007s)
[257.047269] [063/133] (764s left) gem_eio (in-flight-1us)
[257.314520] Starting subtest: in-flight-1us
[265.650901] Subtest in-flight-1us: SUCCESS (8.335s)
[265.819840] [FACT gem_eio (in-flight-1us)] new: kernel.kmod_is_loaded.vgem: true
[265.823304] [064/133] (756s left) kms_async_flips (test-cursor-atomic)
[265.914130] Starting subtest: test-cursor-atomic
[265.918216] Subtest test-cursor-atomic: SKIP (0.000s)
[267.090162] [065/133] (754s left) gem_ctx_isolation (preservation)
[267.156819] Starting subtest: preservation
[267.159374] Starting dynamic subtest: rcs0
[267.297775] Dynamic subtest rcs0: SUCCESS (0.141s)
[267.310331] Starting dynamic subtest: bcs0
[267.448721] Dynamic subtest bcs0: SUCCESS (0.150s)
[267.457783] Starting dynamic subtest: vcs0
[267.587845] Dynamic subtest vcs0: SUCCESS (0.139s)
[267.598803] Starting dynamic subtest: vcs1
[268.809262] Dynamic subtest vcs1: SUCCESS (1.221s)
[268.818198] Starting dynamic subtest: vecs0
[270.811167] Dynamic subtest vecs0: SUCCESS (2.001s)
[270.822922] Starting dynamic subtest: ccs0
[272.824622] Dynamic subtest ccs0: SUCCESS (2.012s)
[272.827170] Subtest preservation: SUCCESS (5.669s)
[273.051471] [066/133] (749s left) gem_exec_whisper (basic-fds-all)
[273.117601] Starting subtest: basic-fds-all
[286.660532] Subtest basic-fds-all: SUCCESS (13.544s)
[286.846914] [067/133] (735s left) kms_cursor_crc (cursor-sliding-64x64)
[287.038607] Starting subtest: cursor-sliding-64x64
[287.043320] Starting dynamic subtest: pipe-A-eDP-1
[290.258637] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.216s)
[290.286889] Starting dynamic subtest: pipe-D-eDP-1
[294.137740] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.856s)
[294.140044] Subtest cursor-sliding-64x64: SUCCESS (7.097s)
[294.935451] [068/133] (727s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[295.032135] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[295.036414] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[295.105760] [069/133] (727s left) i915_query (query-regions-garbage-items)
[295.158701] Starting subtest: query-regions-garbage-items
[295.160981] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[295.253386] [070/133] (727s left) kms_psr (psr-cursor-blt)
[295.341094] Starting subtest: psr-cursor-blt
[295.343434] Starting dynamic subtest: eDP-1
[297.023497] Dynamic subtest eDP-1: SUCCESS (1.682s)
[297.025363] Subtest psr-cursor-blt: SUCCESS (1.683s)
[297.892909] [071/133] (724s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[298.004305] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[305.330378] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.332s)
[305.477561] [072/133] (716s left) kms_plane_scaling (2x-scaler-multi-pipe)
[305.573304] Starting subtest: 2x-scaler-multi-pipe
[305.577775] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[305.673041] [073/133] (716s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[305.773186] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[310.092682] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.323s)
[311.240136] [074/133] (711s left) kms_rotation_crc (primary-rotation-180)
[311.337760] Starting subtest: primary-rotation-180
[318.312170] Subtest primary-rotation-180: SUCCESS (6.978s)
[319.472525] [075/133] (702s left) gem_mmap_wc (write-prefaulted)
[319.527825] Subtest write-prefaulted: SKIP (0.000s)
[319.596444] [076/133] (702s left) i915_pm_freq_api (freq-reset-multiple)
[319.652628] Starting subtest: freq-reset-multiple
[319.654886] Starting dynamic subtest: gt0
[329.493840] Dynamic subtest gt0: SUCCESS (9.844s)
[329.502586] Starting dynamic subtest: gt1
[337.891963] Dynamic subtest gt1: SUCCESS (8.396s)
[337.894366] Subtest freq-reset-multiple: SUCCESS (18.242s)
[337.967368] [077/133] (684s left) gem_exec_suspend (basic-s4-devices)
[338.036453] Starting subtest: basic-S4-devices
[338.038690] Starting dynamic subtest: smem
[349.669634] Dynamic subtest smem: SUCCESS (11.637s)
[349.672839] Subtest basic-S4-devices: SUCCESS (11.640s)
[355.872617] [078/133] (672s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[355.984204] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[355.986562] Starting dynamic subtest: pipe-A-eDP-1
[356.009882] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[356.021093] Starting dynamic subtest: pipe-B-eDP-1
[356.042483] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[356.050950] Starting dynamic subtest: pipe-C-eDP-1
[356.072624] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[356.081347] Starting dynamic subtest: pipe-D-eDP-1
[356.104179] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[356.108831] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.005s)
[358.222263] [079/133] (670s left) prime_self_import (basic-with_one_bo)
[358.262936] Starting subtest: basic-with_one_bo
[358.281317] Subtest basic-with_one_bo: SUCCESS (0.019s)
[358.401198] [080/133] (670s left) kms_flip (dpms-vs-vblank-race-interruptible)
[358.492316] Starting subtest: dpms-vs-vblank-race-interruptible
[358.494600] Starting dynamic subtest: A-eDP1
[362.280556] Dynamic subtest A-eDP1: SUCCESS (3.784s)
[362.290734] Starting dynamic subtest: B-eDP1
[366.901993] Dynamic subtest B-eDP1: SUCCESS (4.618s)
[366.912186] Starting dynamic subtest: C-eDP1
[371.513226] Dynamic subtest C-eDP1: SUCCESS (4.608s)
[371.523320] Starting dynamic subtest: D-eDP1
[376.124182] Dynamic subtest D-eDP1: SUCCESS (4.609s)
[376.126503] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (17.634s)
[377.001417] [081/133] (651s left) gem_media_vme
[377.133821] [082/133] (651s left) kms_scaling_modes (scaling-mode-full)
[377.226996] Starting subtest: scaling-mode-full
[377.229306] Starting dynamic subtest: pipe-A-eDP-1
[377.320355] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.096s)
[377.333881] Starting dynamic subtest: pipe-B-eDP-1
[378.529780] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.205s)
[378.540480] Starting dynamic subtest: pipe-C-eDP-1
[379.630091] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.099s)
[379.643009] Starting dynamic subtest: pipe-D-eDP-1
[380.760391] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.127s)
[380.762549] Subtest scaling-mode-full: SUCCESS (3.537s)
[381.938562] [083/133] (646s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[382.035329] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[382.039418] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[382.132092] [084/133] (646s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[382.222952] Starting subtest: fbc-psr2-sprite-plane-onoff
[382.225215] Starting dynamic subtest: eDP-1
[382.229373] Dynamic subtest eDP-1: SKIP (0.000s)
[382.233626] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[382.297918] [085/133] (646s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[382.388298] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[382.390462] Starting dynamic subtest: pipe-A-eDP-1
[382.410507] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[382.427188] Starting dynamic subtest: pipe-B-eDP-1
[382.445827] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[382.454608] Starting dynamic subtest: pipe-C-eDP-1
[382.473259] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[382.482330] Starting dynamic subtest: pipe-D-eDP-1
[382.500764] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[382.502638] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.006s)
[384.693773] [086/133] (644s left) kms_plane (plane-position-hole)
[384.784358] Starting subtest: plane-position-hole
[385.297959] Starting dynamic subtest: pipe-A-plane-1
[386.582539] Dynamic subtest pipe-A-plane-1: SUCCESS (1.286s)
[386.593093] Starting dynamic subtest: pipe-A-plane-2
[387.906436] Dynamic subtest pipe-A-plane-2: SUCCESS (1.321s)
[387.916841] Starting dynamic subtest: pipe-A-plane-3
[389.180558] Dynamic subtest pipe-A-plane-3: SUCCESS (1.274s)
[389.189933] Starting dynamic subtest: pipe-A-plane-4
[390.519666] Dynamic subtest pipe-A-plane-4: SUCCESS (1.339s)
[390.529798] Starting dynamic subtest: pipe-A-plane-5
[390.549618] Dynamic subtest pipe-A-plane-5: SUCCESS (0.029s)
[391.751385] Starting dynamic subtest: pipe-B-plane-1
[393.062401] Dynamic subtest pipe-B-plane-1: SUCCESS (1.322s)
[393.072089] Starting dynamic subtest: pipe-B-plane-2
[394.367831] Dynamic subtest pipe-B-plane-2: SUCCESS (1.307s)
[394.377881] Starting dynamic subtest: pipe-B-plane-3
[395.607586] Dynamic subtest pipe-B-plane-3: SUCCESS (1.237s)
[395.618030] Starting dynamic subtest: pipe-B-plane-4
[396.920343] Dynamic subtest pipe-B-plane-4: SUCCESS (1.311s)
[396.930719] Starting dynamic subtest: pipe-B-plane-5
[396.943905] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[396.946159] Subtest plane-position-hole: SUCCESS (12.161s)
[397.723787] [087/133] (631s left) perf (invalid-create-userspace-config)
[397.841578] Starting subtest: invalid-create-userspace-config
[397.843685] Subtest invalid-create-userspace-config: SUCCESS (0.001s)
[397.891459] [088/133] (631s left) syncobj_wait (invalid-signal-zero-handles)
[397.946182] Starting subtest: invalid-signal-zero-handles
[397.948511] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[398.039125] [089/133] (631s left) kms_getfb (getfb-handle-valid)
[398.136895] Starting subtest: getfb-handle-valid
[398.139147] Subtest getfb-handle-valid: SUCCESS (0.000s)
[398.245576] [090/133] (630s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[398.311091] Starting subtest: x-tiled-to-vebox-y-tiled
[398.315661] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[398.493528] [091/133] (630s left) gem_exec_fence (submit3)
[398.675789] Starting subtest: submit3
[398.680443] Subtest submit3: SKIP (0.000s)
[400.762394] [092/133] (628s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier)
[400.851858] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier
[400.856070] Subtest pixel-format-4-tiled-bmg-ccs-modifier: SKIP (0.000s)
[400.940576] [093/133] (628s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[400.994203] Starting subtest: invalid-bsd2-flag-on-vebox
[400.996462] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[401.078445] [094/133] (628s left) kms_async_flips (crc)
[401.169324] Starting subtest: crc
[401.543890] Starting dynamic subtest: pipe-A-eDP-1
[404.432102] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.886s)
[404.807135] Starting dynamic subtest: pipe-B-eDP-1
[407.677251] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.878s)
[408.048406] Starting dynamic subtest: pipe-C-eDP-1
[410.975999] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.936s)
[411.345038] Starting dynamic subtest: pipe-D-eDP-1
[414.207825] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.872s)
[414.210035] Subtest crc: SUCCESS (13.042s)
[415.389310] [095/133] (613s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[415.513776] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[416.116012] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.603s)
[416.258281] [096/133] (613s left) prime_vgem (fence-wait)
[416.346311] Starting subtest: fence-wait
[416.348622] Starting dynamic subtest: rcs0
[417.397675] Dynamic subtest rcs0: SUCCESS (1.052s)
[417.409484] Starting dynamic subtest: bcs0
[418.453726] Dynamic subtest bcs0: SUCCESS (1.054s)
[418.466301] Starting dynamic subtest: vcs0
[419.497360] Dynamic subtest vcs0: SUCCESS (1.042s)
[419.509812] Starting dynamic subtest: vcs1
[420.539806] Dynamic subtest vcs1: SUCCESS (1.040s)
[420.552335] Starting dynamic subtest: vecs0
[421.582469] Dynamic subtest vecs0: SUCCESS (1.040s)
[421.595818] Starting dynamic subtest: ccs0
[422.680445] Dynamic subtest ccs0: SUCCESS (1.095s)
[422.683696] Subtest fence-wait: SUCCESS (6.336s)
[422.817220] [097/133] (606s left) gem_wait (wait)
[422.893990] Starting subtest: wait
[422.896394] Starting dynamic subtest: all-engines
[424.676493] Dynamic subtest all-engines: SUCCESS (1.780s)
[424.692260] Starting dynamic subtest: rcs0
[425.724960] Dynamic subtest rcs0: SUCCESS (1.047s)
[425.742691] Starting dynamic subtest: bcs0
[426.771938] Dynamic subtest bcs0: SUCCESS (1.044s)
[426.783470] Starting dynamic subtest: vcs0
[427.816289] Dynamic subtest vcs0: SUCCESS (1.043s)
[427.828640] Starting dynamic subtest: vcs1
[428.861505] Dynamic subtest vcs1: SUCCESS (1.043s)
[428.873218] Starting dynamic subtest: vecs0
[429.907202] Dynamic subtest vecs0: SUCCESS (1.043s)
[429.919698] Starting dynamic subtest: ccs0
[430.955452] Dynamic subtest ccs0: SUCCESS (1.046s)
[430.958000] Subtest wait: SUCCESS (8.063s)
[431.153545] [098/133] (598s left) gem_workarounds (basic-read)
[431.222877] Starting subtest: basic-read
[431.246281] Subtest basic-read: SUCCESS (0.024s)
[431.363195] [099/133] (598s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[431.464442] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[431.468861] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[431.549754] [100/133] (597s left) kms_pm_dc (dc5-dpms-negative)
[432.660216] Starting subtest: dc5-dpms-negative
[432.664784] Subtest dc5-dpms-negative: SKIP (0.000s)
[432.733782] [101/133] (596s left) gem_ctx_shared (single-timeline)
[432.803139] Starting subtest: single-timeline
[432.823027] Subtest single-timeline: SUCCESS (0.013s)
[433.069644] [102/133] (596s left) kms_pipe_crc_basic (suspend-read-crc)
[433.169063] Starting subtest: suspend-read-crc
[433.171784] Starting dynamic subtest: pipe-A-eDP-1
[450.979548] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.569s)
[450.990165] Starting dynamic subtest: pipe-B-eDP-1
[468.927860] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.171s)
[468.938407] Starting dynamic subtest: pipe-C-eDP-1
[486.899285] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.023s)
[486.908500] Starting dynamic subtest: pipe-D-eDP-1
[504.894683] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.060s)
[504.897163] Subtest suspend-read-crc: SUCCESS (11.830s)
[505.693853] [103/133] (523s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[505.811458] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[515.062552] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.370s)
[515.175594] [104/133] (514s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[515.264124] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[515.266859] Starting dynamic subtest: pipe-A-eDP-1
[515.293535] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[515.306310] Starting dynamic subtest: pipe-B-eDP-1
[515.332167] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[515.341738] Starting dynamic subtest: pipe-C-eDP-1
[515.366746] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[515.376072] Starting dynamic subtest: pipe-D-eDP-1
[515.402254] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[515.407076] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[517.548011] [105/133] (512s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[517.641945] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[517.646957] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[517.727070] [106/133] (512s left) gem_exec_reloc (basic-write-cpu-active)
[517.786534] Subtest basic-write-cpu-active: SKIP (0.000s)
[517.867920] [107/133] (511s left) kms_addfb_basic (bad-pitch-1024)
[517.926576] Starting subtest: bad-pitch-1024
[517.929119] Subtest bad-pitch-1024: SUCCESS (0.000s)
[518.047615] [108/133] (511s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[518.113122] Starting subtest: single-wait-for-submit-available-signaled
[518.115829] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[518.224615] [109/133] (511s left) syncobj_timeline (invalid-signal-bad-pad)
[518.278243] Starting subtest: invalid-signal-bad-pad
[518.281068] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[518.360490] [110/133] (511s left) fbdev (info)
[518.398760] Starting subtest: info
[518.401190] Subtest info: SUCCESS (0.000s)
[518.472012] [111/133] (511s left) kms_content_protection (dp-mst-type-0-hdcp14)
[518.607021] Starting subtest: dp-mst-type-0-hdcp14
[518.611849] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s)
[518.733639] [112/133] (511s left) i915_pm_rpm (gem-pread)
[520.964183] Starting subtest: gem-pread
[523.043478] Subtest gem-pread: SUCCESS (2.089s)
[523.157415] [113/133] (506s left) kms_frontbuffer_tracking (fbc-tiling-4)
[523.249283] Starting subtest: fbc-tiling-4
[527.393733] Subtest fbc-tiling-4: SUCCESS (4.157s)
[528.526522] [114/133] (501s left) kms_rotation_crc (sprite-rotation-180)
[528.636821] Starting subtest: sprite-rotation-180
[535.547685] Subtest sprite-rotation-180: SUCCESS (6.919s)
[536.761059] [115/133] (493s left) kms_pm_rpm (modeset-non-lpsp-stress)
[539.005596] Starting subtest: modeset-non-lpsp-stress
[540.160845] Subtest modeset-non-lpsp-stress: SKIP (1.156s)
[540.547275] [116/133] (489s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[540.658834] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[540.663947] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[540.753689] [117/133] (489s left) kms_invalid_mode (bad-hsync-end)
[540.853741] Starting subtest: bad-hsync-end
[540.856108] Starting dynamic subtest: pipe-A-eDP-1
[541.137575] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.282s)
[541.148208] Starting dynamic subtest: pipe-B-eDP-1
[541.150973] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[541.160465] Starting dynamic subtest: pipe-C-eDP-1
[541.162875] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[541.173760] Starting dynamic subtest: pipe-D-eDP-1
[541.175898] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[541.178407] Subtest bad-hsync-end: SUCCESS (0.288s)
[541.968570] [118/133] (488s left) kms_psr (pr-basic)
[542.058326] Starting subtest: pr-basic
[542.063212] Subtest pr-basic: SKIP (0.000s)
[542.144676] [119/133] (488s left) gem_mmap_offset (bad-object)
[542.198118] Starting subtest: bad-object
[542.201039] Subtest bad-object: SUCCESS (0.001s)
[542.297533] [120/133] (488s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[542.385020] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[542.390030] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[542.484173] [121/133] (487s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[542.577057] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[549.106289] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.532s)
[549.219373] [122/133] (481s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[549.310267] Starting subtest: fbc-rgb565-draw-mmap-cpu
[553.287186] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (3.980s)
[554.491881] [123/133] (475s left) gem_eio (throttle)
[554.702030] Starting subtest: throttle
[555.024292] Subtest throttle: SUCCESS (0.322s)
[555.135518] [124/133] (475s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[555.234317] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[555.236642] Starting dynamic subtest: pipe-A-default-mode
[557.905286] Dynamic subtest pipe-A-default-mode: SUCCESS (2.671s)
[557.908268] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.672s)
[558.773561] [125/133] (471s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[558.874287] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[558.876798] Starting dynamic subtest: pipe-A
[558.895136] Dynamic subtest pipe-A: SKIP (0.017s)
[558.906250] Starting dynamic subtest: pipe-B
[558.926165] Dynamic subtest pipe-B: SKIP (0.030s)
[558.936311] Starting dynamic subtest: pipe-C
[558.956006] Dynamic subtest pipe-C: SKIP (0.029s)
[558.965925] Starting dynamic subtest: pipe-D
[558.988713] Dynamic subtest pipe-D: SKIP (0.030s)
[558.993638] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.109s)
[559.085684] [126/133] (471s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[559.196142] Starting subtest: 4-tiled-32bpp-rotate-90
[559.216064] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.019s)
[559.340046] [127/133] (471s left) kms_vblank (wait-forked)
[559.431067] Starting subtest: wait-forked
[559.433769] Starting dynamic subtest: pipe-A-eDP-1
[561.250940] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.820s)
[561.267754] Starting dynamic subtest: pipe-D-eDP-1
[563.768185] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.514s)
[563.771090] Subtest wait-forked: SUCCESS (4.338s)
[564.639940] [128/133] (466s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[564.770015] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[566.233084] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.464s)
[567.123204] [129/133] (463s left) gem_create (create-ext-set-pat)
[567.301167] Starting subtest: create-ext-set-pat
[567.303895] Subtest create-ext-set-pat: SUCCESS (0.001s)
[567.383869] [130/133] (463s left) kms_flip (flip-vs-modeset-vs-hang)
[567.479926] Starting subtest: flip-vs-modeset-vs-hang
[567.482295] Starting dynamic subtest: A-eDP1
[571.806101] Dynamic subtest A-eDP1: SUCCESS (4.328s)
[571.817171] Starting dynamic subtest: D-eDP1
[575.345608] Dynamic subtest D-eDP1: SUCCESS (3.540s)
[575.347932] Subtest flip-vs-modeset-vs-hang: SUCCESS (7.874s)
[575.716269] [131/133] (455s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[575.813821] Starting subtest: x-tiled-64bpp-rotate-270
[575.833266] Subtest x-tiled-64bpp-rotate-270: SKIP (0.019s)
[575.938114] [132/133] (454s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[576.032452] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[576.034889] Starting dynamic subtest: pipe-A-eDP-1
[587.029004] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.004s)
[587.038995] Starting dynamic subtest: pipe-B-eDP-1
[598.743290] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.713s)
[598.746153] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (22.721s)
[599.565571] [133/133] (431s left) kms_big_fb (linear-32bpp-rotate-180)
[599.678906] Starting subtest: linear-32bpp-rotate-180
[601.303550] Subtest linear-32bpp-rotate-180: SUCCESS (1.624s)
[601.430971] Closing watchdogs
results: parsing output: 0/ for test: kms_chamelium_audio
results: parsing output: 1/ for test: prime_mmap_coherency
results: parsing output: 2/ for test: kms_plane
results: parsing output: 3/ for test: sysfs_heartbeat_interval
results: parsing output: 4/ for test: gem_mmap_gtt
results: parsing output: 5/ for test: kms_cursor_legacy
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: kms_tiled_display
results: parsing output: 10/ for test: perf_pmu
results: parsing output: 11/ for test: api_intel_allocator
results: parsing output: 12/ for test: gem_ctx_persistence
results: parsing output: 13/ for test: sw_sync
results: parsing output: 14/ for test: gem_exec_whisper
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: gen9_exec_parse
results: parsing output: 17/ for test: kms_atomic_interruptible
results: parsing output: 18/ for test: syncobj_timeline
results: parsing output: 19/ for test: gem_ctx_bad_destroy
results: parsing output: 20/ for test: gem_exec_basic
results: parsing output: 21/ for test: gem_ctx_param
results: parsing output: 22/ for test: gem_render_copy
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: gem_exec_schedule
results: parsing output: 25/ for test: core_setmaster
results: parsing output: 26/ for test: gem_bad_reloc
results: parsing output: 27/ for test: kms_chamelium_hpd
results: parsing output: 28/ for test: kms_properties
results: parsing output: 29/ for test: syncobj_wait
results: parsing output: 30/ for test: gen3_render_tiledy_blits
results: parsing output: 31/ for test: kms_cursor_crc
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: api_intel_bb
results: parsing output: 35/ for test: gem_render_copy
results: parsing output: 36/ for test: kms_lease
results: parsing output: 37/ for test: gem_partial_pwrite_pread
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: gem_exec_schedule
results: parsing output: 40/ for test: kms_cursor_crc
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: syncobj_eventfd
results: parsing output: 43/ for test: gem_mmap_gtt
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_exec_balancer
results: parsing output: 46/ for test: kms_chamelium_edid
results: parsing output: 47/ for test: kms_psr
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_color
results: parsing output: 50/ for test: kms_psr2_sf
results: parsing output: 51/ for test: kms_rotation_crc
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: perf_pmu
results: parsing output: 54/ for test: gem_sync
results: parsing output: 55/ for test: gem_spin_batch
results: parsing output: 56/ for test: kms_flip
results: parsing output: 57/ for test: gem_exec_schedule
results: parsing output: 58/ for test: kms_dsc
results: parsing output: 59/ for test: kms_cursor_legacy
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: i915_drm_fdinfo
results: parsing output: 62/ for test: gem_eio
results: parsing output: 63/ for test: kms_async_flips
results: parsing output: 64/ for test: gem_ctx_isolation
results: parsing output: 65/ for test: gem_exec_whisper
results: parsing output: 66/ for test: kms_cursor_crc
results: parsing output: 67/ for test: kms_flip_scaled_crc
results: parsing output: 68/ for test: i915_query
results: parsing output: 69/ for test: kms_psr
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_plane_scaling
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_rotation_crc
results: parsing output: 74/ for test: gem_mmap_wc
results: parsing output: 75/ for test: i915_pm_freq_api
results: parsing output: 76/ for test: gem_exec_suspend
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: prime_self_import
results: parsing output: 79/ for test: kms_flip
results: parsing output: 80/ for test: gem_media_vme
results: parsing output: 81/ for test: kms_scaling_modes
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_psr
results: parsing output: 84/ for test: kms_ccs
results: parsing output: 85/ for test: kms_plane
results: parsing output: 86/ for test: perf
results: parsing output: 87/ for test: syncobj_wait
results: parsing output: 88/ for test: kms_getfb
results: parsing output: 89/ for test: gem_render_copy
results: parsing output: 90/ for test: gem_exec_fence
results: parsing output: 91/ for test: kms_plane
results: parsing output: 92/ for test: gem_exec_params
results: parsing output: 93/ for test: kms_async_flips
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: prime_vgem
results: parsing output: 96/ for test: gem_wait
results: parsing output: 97/ for test: gem_workarounds
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_pm_dc
results: parsing output: 100/ for test: gem_ctx_shared
results: parsing output: 101/ for test: kms_pipe_crc_basic
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_ccs
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: gem_exec_reloc
results: parsing output: 106/ for test: kms_addfb_basic
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: syncobj_timeline
results: parsing output: 109/ for test: fbdev
results: parsing output: 110/ for test: kms_content_protection
results: parsing output: 111/ for test: i915_pm_rpm
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_rotation_crc
results: parsing output: 114/ for test: kms_pm_rpm
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_invalid_mode
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: gem_mmap_offset
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: gem_eio
results: parsing output: 123/ for test: kms_flip_scaled_crc
results: parsing output: 124/ for test: kms_plane_scaling
results: parsing output: 125/ for test: kms_big_fb
results: parsing output: 126/ for test: kms_vblank
results: parsing output: 127/ for test: kms_cursor_legacy
results: parsing output: 128/ for test: gem_create
results: parsing output: 129/ for test: kms_flip
results: parsing output: 130/ for test: kms_big_fb
results: parsing output: 131/ for test: kms_psr2_sf
results: parsing output: 132/ for test: kms_big_fb
Done.