[56.526966] Initializing watchdogs
[56.527027]   /dev/watchdog0
[56.544818] [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]
[56.549311] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.551812] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.555338] [001/133] (960s left) kms_getfb (getfb2-handle-protection)
[56.675145] Starting subtest: getfb2-handle-protection
[56.699789] Subtest getfb2-handle-protection: SUCCESS (0.026s)
[56.839858] [002/133] (960s left) gem_ctx_persistence (smoketest)
[56.904572] Starting subtest: smoketest
[97.847033] Subtest smoketest: SUCCESS (40.967s)
[97.948299] [003/133] (919s left) kms_cursor_edge_walk (64x64-top-bottom)
[98.055041] Starting subtest: 64x64-top-bottom
[98.057456] Starting dynamic subtest: pipe-A-eDP-1
[101.586388] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.531s)
[101.595783] Starting dynamic subtest: pipe-D-eDP-1
[104.749544] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.161s)
[104.751498] Subtest 64x64-top-bottom: SUCCESS (6.694s)
[105.571020] [004/133] (911s left) sysfs_timeslice_duration (duration)
[105.627650] Starting subtest: duration
[105.630098] Starting dynamic subtest: vecs0
[118.835969] Dynamic subtest vecs0: SUCCESS (13.206s)
[118.846725] Starting dynamic subtest: ccs0
[132.007549] Dynamic subtest ccs0: SUCCESS (13.170s)
[132.017843] Starting dynamic subtest: vcs0
[146.805839] Dynamic subtest vcs0: SUCCESS (14.796s)
[146.816760] Starting dynamic subtest: bcs0
[159.962361] Dynamic subtest bcs0: SUCCESS (13.157s)
[159.972778] Starting dynamic subtest: rcs0
[173.137542] Dynamic subtest rcs0: SUCCESS (13.174s)
[173.145986] Starting dynamic subtest: vcs1
[187.829089] Dynamic subtest vcs1: SUCCESS (14.689s)
[187.832614] Subtest duration: SUCCESS (82.199s)
[187.919977] [005/133] (829s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[188.034033] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[195.123036] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (7.093s)
[195.278097] [006/133] (821s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[195.383783] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[195.388235] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[196.504677] [007/133] (820s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[196.595227] Starting subtest: plane-all-modeset-transition-fencing
[196.599691] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[196.678255] [008/133] (820s left) gem_mmap_gtt (cpuset-big-copy-xy)
[196.731572] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[196.799763] [009/133] (820s left) i915_hangman (error-state-basic)
[196.859508] Starting subtest: error-state-basic
[196.971525] Subtest error-state-basic: SUCCESS (0.113s)
[197.065536] [010/133] (820s left) kms_cursor_crc (cursor-offscreen-32x32)
[197.227670] Starting subtest: cursor-offscreen-32x32
[197.274980] Subtest cursor-offscreen-32x32: SKIP (0.042s)
[197.558052] [011/133] (819s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[197.645082] Starting subtest: nonblocking-crc-frame-sequence
[197.646944] Starting dynamic subtest: pipe-A-eDP-1
[198.380736] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.735s)
[198.391108] Starting dynamic subtest: pipe-B-eDP-1
[199.814897] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.432s)
[199.824730] Starting dynamic subtest: pipe-C-eDP-1
[201.191588] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.375s)
[201.201366] Starting dynamic subtest: pipe-D-eDP-1
[202.528841] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.335s)
[202.530882] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.882s)
[203.351242] [012/133] (814s left) perf (oa-formats)
[203.480762] Starting subtest: oa-formats
[203.482639] Starting dynamic subtest: 0-rcs0
[203.494435] Dynamic subtest 0-rcs0: SUCCESS (0.015s)
[203.503489] Starting dynamic subtest: 1-vcs0
[203.516124] Dynamic subtest 1-vcs0: SUCCESS (0.021s)
[203.518493] Subtest oa-formats: SUCCESS (0.037s)
[203.564295] [013/133] (813s left) syncobj_wait (wait-delayed-signal)
[203.634611] Starting subtest: wait-delayed-signal
[203.736317] Subtest wait-delayed-signal: SUCCESS (0.102s)
[203.822049] [014/133] (813s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[203.925223] Starting subtest: pr-overlay-plane-move-continuous-sf
[203.929695] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[204.000337] [015/133] (813s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[204.105876] Starting subtest: x-tiled-addfb-size-offset-overflow
[204.107876] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[204.217558] [016/133] (813s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[204.322305] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[204.325917] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[204.449274] [017/133] (813s left) gem_workarounds (reset-fd)
[204.515157] Starting subtest: reset-fd
[204.669038] Subtest reset-fd: SUCCESS (0.156s)
[204.820992] [018/133] (812s left) gem_exec_schedule (u-semaphore-resolve)
[204.891558] Starting subtest: u-semaphore-resolve
[204.921318] Subtest u-semaphore-resolve: SUCCESS (0.035s)
[205.278833] [019/133] (812s left) gem_userptr_blits (sync-unmap-after-close)
[205.347406] Starting subtest: sync-unmap-after-close
[205.359582] Subtest sync-unmap-after-close: SUCCESS (0.012s)
[205.501278] [020/133] (812s left) kms_invalid_mode (zero-vdisplay)
[205.605938] Starting subtest: zero-vdisplay
[205.608135] Starting dynamic subtest: pipe-A-eDP-1
[205.899507] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.296s)
[205.907701] Starting dynamic subtest: pipe-B-eDP-1
[205.909630] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[205.917055] Starting dynamic subtest: pipe-C-eDP-1
[205.918873] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[205.926849] Starting dynamic subtest: pipe-D-eDP-1
[205.929075] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[205.931217] Subtest zero-vdisplay: SUCCESS (0.303s)
[206.780123] [021/133] (811s left) kms_setmode (basic-clone-single-crtc)
[206.838124] Starting subtest: basic-clone-single-crtc
[206.844941] Subtest basic-clone-single-crtc: SKIP (0.000s)
[206.957107] [022/133] (810s left) kms_flip (flip-vs-suspend)
[207.067656] Starting subtest: flip-vs-suspend
[207.070029] Starting dynamic subtest: A-eDP1
[256.097336] Dynamic subtest A-eDP1: SUCCESS (4.679s)
[256.111824] Starting dynamic subtest: B-eDP1
[305.090331] Dynamic subtest B-eDP1: SUCCESS (4.522s)
[305.099627] Starting dynamic subtest: C-eDP1
[354.108402] Dynamic subtest C-eDP1: SUCCESS (4.601s)
[354.122110] Starting dynamic subtest: D-eDP1
[403.094222] Dynamic subtest D-eDP1: SUCCESS (4.500s)
[403.099279] Subtest flip-vs-suspend: SUCCESS (18.315s)
[404.271203] [023/133] (613s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[404.370269] Starting subtest: primary-4-tiled-reflect-x-180
[411.463589] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.121s)
[412.720315] [024/133] (605s left) core_setmaster (master-drop-set-shared-fd)
[412.822558] Starting subtest: master-drop-set-shared-fd
[412.843905] Subtest master-drop-set-shared-fd: SUCCESS (0.022s)
[412.879439] [025/133] (605s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[413.293550] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[414.110859] [026/133] (603s left) kms_pm_rpm (cursor)
[415.964278] Starting subtest: cursor
[415.969211] Subtest cursor: SKIP (0.000s)
[416.386788] [027/133] (601s left) gem_exec_store (dword)
[416.451278] Starting subtest: dword
[416.453647] Starting dynamic subtest: rcs0
[416.540705] Dynamic subtest rcs0: SUCCESS (0.089s)
[416.552865] Starting dynamic subtest: bcs0
[416.583887] Dynamic subtest bcs0: SUCCESS (0.042s)
[416.595090] Starting dynamic subtest: vcs0
[416.626210] Dynamic subtest vcs0: SUCCESS (0.041s)
[416.636370] Starting dynamic subtest: vcs1
[416.668110] Dynamic subtest vcs1: SUCCESS (0.040s)
[416.678269] Starting dynamic subtest: vecs0
[416.709282] Dynamic subtest vecs0: SUCCESS (0.039s)
[416.720830] Starting dynamic subtest: ccs0
[416.750740] Dynamic subtest ccs0: SUCCESS (0.040s)
[416.753261] Subtest dword: SUCCESS (0.301s)
[416.957837] [028/133] (601s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[417.055675] Starting subtest: x-tiled-16bpp-rotate-0
[418.414637] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.362s)
[418.543184] [029/133] (599s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[418.652377] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[418.669066] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.018s)
[418.771304] [030/133] (599s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[418.869019] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[426.326600] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.466s)
[426.474731] [031/133] (591s left) api_intel_allocator (default-alignment)
[426.532603] Starting subtest: default-alignment
[426.534839] Subtest default-alignment: SUCCESS (0.003s)
[426.682499] [032/133] (591s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[426.787060] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[426.791000] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s)
[426.869348] [033/133] (591s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[426.974691] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[427.587057] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.614s)
[427.750421] [034/133] (590s left) gen9_exec_parse (valid-registers)
[427.817037] Subtest valid-registers: SKIP (0.000s)
[427.882409] [035/133] (590s left) kms_feature_discovery (chamelium)
[427.981314] Starting subtest: chamelium
[427.985350] Subtest chamelium: SKIP (0.000s)
[428.063680] [036/133] (590s left) perf (whitelisted-registers-userspace-config)
[428.153760] Starting subtest: whitelisted-registers-userspace-config
[428.156134] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[428.195389] [037/133] (590s left) kms_pm_rpm (legacy-planes)
[429.927294] Starting subtest: legacy-planes
[429.929347] Starting dynamic subtest: plane-64
[438.507195] Dynamic subtest plane-64: SUCCESS (8.588s)
[438.518569] Starting dynamic subtest: plane-94
[446.789519] Dynamic subtest plane-94: SUCCESS (8.284s)
[446.801291] Starting dynamic subtest: plane-124
[455.196587] Dynamic subtest plane-124: SUCCESS (8.410s)
[455.208264] Starting dynamic subtest: plane-134
[463.491509] Dynamic subtest plane-134: SUCCESS (8.296s)
[463.494412] Subtest legacy-planes: SUCCESS (33.587s)
[463.867922] [038/133] (554s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[463.935843] Starting subtest: multi-wait-all-for-submit-unsubmitted
[464.039218] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.104s)
[464.130287] [039/133] (554s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[464.230794] Starting subtest: y-tiled-8bpp-rotate-0
[464.235227] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[464.336462] [040/133] (554s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[464.399105] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[464.401295] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[464.521891] [041/133] (554s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[464.662935] Starting subtest: dp-mst-lic-type-0-hdcp14
[464.667386] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[464.813944] [042/133] (553s left) kms_async_flips (test-cursor)
[464.912240] Starting subtest: test-cursor
[464.916497] Subtest test-cursor: SKIP (0.000s)
[466.098938] [043/133] (552s left) kms_setmode (invalid-clone-single-crtc)
[466.157493] Starting subtest: invalid-clone-single-crtc
[466.164622] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[466.250885] [044/133] (552s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[466.311003] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[466.313572] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[466.436090] [045/133] (552s left) gem_unfence_active_buffers
[466.605640] [046/133] (552s left) gem_pxp (verify-pxp-stale-ctx-execution)
[466.725618] Starting subtest: verify-pxp-stale-ctx-execution
[467.785153] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.060s)
[467.946401] [047/133] (550s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[468.010143] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[468.070305] [048/133] (550s left) perf (sysctl-defaults)
[468.141742] Starting subtest: sysctl-defaults
[468.144210] Subtest sysctl-defaults: SUCCESS (0.000s)
[468.214087] [049/133] (550s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[468.315346] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[468.319786] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[468.428237] [050/133] (550s left) gem_create (create-clear)
[468.488891] Starting subtest: create-clear
[468.490932] Starting dynamic subtest: smem0
[501.105984] Dynamic subtest smem0: SUCCESS (32.632s)
[501.108267] Subtest create-clear: SUCCESS (32.634s)
[501.321239] [051/133] (517s left) syncobj_wait (invalid-signal-zero-handles)
[501.381231] Starting subtest: invalid-signal-zero-handles
[501.383745] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[501.514635] [052/133] (517s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[501.578437] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[501.677876] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.101s)
[501.768213] [053/133] (517s left) gem_exec_reloc (basic-range)
[501.844030] Subtest basic-range: SKIP (0.000s)
[501.932279] [054/133] (517s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[502.039575] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[502.043840] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[502.143252] [055/133] (517s left) kms_psr (fbc-psr-sprite-render)
[502.229470] Starting subtest: fbc-psr-sprite-render
[502.231630] Starting dynamic subtest: eDP-1
[502.235976] Dynamic subtest eDP-1: SKIP (0.000s)
[502.240355] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[502.319623] [056/133] (516s left) syncobj_wait (signal)
[502.386042] Starting subtest: signal
[502.387993] Subtest signal: SUCCESS (0.000s)
[502.516300] [057/133] (516s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[502.608503] Starting subtest: fbc-shrfb-scaledprimary
[505.654753] Subtest fbc-shrfb-scaledprimary: SUCCESS (3.049s)
[506.848608] [058/133] (512s left) kms_cursor_crc (cursor-size-change)
[506.951395] Starting subtest: cursor-size-change
[506.953736] Starting dynamic subtest: pipe-A-eDP-1
[507.767032] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.814s)
[507.776927] Starting dynamic subtest: pipe-D-eDP-1
[509.202819] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.436s)
[509.204983] Subtest cursor-size-change: SUCCESS (2.253s)
[510.017483] [059/133] (509s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[510.120503] Starting subtest: addfb25-y-tiled-legacy
[510.122739] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[510.238707] [060/133] (509s left) i915_query (query-regions-sanity-check)
[510.291320] Starting subtest: query-regions-sanity-check
[510.299449] Subtest query-regions-sanity-check: SUCCESS (0.010s)
[510.398321] [061/133] (509s left) gem_render_copy (y-tiled-ccs-to-linear)
[510.457820] Starting subtest: y-tiled-ccs-to-linear
[510.462451] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[510.652830] [062/133] (508s left) gem_exec_fence (long-history)
[511.141740] Starting subtest: long-history
[518.512264] Subtest long-history: SUCCESS (7.376s)
[519.012918] [FACT gem_exec_fence (long-history)] new: kernel.kmod_is_loaded.vgem: true
[519.016449] [063/133] (500s left) kms_vblank (query-forked-hang)
[519.127174] Starting subtest: query-forked-hang
[519.129459] Starting dynamic subtest: pipe-A-eDP-1
[545.520210] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.405s)
[545.536026] Starting dynamic subtest: pipe-D-eDP-1
[560.552224] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.037s)
[560.554571] Subtest query-forked-hang: SUCCESS (41.447s)
[561.352473] [064/133] (458s left) gem_softpin (evict-prime-sanity-check)
[561.411981] Starting subtest: evict-prime-sanity-check
[561.414269] Starting dynamic subtest: rcs0
[562.580154] Dynamic subtest rcs0: SUCCESS (1.168s)
[562.591696] Starting dynamic subtest: bcs0
[563.726976] Dynamic subtest bcs0: SUCCESS (1.144s)
[563.738797] Starting dynamic subtest: vcs0
[565.749255] Dynamic subtest vcs0: SUCCESS (2.018s)
[565.759360] Starting dynamic subtest: vcs1
[567.697561] Dynamic subtest vcs1: SUCCESS (1.945s)
[567.709020] Starting dynamic subtest: vecs0
[569.747185] Dynamic subtest vecs0: SUCCESS (2.047s)
[569.758347] Starting dynamic subtest: ccs0
[570.934417] Dynamic subtest ccs0: SUCCESS (1.185s)
[570.946036] Starting dynamic subtest: all
[572.080222] Dynamic subtest all: SUCCESS (1.143s)
[572.082613] Subtest evict-prime-sanity-check: SUCCESS (10.667s)
[572.178795] [065/133] (447s left) sw_sync (sync_busy)
[572.218269] Starting subtest: sync_busy
[572.220460] Subtest sync_busy: SUCCESS (0.002s)
[572.289366] [066/133] (447s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[572.533231] Starting subtest: cursor-rapid-movement-256x256
[572.537833] Starting dynamic subtest: pipe-A-eDP-1
[573.083426] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.546s)
[573.114309] Starting dynamic subtest: pipe-D-eDP-1
[574.267610] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.160s)
[574.269619] Subtest cursor-rapid-movement-256x256: SUCCESS (1.732s)
[575.133027] [067/133] (444s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[575.533939] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[576.334719] [068/133] (443s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[576.443668] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[583.023213] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.582s)
[583.160711] [069/133] (436s left) perf_pmu (busy-idle)
[583.200207] Starting subtest: busy-idle
[583.202645] Starting dynamic subtest: rcs0
[583.923063] Dynamic subtest rcs0: SUCCESS (0.723s)
[583.935242] Starting dynamic subtest: bcs0
[584.598894] Dynamic subtest bcs0: SUCCESS (0.674s)
[584.611374] Starting dynamic subtest: vcs0
[585.765408] Dynamic subtest vcs0: SUCCESS (1.163s)
[585.778050] Starting dynamic subtest: vcs1
[587.748199] Dynamic subtest vcs1: SUCCESS (1.981s)
[587.761040] Starting dynamic subtest: vecs0
[589.796516] Dynamic subtest vecs0: SUCCESS (2.046s)
[589.809278] Starting dynamic subtest: ccs0
[590.471749] Dynamic subtest ccs0: SUCCESS (0.674s)
[590.474243] Subtest busy-idle: SUCCESS (7.275s)
[590.596415] [070/133] (429s left) gem_userptr_blits (invalid-mmap-offset-unsync)
[590.663234] Subtest invalid-mmap-offset-unsync: SKIP (0.000s)
[590.860178] [071/133] (429s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[590.968226] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[590.972297] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[591.077031] [072/133] (428s left) prime_busy (hang)
[591.152024] Starting subtest: hang
[591.154461] Starting dynamic subtest: rcs0
[617.277502] Dynamic subtest rcs0: SUCCESS (26.116s)
[617.288688] Starting dynamic subtest: bcs0
[624.432657] Dynamic subtest bcs0: SUCCESS (7.159s)
[624.442509] Starting dynamic subtest: vcs0
[631.411688] Dynamic subtest vcs0: SUCCESS (6.975s)
[631.422450] Starting dynamic subtest: vcs1
[638.446137] Dynamic subtest vcs1: SUCCESS (7.039s)
[638.455845] Starting dynamic subtest: vecs0
[645.418830] Dynamic subtest vecs0: SUCCESS (6.973s)
[645.430760] Starting dynamic subtest: ccs0
[659.324834] Dynamic subtest ccs0: SUCCESS (13.904s)
[659.327277] Subtest hang: SUCCESS (68.173s)
[659.466095] [073/133] (360s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[659.562467] Starting subtest: psr-rgb101010-draw-mmap-cpu
[666.636058] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (7.073s)
[666.783814] [074/133] (353s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[666.854504] Starting subtest: single-wait-all-for-submit-available-signaled
[666.856769] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[666.990029] [075/133] (353s left) kms_getfb (getfb-handle-not-fb)
[667.086271] Starting subtest: getfb-handle-not-fb
[667.088670] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[667.226299] [076/133] (352s left) kms_plane (plane-panning-bottom-right-suspend)
[667.317309] Starting subtest: plane-panning-bottom-right-suspend
[667.319524] Starting dynamic subtest: pipe-A
[685.515514] Dynamic subtest pipe-A: SUCCESS (2.928s)
[685.526533] Starting dynamic subtest: pipe-B
[703.514997] Dynamic subtest pipe-B: SUCCESS (3.476s)
[703.517443] Subtest plane-panning-bottom-right-suspend: SUCCESS (6.409s)
[704.337719] [077/133] (315s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[704.421637] Starting subtest: stress-mm-invalidate-close-overlap
[706.543802] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s)
[706.699406] [078/133] (313s left) fbdev (read)
[706.748704] Starting subtest: read
[707.435105] Subtest read: SUCCESS (0.695s)
[707.514053] [079/133] (312s left) kms_chamelium_color (ctm-0-75)
[707.627824] Subtest ctm-0-75: SKIP (0.000s)
[707.676168] [080/133] (312s left) gem_ctx_shared (disjoint-timelines)
[707.761581] Starting subtest: disjoint-timelines
[707.798476] Subtest disjoint-timelines: SUCCESS (0.037s)
[708.079663] [081/133] (312s left) gem_ppgtt (shrink-vs-evict-pinned)
[708.137812] Starting subtest: shrink-vs-evict-pinned
[713.611677] Subtest shrink-vs-evict-pinned: SUCCESS (5.506s)
[713.681637] [082/133] (306s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[713.800203] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[713.805266] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[713.919911] [083/133] (306s left) perf (gen12-oa-tlb-invalidate)
[714.014698] Starting subtest: gen12-oa-tlb-invalidate
[714.016828] Starting dynamic subtest: 0-rcs0
[724.046915] Dynamic subtest 0-rcs0: SUCCESS (10.059s)
[724.057595] Starting dynamic subtest: 1-vecs0
[734.088384] Dynamic subtest 1-vecs0: SUCCESS (10.049s)
[734.090841] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.110s)
[734.142141] [084/133] (286s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[734.234874] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[734.237291] Starting dynamic subtest: pipe-A-eDP-1
[734.260690] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[734.272646] Starting dynamic subtest: pipe-B-eDP-1
[734.299458] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[734.309959] Starting dynamic subtest: pipe-C-eDP-1
[734.336433] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[734.346568] Starting dynamic subtest: pipe-D-eDP-1
[734.373614] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[734.378594] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[736.487087] [085/133] (284s left) gem_exec_schedule (noreorder-priority)
[736.677719] Starting subtest: noreorder-priority
[736.680267] Starting dynamic subtest: rcs0
[737.837071] Dynamic subtest rcs0: SUCCESS (1.157s)
[737.849373] Starting dynamic subtest: vcs0
[739.652153] Dynamic subtest vcs0: SUCCESS (1.809s)
[739.668653] Starting dynamic subtest: vcs1
[741.636879] Dynamic subtest vcs1: SUCCESS (1.979s)
[741.650099] Starting dynamic subtest: vecs0
[743.621281] Dynamic subtest vecs0: SUCCESS (1.980s)
[743.638283] Starting dynamic subtest: ccs0
[744.794308] Dynamic subtest ccs0: SUCCESS (1.170s)
[744.797304] Subtest noreorder-priority: SUCCESS (8.108s)
[744.999821] [086/133] (275s left) gem_mmap_wc (fault-concurrent)
[745.067431] Subtest fault-concurrent: SKIP (0.000s)
[745.139323] [087/133] (275s left) gen9_exec_parse (batch-invalid-length)
[745.213803] Subtest batch-invalid-length: SKIP (0.000s)
[745.303003] [088/133] (275s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[745.421806] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[746.202629] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.781s)
[746.386632] [089/133] (274s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[746.494587] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[746.498721] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[746.622003] [090/133] (274s left) kms_universal_plane (universal-plane-pageflip-windowed)
[746.725850] Starting subtest: universal-plane-pageflip-windowed
[746.728462] Starting dynamic subtest: pipe-A-eDP-1
[747.315581] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.590s)
[747.326857] Starting dynamic subtest: pipe-B-eDP-1
[748.515837] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.195s)
[748.526833] Starting dynamic subtest: pipe-C-eDP-1
[749.727346] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.210s)
[749.738828] Starting dynamic subtest: pipe-D-eDP-1
[750.949646] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.220s)
[750.952242] Subtest universal-plane-pageflip-windowed: SUCCESS (4.221s)
[751.813220] [091/133] (268s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[751.879704] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[751.882626] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[751.995282] [092/133] (268s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[752.097342] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[756.701429] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (4.606s)
[757.825919] [093/133] (263s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[757.951567] Starting subtest: 2x-cursor-vs-flip-atomic
[757.956398] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[758.108857] [094/133] (262s left) drm_read (fault-buffer)
[758.255871] Starting subtest: fault-buffer
[758.258814] Subtest fault-buffer: SUCCESS (0.001s)
[758.419851] [095/133] (262s left) kms_psr (fbc-psr2-basic)
[758.519046] Starting subtest: fbc-psr2-basic
[758.521422] Starting dynamic subtest: eDP-1
[758.526423] Dynamic subtest eDP-1: SKIP (0.000s)
[758.531387] Subtest fbc-psr2-basic: SKIP (0.001s)
[758.604982] [096/133] (262s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[758.706198] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[758.708732] Starting dynamic subtest: pipe-A-eDP-1
[759.129583] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.425s)
[759.141809] Starting dynamic subtest: pipe-B-eDP-1
[759.161462] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[759.171252] Starting dynamic subtest: pipe-C-eDP-1
[759.190244] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[759.199606] Starting dynamic subtest: pipe-D-eDP-1
[759.218876] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[759.221044] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.439s)
[761.468558] [097/133] (259s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[761.586391] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[761.589264] Starting dynamic subtest: pipe-A-eDP-1
[768.121582] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.540s)
[768.132820] Starting dynamic subtest: pipe-B-eDP-1
[775.187431] Dynamic subtest pipe-B-eDP-1: SUCCESS (7.067s)
[775.190068] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.610s)
[776.050118] [098/133] (245s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[776.179441] Starting subtest: cursorB-vs-flipA-atomic-transitions
[776.184702] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[776.337292] [099/133] (244s left) gem_exec_await (wide-all)
[776.548730] Starting subtest: wide-all
[799.626312] Subtest wide-all: SUCCESS (23.079s)
[799.836771] [100/133] (221s left) kms_rotation_crc (primary-rotation-180)
[799.994512] Starting subtest: primary-rotation-180
[807.147106] Subtest primary-rotation-180: SUCCESS (7.153s)
[808.413856] [101/133] (212s left) gem_mmap_offset (blt-coherency)
[808.476745] Starting subtest: blt-coherency
[808.482757] Subtest blt-coherency: SUCCESS (0.009s)
[808.626564] [102/133] (212s left) api_intel_bb (object-noreloc-keep-cache-simple)
[808.705774] Starting subtest: object-noreloc-keep-cache-simple
[808.712204] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.008s)
[808.837769] [103/133] (212s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[808.938867] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[812.668330] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.733s)
[813.818204] [104/133] (207s left) gem_sync (basic-store-all)
[813.906736] Starting subtest: basic-store-all
[816.780571] Subtest basic-store-all: SUCCESS (2.885s)
[816.976828] [105/133] (204s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[817.079591] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[817.082170] Starting dynamic subtest: pipe-A-eDP-1
[817.148309] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[817.158632] Starting dynamic subtest: pipe-B-eDP-1
[817.230405] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[817.241872] Starting dynamic subtest: pipe-C-eDP-1
[817.309410] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[817.319840] Starting dynamic subtest: pipe-D-eDP-1
[817.387359] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[817.392813] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.009s)
[819.375223] [106/133] (202s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[819.476387] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[819.480888] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[819.597970] [107/133] (201s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[819.705602] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[819.710132] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[819.820287] [108/133] (201s left) kms_plane (pixel-format-yf-tiled-modifier-source-clamping)
[819.912651] Starting subtest: pixel-format-yf-tiled-modifier-source-clamping
[819.938745] Starting dynamic subtest: pipe-A-plane-0
[819.944616] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[819.956819] Starting dynamic subtest: pipe-A-plane-3
[819.962570] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[819.972800] Starting dynamic subtest: pipe-A-plane-5
[819.978373] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[821.021870] Starting dynamic subtest: pipe-B-plane-0
[821.027062] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[821.037503] Starting dynamic subtest: pipe-B-plane-3
[821.042637] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[821.052772] Starting dynamic subtest: pipe-B-plane-5
[821.058496] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[821.328664] Subtest pixel-format-yf-tiled-modifier-source-clamping: SKIP (1.414s)
[822.217471] [109/133] (199s left) gem_exec_fence (basic-busy)
[822.402645] Starting subtest: basic-busy
[822.405658] Starting dynamic subtest: rcs0
[822.496154] Dynamic subtest rcs0: SUCCESS (0.097s)
[822.509129] Starting dynamic subtest: bcs0
[822.552077] Dynamic subtest bcs0: SUCCESS (0.054s)
[822.563024] Starting dynamic subtest: vcs0
[822.609004] Dynamic subtest vcs0: SUCCESS (0.055s)
[822.620698] Starting dynamic subtest: vcs1
[822.674022] Dynamic subtest vcs1: SUCCESS (0.062s)
[822.686981] Starting dynamic subtest: vecs0
[822.734998] Dynamic subtest vecs0: SUCCESS (0.058s)
[822.751452] Starting dynamic subtest: ccs0
[822.797884] Dynamic subtest ccs0: SUCCESS (0.061s)
[822.800624] Subtest basic-busy: SUCCESS (0.401s)
[824.752303] [110/133] (196s left) gem_exec_whisper (basic-queues-all)
[824.832707] Starting subtest: basic-queues-all
[835.657146] Subtest basic-queues-all: SUCCESS (10.826s)
[835.856463] [111/133] (185s left) syncobj_eventfd (invalid-illegal-handle)
[835.923198] Starting subtest: invalid-illegal-handle
[835.926158] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[836.055355] [112/133] (185s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[836.121667] Starting subtest: invalid-single-wait-unsubmitted
[836.124649] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[836.245029] [113/133] (185s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[836.312276] Starting subtest: yf-tiled-to-vebox-yf-tiled
[836.317611] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[836.514950] [114/133] (185s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[836.631482] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[836.636761] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[836.760330] [115/133] (185s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[836.870730] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[836.875516] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[836.991699] [116/133] (184s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[837.097677] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[837.102111] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[837.222009] [117/133] (184s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[837.327500] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[837.329973] Starting dynamic subtest: pipe-A
[837.349592] Dynamic subtest pipe-A: SKIP (0.018s)
[837.370832] Starting dynamic subtest: pipe-B
[837.382362] Dynamic subtest pipe-B: SKIP (0.030s)
[837.403979] Starting dynamic subtest: pipe-C
[837.414327] Dynamic subtest pipe-C: SKIP (0.031s)
[837.425624] Starting dynamic subtest: pipe-D
[837.458678] Dynamic subtest pipe-D: SKIP (0.048s)
[837.462431] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.132s)
[837.588615] [118/133] (184s left) gem_flink_basic (bad-open)
[837.637808] Starting subtest: bad-open
[837.640294] Subtest bad-open: SUCCESS (0.000s)
[837.768026] [119/133] (184s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[837.877688] Starting subtest: yf-tiled-8bpp-rotate-90
[837.882109] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[837.984485] [120/133] (184s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[838.083851] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[842.508060] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.429s)
[843.685522] [121/133] (178s left) kms_plane_multiple (2x-tiling-4)
[843.781008] Starting subtest: 2x-tiling-4
[843.786425] Subtest 2x-tiling-4: SKIP (0.000s)
[843.869587] [122/133] (178s left) i915_pm_rpm (system-suspend-execbuf)
[845.822490] Starting subtest: system-suspend-execbuf
[904.922874] Subtest system-suspend-execbuf: SUCCESS (44.013s)
[905.303899] [123/133] (116s left) gem_exec_balancer (indices)
[905.371229] Starting subtest: indices
[907.741157] Subtest indices: SUCCESS (2.369s)
[908.068779] [124/133] (114s left) kms_psr (pr-cursor-plane-onoff)
[908.174647] Starting subtest: pr-cursor-plane-onoff
[908.179862] Subtest pr-cursor-plane-onoff: SKIP (0.000s)
[908.263001] [125/133] (114s left) kms_color (gamma)
[908.367224] Starting subtest: gamma
[908.369991] Starting dynamic subtest: pipe-A-eDP-1
[909.111385] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.745s)
[909.123873] Starting dynamic subtest: pipe-B-eDP-1
[910.488046] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.378s)
[910.498901] Starting dynamic subtest: pipe-C-eDP-1
[911.876147] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.386s)
[911.887895] Starting dynamic subtest: pipe-D-eDP-1
[913.204071] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.327s)
[913.206919] Subtest gamma: SUCCESS (4.840s)
[914.024049] [126/133] (108s left) kms_flip (flip-vs-fences)
[914.119798] Starting subtest: flip-vs-fences
[914.125188] Subtest flip-vs-fences: SKIP (0.000s)
[914.314866] [127/133] (108s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[914.444086] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area
[914.449974] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[914.564854] [128/133] (108s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[914.698031] Starting subtest: short-busy-flip-before-cursor-toggle
[914.704029] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[914.894595] [129/133] (107s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[915.000953] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[915.003237] Starting dynamic subtest: pipe-A-default-mode
[917.766898] Dynamic subtest pipe-A-default-mode: SUCCESS (2.763s)
[917.770031] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.765s)
[918.611690] [130/133] (104s left) kms_psr (psr2-primary-mmap-gtt)
[918.713906] Starting subtest: psr2-primary-mmap-gtt
[918.716458] Starting dynamic subtest: eDP-1
[920.193191] Dynamic subtest eDP-1: SKIP (1.477s)
[920.198784] Subtest psr2-primary-mmap-gtt: SKIP (1.479s)
[920.395084] [131/133] (102s left) gem_ctx_persistence (engines-hostile-preempt)
[920.463933] Starting subtest: engines-hostile-preempt
[920.467037] Starting dynamic subtest: rcs0
[920.582546] Dynamic subtest rcs0: SUCCESS (0.118s)
[920.596253] Starting dynamic subtest: bcs0
[920.651371] Dynamic subtest bcs0: SUCCESS (0.067s)
[920.664809] Starting dynamic subtest: vcs0
[921.765001] Dynamic subtest vcs0: SUCCESS (1.110s)
[921.779373] Starting dynamic subtest: vcs1
[923.763012] Dynamic subtest vcs1: SUCCESS (1.996s)
[923.776888] Starting dynamic subtest: vecs0
[925.791261] Dynamic subtest vecs0: SUCCESS (2.026s)
[925.804889] Starting dynamic subtest: ccs0
[925.883676] Dynamic subtest ccs0: SUCCESS (0.091s)
[925.886759] Subtest engines-hostile-preempt: SUCCESS (5.422s)
[925.978693] [132/133] ( 96s left) gem_exec_schedule (fairslice)
[926.054035] Starting subtest: fairslice
[926.056390] Starting dynamic subtest: rcs0
[928.078810] Dynamic subtest rcs0: SUCCESS (2.034s)
[928.090104] Starting dynamic subtest: bcs0
[930.106460] Dynamic subtest bcs0: SUCCESS (2.026s)
[930.119047] Starting dynamic subtest: vcs0
[932.127223] Dynamic subtest vcs0: SUCCESS (2.019s)
[932.139712] Starting dynamic subtest: vcs1
[934.146310] Dynamic subtest vcs1: SUCCESS (2.018s)
[934.158080] Starting dynamic subtest: vecs0
[936.170551] Dynamic subtest vecs0: SUCCESS (2.024s)
[936.188860] Starting dynamic subtest: ccs0
[938.193240] Dynamic subtest ccs0: SUCCESS (2.024s)
[938.196220] Subtest fairslice: SUCCESS (12.149s)
[938.505921] [133/133] ( 84s left) kms_lease (atomic-implicit-crtc)
[938.613075] Starting subtest: atomic-implicit-crtc
[938.615672] Starting dynamic subtest: pipe-A-eDP-1
[938.628367] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[938.639778] Starting dynamic subtest: pipe-B-eDP-1
[938.653980] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[938.664916] Starting dynamic subtest: pipe-C-eDP-1
[938.677853] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s)
[938.688273] Starting dynamic subtest: pipe-D-eDP-1
[938.701206] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[938.703996] Subtest atomic-implicit-crtc: SUCCESS (0.035s)
[938.755343] Closing watchdogs
results: parsing output: 0/ for test: kms_getfb
results: parsing output: 1/ for test: gem_ctx_persistence
results: parsing output: 2/ for test: kms_cursor_edge_walk
results: parsing output: 3/ for test: sysfs_timeslice_duration
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_ccs
results: parsing output: 6/ for test: kms_atomic_transition
results: parsing output: 7/ for test: gem_mmap_gtt
results: parsing output: 8/ for test: i915_hangman
results: parsing output: 9/ for test: kms_cursor_crc
results: parsing output: 10/ for test: kms_pipe_crc_basic
results: parsing output: 11/ for test: perf
results: parsing output: 12/ for test: syncobj_wait
results: parsing output: 13/ for test: kms_psr2_sf
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: gem_workarounds
results: parsing output: 17/ for test: gem_exec_schedule
results: parsing output: 18/ for test: gem_userptr_blits
results: parsing output: 19/ for test: kms_invalid_mode
results: parsing output: 20/ for test: kms_setmode
results: parsing output: 21/ for test: kms_flip
results: parsing output: 22/ for test: kms_rotation_crc
results: parsing output: 23/ for test: core_setmaster
results: parsing output: 24/ for test: kms_chamelium_hpd
results: parsing output: 25/ for test: kms_pm_rpm
results: parsing output: 26/ for test: gem_exec_store
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: kms_flip
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: api_intel_allocator
results: parsing output: 31/ for test: kms_flip_scaled_crc
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: gen9_exec_parse
results: parsing output: 34/ for test: kms_feature_discovery
results: parsing output: 35/ for test: perf
results: parsing output: 36/ for test: kms_pm_rpm
results: parsing output: 37/ for test: syncobj_wait
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: syncobj_timeline
results: parsing output: 40/ for test: kms_content_protection
results: parsing output: 41/ for test: kms_async_flips
results: parsing output: 42/ for test: kms_setmode
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: gem_unfence_active_buffers
results: parsing output: 45/ for test: gem_pxp
results: parsing output: 46/ for test: kms_pipe_b_c_ivb
results: parsing output: 47/ for test: perf
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: gem_create
results: parsing output: 50/ for test: syncobj_wait
results: parsing output: 51/ for test: syncobj_wait
results: parsing output: 52/ for test: gem_exec_reloc
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: syncobj_wait
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_cursor_crc
results: parsing output: 58/ for test: kms_addfb_basic
results: parsing output: 59/ for test: i915_query
results: parsing output: 60/ for test: gem_render_copy
results: parsing output: 61/ for test: gem_exec_fence
results: parsing output: 62/ for test: kms_vblank
results: parsing output: 63/ for test: gem_softpin
results: parsing output: 64/ for test: sw_sync
results: parsing output: 65/ for test: kms_cursor_crc
results: parsing output: 66/ for test: kms_chamelium_edid
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: perf_pmu
results: parsing output: 69/ for test: gem_userptr_blits
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: prime_busy
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: syncobj_timeline
results: parsing output: 74/ for test: kms_getfb
results: parsing output: 75/ for test: kms_plane
results: parsing output: 76/ for test: gem_userptr_blits
results: parsing output: 77/ for test: fbdev
results: parsing output: 78/ for test: kms_chamelium_color
results: parsing output: 79/ for test: gem_ctx_shared
results: parsing output: 80/ for test: gem_ppgtt
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: perf
results: parsing output: 83/ for test: kms_ccs
results: parsing output: 84/ for test: gem_exec_schedule
results: parsing output: 85/ for test: gem_mmap_wc
results: parsing output: 86/ for test: gen9_exec_parse
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: kms_universal_plane
results: parsing output: 90/ for test: syncobj_wait
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_cursor_legacy
results: parsing output: 93/ for test: drm_read
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: kms_ccs
results: parsing output: 96/ for test: kms_psr2_sf
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: gem_exec_await
results: parsing output: 99/ for test: kms_rotation_crc
results: parsing output: 100/ for test: gem_mmap_offset
results: parsing output: 101/ for test: api_intel_bb
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_sync
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_plane
results: parsing output: 108/ for test: gem_exec_fence
results: parsing output: 109/ for test: gem_exec_whisper
results: parsing output: 110/ for test: syncobj_eventfd
results: parsing output: 111/ for test: syncobj_timeline
results: parsing output: 112/ for test: gem_render_copy
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_plane_scaling
results: parsing output: 117/ for test: gem_flink_basic
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_plane_multiple
results: parsing output: 121/ for test: i915_pm_rpm
results: parsing output: 122/ for test: gem_exec_balancer
results: parsing output: 123/ for test: kms_psr
results: parsing output: 124/ for test: kms_color
results: parsing output: 125/ for test: kms_flip
results: parsing output: 126/ for test: kms_psr2_sf
results: parsing output: 127/ for test: kms_cursor_legacy
results: parsing output: 128/ for test: kms_flip_scaled_crc
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: gem_ctx_persistence
results: parsing output: 131/ for test: gem_exec_schedule
results: parsing output: 132/ for test: kms_lease
Done.