[98.999556] Initializing watchdogs
[98.999652]   /dev/watchdog0
[99.013750] [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]
[99.018121] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[99.020414] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[99.023845] [001/131] (960s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[99.128398] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[99.139987] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[99.249104] [002/131] (960s left) kms_psr (fbc-psr-cursor-blt)
[99.341376] Starting subtest: fbc-psr-cursor-blt
[99.343678] Starting dynamic subtest: eDP-1
[99.348160] Dynamic subtest eDP-1: SKIP (0.000s)
[99.352566] Subtest fbc-psr-cursor-blt: SKIP (0.000s)
[99.409298] [003/131] (960s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[99.506209] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[99.508661] Starting dynamic subtest: pipe-A-eDP-1
[100.314300] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.799s)
[100.321232] Starting dynamic subtest: pipe-B-eDP-1
[102.101713] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.788s)
[102.109901] Starting dynamic subtest: pipe-C-eDP-1
[103.918518] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.817s)
[103.926801] Starting dynamic subtest: pipe-D-eDP-1
[105.761629] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.843s)
[105.763933] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.250s)
[106.940287] [004/131] (952s left) kms_flip (plain-flip-ts-check)
[107.041252] Starting subtest: plain-flip-ts-check
[107.043680] Starting dynamic subtest: A-eDP1
[115.934567] Dynamic subtest A-eDP1: SUCCESS (8.892s)
[115.942618] Starting dynamic subtest: B-eDP1
[124.857525] Dynamic subtest B-eDP1: SUCCESS (8.921s)
[124.864277] Starting dynamic subtest: C-eDP1
[133.769822] Dynamic subtest C-eDP1: SUCCESS (8.912s)
[133.777666] Starting dynamic subtest: D-eDP1
[142.594575] Dynamic subtest D-eDP1: SUCCESS (8.823s)
[142.599589] Subtest plain-flip-ts-check: SUCCESS (35.556s)
[143.766877] [005/131] (915s left) kms_cursor_crc (cursor-random-128x128)
[143.985467] Starting subtest: cursor-random-128x128
[143.990427] Starting dynamic subtest: pipe-A-eDP-1
[147.808453] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.818s)
[147.832966] Starting dynamic subtest: pipe-D-eDP-1
[152.166914] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.338s)
[152.169069] Subtest cursor-random-128x128: SUCCESS (8.179s)
[153.018537] [006/131] (906s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[153.116915] Starting subtest: yf-tiled-addfb-size-overflow
[153.121183] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[153.225492] [007/131] (906s left) gem_userptr_blits (set-cache-level)
[153.289023] Starting subtest: set-cache-level
[153.293264] Subtest set-cache-level: SKIP (0.000s)
[153.418573] [008/131] (906s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[153.520981] Starting subtest: plane-upscale-20x20-with-pixel-format
[153.523523] Starting dynamic subtest: pipe-A
[154.570180] Dynamic subtest pipe-A: SUCCESS (1.050s)
[154.582644] Starting dynamic subtest: pipe-B
[156.723764] Dynamic subtest pipe-B: SUCCESS (2.153s)
[156.732655] Starting dynamic subtest: pipe-C
[157.917254] Dynamic subtest pipe-C: SUCCESS (1.193s)
[157.926289] Starting dynamic subtest: pipe-D
[159.051656] Dynamic subtest pipe-D: SUCCESS (1.134s)
[159.054115] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.531s)
[160.235165] [009/131] (899s left) gem_ctx_bad_destroy (invalid-ctx)
[160.291553] Starting subtest: invalid-ctx
[160.293902] Subtest invalid-ctx: SUCCESS (0.000s)
[160.360919] [010/131] (899s left) kms_plane_alpha_blend (constant-alpha-max)
[160.446861] Starting subtest: constant-alpha-max
[160.895528] Starting dynamic subtest: pipe-A-eDP-1
[161.869809] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.974s)
[161.877560] Starting dynamic subtest: pipe-D-eDP-1
[163.456098] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.581s)
[163.458170] Subtest constant-alpha-max: SUCCESS (3.005s)
[164.281622] [011/131] (895s left) gem_ctx_isolation (dirty-switch)
[164.344356] Starting subtest: dirty-switch
[164.346673] Starting dynamic subtest: rcs0
[164.779757] Dynamic subtest rcs0: SUCCESS (0.435s)
[164.787043] Starting dynamic subtest: bcs0
[165.262663] Dynamic subtest bcs0: SUCCESS (0.483s)
[165.271565] Starting dynamic subtest: vcs0
[165.735612] Dynamic subtest vcs0: SUCCESS (0.472s)
[165.744250] Starting dynamic subtest: vcs1
[167.435687] Dynamic subtest vcs1: SUCCESS (1.700s)
[167.442791] Starting dynamic subtest: vecs0
[169.404453] Dynamic subtest vecs0: SUCCESS (1.968s)
[169.411615] Starting dynamic subtest: ccs0
[171.438505] Dynamic subtest ccs0: SUCCESS (2.034s)
[171.440824] Subtest dirty-switch: SUCCESS (7.094s)
[171.674469] [012/131] (888s left) vgem_basic (unload)
[171.705834] Starting subtest: unload
[200.933570] Subtest unload: SUCCESS (29.226s)
[201.028142] [FACT vgem_basic (unload)] new: kernel.kmod_is_loaded.vgem: true
[201.031354] [013/131] (858s left) gem_exec_gttfill (basic)
[201.092931] Starting subtest: basic
[205.963800] Subtest basic: SUCCESS (4.868s)
[206.145859] [014/131] (853s left) kms_psr (psr2-cursor-render)
[206.294923] Starting subtest: psr2-cursor-render
[206.297543] Starting dynamic subtest: eDP-1
[207.948295] Dynamic subtest eDP-1: SUCCESS (1.649s)
[207.950835] Subtest psr2-cursor-render: SUCCESS (1.651s)
[208.731127] [015/131] (851s left) syncobj_timeline (single-wait-available-signaled)
[208.802326] Starting subtest: single-wait-available-signaled
[208.804822] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[208.914853] [016/131] (851s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[209.028421] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[209.033023] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[209.132060] [017/131] (850s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[209.236070] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[209.336933] [018/131] (850s left) kms_pm_rpm (universal-planes-dpms)
[211.101790] Starting subtest: universal-planes-dpms
[211.104252] Starting dynamic subtest: plane-33
[219.372984] Dynamic subtest plane-33: SUCCESS (8.274s)
[219.382586] Starting dynamic subtest: plane-43
[227.986861] Dynamic subtest plane-43: SUCCESS (8.613s)
[227.996722] Starting dynamic subtest: plane-53
[236.291080] Dynamic subtest plane-53: SUCCESS (8.302s)
[236.301732] Starting dynamic subtest: plane-63
[244.777787] Dynamic subtest plane-63: SUCCESS (8.486s)
[244.786849] Starting dynamic subtest: plane-73
[253.101340] Dynamic subtest plane-73: SUCCESS (8.322s)
[253.112264] Starting dynamic subtest: plane-83
[261.485504] Dynamic subtest plane-83: SUCCESS (8.383s)
[261.487978] Subtest universal-planes-dpms: SUCCESS (50.387s)
[261.852846] [019/131] (798s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[261.953444] Starting subtest: fbc-tiling-linear
[265.720998] Subtest fbc-tiling-linear: SUCCESS (3.772s)
[266.824694] [020/131] (793s left) kms_async_flips (async-flip-dpms)
[266.922910] Starting subtest: async-flip-dpms
[267.298745] Starting dynamic subtest: pipe-A-eDP-1
[271.115958] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.818s)
[271.485503] Starting dynamic subtest: pipe-B-eDP-1
[274.261832] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.783s)
[274.645087] Starting dynamic subtest: pipe-C-eDP-1
[277.397546] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.756s)
[277.770996] Starting dynamic subtest: pipe-D-eDP-1
[280.533934] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.771s)
[280.536460] Subtest async-flip-dpms: SUCCESS (13.610s)
[281.708398] [021/131] (778s left) gem_exec_balancer (parallel-keep-submit-fence)
[281.979465] Starting subtest: parallel-keep-submit-fence
[283.096348] Subtest parallel-keep-submit-fence: SUCCESS (1.115s)
[283.221712] [022/131] (777s left) gem_ctx_persistence (hang)
[283.290210] Starting subtest: hang
[283.294783] Subtest hang: SKIP (0.000s)
[283.378550] [023/131] (776s left) gem_exec_nop (basic-series)
[283.463992] Starting subtest: basic-series
[298.903031] Subtest basic-series: SUCCESS (15.446s)
[299.137993] [024/131] (761s left) gem_workarounds (reset-context)
[299.203097] Starting subtest: reset-context
[299.421041] Subtest reset-context: SUCCESS (0.217s)
[299.556879] [025/131] (760s left) gem_exec_schedule (timeslicing)
[299.637441] Starting subtest: timeslicing
[299.639483] Starting dynamic subtest: rcs0
[299.652826] Dynamic subtest rcs0: SUCCESS (0.025s)
[299.662820] Starting dynamic subtest: bcs0
[299.676226] Dynamic subtest bcs0: SUCCESS (0.023s)
[299.684680] Starting dynamic subtest: vcs0
[299.698018] Dynamic subtest vcs0: SUCCESS (0.021s)
[299.706305] Starting dynamic subtest: vcs1
[299.718488] Dynamic subtest vcs1: SUCCESS (0.020s)
[299.726258] Starting dynamic subtest: vecs0
[299.740535] Dynamic subtest vecs0: SUCCESS (0.022s)
[299.748288] Starting dynamic subtest: ccs0
[299.764643] Dynamic subtest ccs0: SUCCESS (0.023s)
[299.767039] Subtest timeslicing: SUCCESS (0.137s)
[300.926089] [026/131] (759s left) kms_pm_rpm (fences)
[302.971399] Starting subtest: fences
[302.976660] Subtest fences: SKIP (0.000s)
[303.338101] [027/131] (757s left) kms_psr (fbc-psr-cursor-render)
[303.430143] Starting subtest: fbc-psr-cursor-render
[303.432262] Starting dynamic subtest: eDP-1
[303.436521] Dynamic subtest eDP-1: SKIP (0.000s)
[303.440725] Subtest fbc-psr-cursor-render: SKIP (0.001s)
[303.502378] [028/131] (757s left) syncobj_wait (invalid-wait-bad-flags)
[303.547843] Starting subtest: invalid-wait-bad-flags
[303.549918] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[303.641775] [029/131] (756s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[303.694096] Starting subtest: invalid-single-wait-all-unsubmitted
[303.696310] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[303.811342] [030/131] (756s left) fbdev (write)
[303.851067] Starting subtest: write
[304.215738] Subtest write: SUCCESS (0.363s)
[304.275149] [031/131] (756s left) api_intel_bb (simple-bb-ctx)
[304.322221] Starting subtest: simple-bb-ctx
[304.328831] Subtest simple-bb-ctx: SUCCESS (0.008s)
[304.453180] [032/131] (756s left) i915_pm_rps (thresholds-idle)
[304.521327] Starting subtest: thresholds-idle
[304.526211] Subtest thresholds-idle: SKIP (0.000s)
[304.605171] [033/131] (756s left) kms_panel_fitting (atomic-fastset)
[304.702085] Starting subtest: atomic-fastset
[304.704420] Starting dynamic subtest: pipe-A-eDP-1
[304.865154] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.162s)
[304.875230] Starting dynamic subtest: pipe-B-eDP-1
[306.090794] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.224s)
[306.101251] Starting dynamic subtest: pipe-C-eDP-1
[307.276072] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.183s)
[307.284898] Starting dynamic subtest: pipe-D-eDP-1
[308.501981] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.225s)
[308.504294] Subtest atomic-fastset: SUCCESS (3.798s)
[309.646140] [034/131] (751s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[309.707171] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[309.711426] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[309.887458] [035/131] (750s left) gem_exec_reloc (basic-cpu-read-noreloc)
[309.953376] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[310.038217] [036/131] (750s left) syncobj_timeline (wait-for-submit-snapshot)
[310.096432] Starting subtest: wait-for-submit-snapshot
[310.178880] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[310.253724] [037/131] (750s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[310.370811] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[310.503812] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.136s)
[310.629541] [038/131] (750s left) prime_busy (after-wait)
[310.680138] Starting subtest: after-wait
[310.684585] Starting dynamic subtest: rcs0
[310.713417] Dynamic subtest rcs0: SUCCESS (0.031s)
[310.721633] Starting dynamic subtest: bcs0
[310.769299] Dynamic subtest bcs0: SUCCESS (0.056s)
[310.778052] Starting dynamic subtest: vcs0
[310.808780] Dynamic subtest vcs0: SUCCESS (0.039s)
[310.816703] Starting dynamic subtest: vcs1
[310.850056] Dynamic subtest vcs1: SUCCESS (0.041s)
[310.857789] Starting dynamic subtest: vecs0
[310.889827] Dynamic subtest vecs0: SUCCESS (0.039s)
[310.898995] Starting dynamic subtest: ccs0
[310.930751] Dynamic subtest ccs0: SUCCESS (0.040s)
[311.039976] Subtest after-wait: SUCCESS (0.359s)
[311.114969] [039/131] (749s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[311.214682] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[311.219195] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[311.328085] [040/131] (749s left) i915_module_load (reload-no-display)
[311.365265] Starting subtest: reload-no-display
[317.876039] Subtest reload-no-display: SUCCESS (6.511s)
[317.904848] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[317.905551] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[317.908836] [041/131] (743s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[319.440466] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[319.444848] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[319.530766] [FACT kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[319.532032] [FACT kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)] new: kernel.kmod_is_loaded.i915: true
[319.535837] [042/131] (741s left) kms_invalid_mode (int-max-clock)
[319.638316] Starting subtest: int-max-clock
[319.640678] Starting dynamic subtest: pipe-A-eDP-1
[319.929903] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.292s)
[319.938071] Starting dynamic subtest: pipe-B-eDP-1
[319.940072] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[319.946991] Starting dynamic subtest: pipe-C-eDP-1
[319.948925] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[319.955770] Starting dynamic subtest: pipe-D-eDP-1
[319.957695] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[319.959630] Subtest int-max-clock: SUCCESS (0.298s)
[320.772926] [043/131] (740s left) gem_media_fill (media-fill)
[320.834704] Subtest media-fill: SKIP (0.000s)
[320.930465] [044/131] (740s left) i915_drm_fdinfo (virtual-busy-hang)
[320.972872] Starting subtest: virtual-busy-hang
[320.977394] Subtest virtual-busy-hang: SKIP (0.000s)
[321.041809] [045/131] (740s left) testdisplay
[321.405643] [046/131] (739s left) gem_userptr_blits (relocations)
[321.472075] Starting subtest: relocations
[321.476040] Subtest relocations: SKIP (0.001s)
[321.613955] [047/131] (739s left) gem_create (create-ext-cpu-access-sanity-check)
[321.788404] Starting subtest: create-ext-cpu-access-sanity-check
[321.793582] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[321.861407] [048/131] (739s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[322.393030] Starting subtest: syncobj-backward-timeline-chain-engines
[322.479549] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.087s)
[324.061616] [049/131] (737s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[324.169914] Starting subtest: flip-vs-dpms-off-vs-modeset
[324.172116] Starting dynamic subtest: A-eDP1
[327.770784] Dynamic subtest A-eDP1: SUCCESS (3.598s)
[327.778689] Starting dynamic subtest: B-eDP1
[330.957674] Dynamic subtest B-eDP1: SUCCESS (3.184s)
[330.965198] Starting dynamic subtest: C-eDP1
[334.016077] Dynamic subtest C-eDP1: SUCCESS (3.061s)
[334.024443] Starting dynamic subtest: D-eDP1
[337.083112] Dynamic subtest D-eDP1: SUCCESS (3.064s)
[337.085422] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (12.914s)
[337.875604] [050/131] (723s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[337.980855] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[337.983262] Starting dynamic subtest: pipe-A-eDP-1
[338.004055] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[338.014200] Starting dynamic subtest: pipe-B-eDP-1
[338.034492] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[338.041930] Starting dynamic subtest: pipe-C-eDP-1
[338.061999] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[338.069521] Starting dynamic subtest: pipe-D-eDP-1
[338.090075] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[338.092284] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[340.140203] [051/131] (721s left) gem_exec_reloc (basic-wc-noreloc)
[340.207373] Subtest basic-wc-noreloc: SKIP (0.000s)
[340.277563] [052/131] (721s left) gem_eio (in-flight-external)
[340.463033] Starting subtest: in-flight-external
[341.955645] Subtest in-flight-external: SUCCESS (1.494s)
[342.108979] [053/131] (719s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[342.196745] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[342.199074] Starting dynamic subtest: pipe-A-eDP-1
[342.221795] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[342.232387] Starting dynamic subtest: pipe-B-eDP-1
[342.253269] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[342.261673] Starting dynamic subtest: pipe-C-eDP-1
[342.282706] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[342.290816] Starting dynamic subtest: pipe-D-eDP-1
[342.311430] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[342.315592] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[344.388607] [054/131] (717s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[344.450803] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[344.453052] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[344.560777] [055/131] (717s left) gem_exec_fence (syncobj-timeline-unused-fence)
[345.075599] Starting subtest: syncobj-timeline-unused-fence
[345.082229] Subtest syncobj-timeline-unused-fence: SUCCESS (0.007s)
[346.057700] [056/131] (715s left) gem_exec_schedule (fifo)
[346.131430] Starting subtest: fifo
[346.133615] Starting dynamic subtest: rcs0
[346.221226] Dynamic subtest rcs0: SUCCESS (0.100s)
[346.232314] Starting dynamic subtest: vcs0
[346.297603] Dynamic subtest vcs0: SUCCESS (0.076s)
[346.307804] Starting dynamic subtest: vcs1
[346.371836] Dynamic subtest vcs1: SUCCESS (0.074s)
[346.383112] Starting dynamic subtest: vecs0
[346.445031] Dynamic subtest vecs0: SUCCESS (0.073s)
[346.456313] Starting dynamic subtest: ccs0
[346.534658] Dynamic subtest ccs0: SUCCESS (0.089s)
[346.537060] Subtest fifo: SUCCESS (0.414s)
[348.038457] [057/131] (713s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[348.143817] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[356.345460] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (8.205s)
[356.490922] [058/131] (705s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[356.591085] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[363.580321] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (6.992s)
[363.703538] [059/131] (698s left) kms_addfb_basic (bad-pitch-999)
[363.754469] Starting subtest: bad-pitch-999
[363.756643] Subtest bad-pitch-999: SUCCESS (0.000s)
[363.901985] [060/131] (697s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[364.016517] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[364.020671] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[364.128920] [061/131] (697s left) kms_chamelium_frames (hdmi-frame-dump)
[364.526580] Subtest hdmi-frame-dump: SKIP (0.000s)
[365.301550] [062/131] (696s left) syncobj_timeline (host-signal-ordered)
[365.358379] Starting subtest: host-signal-ordered
[365.360692] Subtest host-signal-ordered: SUCCESS (0.000s)
[365.459190] [063/131] (696s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[365.559712] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[366.824359] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: FAIL (0.661s)
[366.865907] [064/131] (695s left) syncobj_wait (single-wait-all-signaled)
[366.926071] Starting subtest: single-wait-all-signaled
[366.928391] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[367.023924] [065/131] (694s left) kms_psr (psr-basic)
[367.117174] Starting subtest: psr-basic
[367.119065] Starting dynamic subtest: eDP-1
[368.698462] Dynamic subtest eDP-1: SUCCESS (1.582s)
[368.700844] Subtest psr-basic: SUCCESS (1.583s)
[369.578332] [066/131] (692s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[369.698639] Starting subtest: basic-busy-flip-before-cursor-varying-size
[369.703307] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[369.843088] [067/131] (692s left) gem_exercise_blt (fast-copy)
[369.898716] Starting subtest: fast-copy
[369.900973] Starting dynamic subtest: linear-smem-smem
[369.922622] Dynamic subtest linear-smem-smem: SUCCESS (0.024s)
[369.933162] Starting dynamic subtest: xmajor-smem-smem
[369.943242] Dynamic subtest xmajor-smem-smem: SUCCESS (0.019s)
[369.951608] Starting dynamic subtest: tile4-smem-smem
[369.961534] Dynamic subtest tile4-smem-smem: SUCCESS (0.018s)
[369.969877] Starting dynamic subtest: tile64-smem-smem
[369.979658] Dynamic subtest tile64-smem-smem: SUCCESS (0.018s)
[369.981886] Subtest fast-copy: SUCCESS (0.082s)
[370.114854] [068/131] (692s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[370.221352] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[370.223732] Starting dynamic subtest: pipe-A-default-mode
[370.509263] Dynamic subtest pipe-A-default-mode: SKIP (0.284s)
[370.513868] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.286s)
[371.304801] [069/131] (690s left) kms_psr (fbc-pr-primary-mmap-cpu)
[371.411106] Starting subtest: fbc-pr-primary-mmap-cpu
[371.415323] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[371.481312] [070/131] (690s left) kms_selftest (drm_cmdline_parser)
[371.520868] Starting subtest: drm_cmdline_parser
[371.534023] Starting dynamic subtest: drm_test_cmdline_force_d_only
[371.629041] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.094s)
[371.637493] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[371.763372] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.132s)
[371.773712] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[371.874290] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.112s)
[371.884251] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[372.017791] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.143s)
[372.027456] Starting dynamic subtest: drm_test_cmdline_force_e_only
[372.142262] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.124s)
[372.151967] Starting dynamic subtest: drm_test_cmdline_res
[372.284067] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.140s)
[372.292599] Starting dynamic subtest: drm_test_cmdline_res_vesa
[372.408827] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.124s)
[372.417325] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[372.545245] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.137s)
[372.553699] Starting dynamic subtest: drm_test_cmdline_res_rblank
[372.668739] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.123s)
[372.676994] Starting dynamic subtest: drm_test_cmdline_res_bpp
[372.785911] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.115s)
[372.795322] Starting dynamic subtest: drm_test_cmdline_res_refresh
[372.899075] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.115s)
[372.909284] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[373.028846] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.127s)
[373.038778] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[373.136111] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.107s)
[373.144498] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[373.244414] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.106s)
[373.252310] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[373.333306] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.089s)
[373.341141] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[373.456022] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.120s)
[373.465079] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[373.560860] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.104s)
[373.569137] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[373.687107] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.124s)
[373.696815] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[373.777159] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.091s)
[373.785128] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[373.869349] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.091s)
[373.879064] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[373.984723] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.115s)
[373.992987] Starting dynamic subtest: drm_test_cmdline_name
[374.128103] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.142s)
[374.135950] Starting dynamic subtest: drm_test_cmdline_name_bpp
[374.228629] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.100s)
[374.236943] Starting dynamic subtest: drm_test_cmdline_name_option
[374.341705] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.112s)
[374.355204] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[374.448381] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.104s)
[374.458791] Starting dynamic subtest: drm_test_cmdline_rotate_0
[374.560712] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.112s)
[374.570599] Starting dynamic subtest: drm_test_cmdline_rotate_90
[374.666046] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.106s)
[374.674406] Starting dynamic subtest: drm_test_cmdline_rotate_180
[374.763681] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.096s)
[374.772140] Starting dynamic subtest: drm_test_cmdline_rotate_270
[374.872873] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.107s)
[374.882467] Starting dynamic subtest: drm_test_cmdline_hmirror
[374.993017] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.118s)
[375.003270] Starting dynamic subtest: drm_test_cmdline_vmirror
[375.093511] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.101s)
[375.102258] Starting dynamic subtest: drm_test_cmdline_margin_options
[375.194125] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.100s)
[375.203589] Starting dynamic subtest: drm_test_cmdline_multiple_options
[375.301343] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.107s)
[375.311325] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[375.408024] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.105s)
[375.418257] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[375.518298] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.108s)
[375.532380] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[375.646560] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.125s)
[375.656500] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[375.774109] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.128s)
[375.783729] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[375.907023] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.132s)
[375.915333] Starting dynamic subtest: drm_test_cmdline_invalid
[376.016967] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.110s)
[376.025256] Starting dynamic subtest: drm_test_cmdline_tv_options
[376.156040] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.139s)
[376.158428] Subtest drm_cmdline_parser: SUCCESS (4.637s)
[376.333029] [071/131] (685s left) kms_color (invalid-gamma-lut-sizes)
[376.441260] Starting subtest: invalid-gamma-lut-sizes
[376.443599] Starting dynamic subtest: pipe-A
[376.740235] Dynamic subtest pipe-A: SUCCESS (0.295s)
[376.748753] Starting dynamic subtest: pipe-B
[376.751141] Dynamic subtest pipe-B: SUCCESS (0.001s)
[376.759642] Starting dynamic subtest: pipe-C
[376.762045] Dynamic subtest pipe-C: SUCCESS (0.001s)
[376.770280] Starting dynamic subtest: pipe-D
[376.772540] Dynamic subtest pipe-D: SUCCESS (0.001s)
[376.774776] Subtest invalid-gamma-lut-sizes: SUCCESS (0.300s)
[377.520641] [072/131] (684s left) kms_big_fb (linear-32bpp-rotate-270)
[377.625588] Starting subtest: linear-32bpp-rotate-270
[377.645087] Subtest linear-32bpp-rotate-270: SKIP (0.019s)
[377.747196] [073/131] (684s left) gem_exec_params (invalid-ring)
[377.807425] Starting subtest: invalid-ring
[377.809644] Subtest invalid-ring: SUCCESS (0.000s)
[377.923994] [074/131] (684s left) gem_render_copy_redux (flink-interruptible)
[377.991016] Starting subtest: flink-interruptible
[379.015973] Subtest flink-interruptible: SUCCESS (1.026s)
[379.152273] [075/131] (683s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[379.252487] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[385.938926] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.687s)
[386.071176] [076/131] (676s left) gem_eio (in-flight-10ms)
[386.304746] Starting subtest: in-flight-10ms
[395.038588] Subtest in-flight-10ms: SUCCESS (8.733s)
[395.163335] [077/131] (667s left) gem_flink_basic (double-flink)
[395.219610] Starting subtest: double-flink
[395.222048] Subtest double-flink: SUCCESS (0.000s)
[395.319805] [078/131] (667s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[395.579327] Starting subtest: cursor-rapid-movement-256x85
[395.622892] Subtest cursor-rapid-movement-256x85: SKIP (0.039s)
[395.824681] [079/131] (666s left) kms_sequence (queue-busy)
[395.917739] Starting subtest: queue-busy
[395.919823] Starting dynamic subtest: pipe-A-eDP-1
[397.855959] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.936s)
[397.865479] Starting dynamic subtest: pipe-B-eDP-1
[400.419477] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.562s)
[400.429199] Starting dynamic subtest: pipe-C-eDP-1
[403.037639] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.617s)
[403.050629] Starting dynamic subtest: pipe-D-eDP-1
[405.646280] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.607s)
[405.648607] Subtest queue-busy: SUCCESS (9.727s)
[406.433608] [080/131] (656s left) gem_exec_schedule (preempt)
[406.510111] Starting subtest: preempt
[406.512121] Starting dynamic subtest: rcs0
[406.526643] Dynamic subtest rcs0: SUCCESS (0.023s)
[406.537100] Starting dynamic subtest: bcs0
[406.546088] Dynamic subtest bcs0: SUCCESS (0.019s)
[406.554714] Starting dynamic subtest: vcs0
[406.565104] Dynamic subtest vcs0: SUCCESS (0.019s)
[406.573722] Starting dynamic subtest: vcs1
[406.586392] Dynamic subtest vcs1: SUCCESS (0.020s)
[406.595082] Starting dynamic subtest: vecs0
[406.606821] Dynamic subtest vecs0: SUCCESS (0.020s)
[406.615665] Starting dynamic subtest: ccs0
[406.628174] Dynamic subtest ccs0: SUCCESS (0.021s)
[406.630491] Subtest preempt: SUCCESS (0.125s)
[407.979098] [081/131] (654s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[408.072357] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[408.074878] Starting dynamic subtest: pipe-A-eDP-1
[408.097408] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[408.112493] Starting dynamic subtest: pipe-B-eDP-1
[408.132912] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[408.141433] Starting dynamic subtest: pipe-C-eDP-1
[408.161231] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[408.169245] Starting dynamic subtest: pipe-D-eDP-1
[408.188872] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[408.190918] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s)
[410.283631] [082/131] (652s left) kms_fbcon_fbt (psr-suspend)
[410.349587] Starting subtest: psr-suspend
[459.701325] Subtest psr-suspend: SUCCESS (20.095s)
[459.776143] [083/131] (602s left) perf_pmu (idle)
[459.826938] Starting subtest: idle
[459.829261] Starting dynamic subtest: rcs0
[460.359916] Dynamic subtest rcs0: SUCCESS (0.537s)
[460.372407] Starting dynamic subtest: bcs0
[460.887526] Dynamic subtest bcs0: SUCCESS (0.530s)
[460.897380] Starting dynamic subtest: vcs0
[461.410823] Dynamic subtest vcs0: SUCCESS (0.526s)
[461.422172] Starting dynamic subtest: vcs1
[461.933596] Dynamic subtest vcs1: SUCCESS (0.520s)
[461.944773] Starting dynamic subtest: vecs0
[462.449950] Dynamic subtest vecs0: SUCCESS (0.522s)
[462.462523] Starting dynamic subtest: ccs0
[462.974817] Dynamic subtest ccs0: SUCCESS (0.526s)
[462.977673] Subtest idle: SUCCESS (3.174s)
[463.077802] [084/131] (599s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[463.179275] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[463.183675] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[463.296791] [085/131] (599s left) kms_flip (2x-modeset-vs-vblank-race)
[463.393933] Starting subtest: 2x-modeset-vs-vblank-race
[463.405563] Subtest 2x-modeset-vs-vblank-race: SKIP (0.011s)
[463.523702] [086/131] (599s left) perf_pmu (busy)
[463.561790] Starting subtest: busy
[463.563616] Starting dynamic subtest: rcs0
[464.167360] Dynamic subtest rcs0: SUCCESS (0.610s)
[464.178521] Starting dynamic subtest: bcs0
[464.738505] Dynamic subtest bcs0: SUCCESS (0.572s)
[464.750345] Starting dynamic subtest: vcs0
[466.292109] Dynamic subtest vcs0: SUCCESS (1.557s)
[466.302659] Starting dynamic subtest: vcs1
[468.339833] Dynamic subtest vcs1: SUCCESS (2.054s)
[468.350298] Starting dynamic subtest: vecs0
[470.324724] Dynamic subtest vecs0: SUCCESS (1.988s)
[470.337074] Starting dynamic subtest: ccs0
[470.899096] Dynamic subtest ccs0: SUCCESS (0.575s)
[470.902131] Subtest busy: SUCCESS (7.369s)
[471.023989] [087/131] (591s left) gem_mmap_gtt (flink-race)
[471.095675] Subtest flink-race: SKIP (0.000s)
[471.151686] [088/131] (591s left) kms_force_connector_basic (force-connector-state)
[471.234790] Starting subtest: force-connector-state
[471.829326] Subtest force-connector-state: SUCCESS (0.596s)
[472.769979] [089/131] (590s left) kms_flip (2x-flip-vs-panning)
[472.866739] Starting subtest: 2x-flip-vs-panning
[472.878304] Subtest 2x-flip-vs-panning: SKIP (0.011s)
[472.957015] [090/131] (590s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[473.058303] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[473.062211] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[473.178685] [091/131] (589s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[473.284623] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[473.288703] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[473.388365] [092/131] (589s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[478.361869] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[478.364240] Starting dynamic subtest: pipe-A-eDP-1
[479.161305] Dynamic subtest pipe-A-eDP-1: SKIP (0.796s)
[479.171853] Starting dynamic subtest: pipe-B-eDP-1
[480.282213] Dynamic subtest pipe-B-eDP-1: SKIP (1.120s)
[480.286469] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.919s)
[481.463004] [093/131] (581s left) kms_dp_linktrain_fallback (dsc-fallback)
[481.573092] Starting subtest: dsc-fallback
[481.579747] Subtest dsc-fallback: SKIP (0.000s)
[481.643365] [094/131] (581s left) gem_fence_thrash (bo-write-verify-x)
[481.681697] Starting subtest: bo-write-verify-x
[481.695550] Subtest bo-write-verify-x: SKIP (0.018s)
[481.765908] [095/131] (581s left) kms_dsc (dsc-with-output-formats-with-bpc)
[481.857120] Starting subtest: dsc-with-output-formats-with-bpc
[481.913948] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s)
[481.952303] [096/131] (581s left) i915_drm_fdinfo (busy-idle)
[481.991760] Starting subtest: busy-idle
[481.994042] Starting dynamic subtest: rcs0
[482.035755] Dynamic subtest rcs0: SKIP (0.041s)
[482.047937] Starting dynamic subtest: bcs0
[482.052410] Dynamic subtest bcs0: SKIP (0.001s)
[482.062110] Starting dynamic subtest: vcs0
[482.066680] Dynamic subtest vcs0: SKIP (0.000s)
[482.076115] Starting dynamic subtest: vcs1
[482.080599] Dynamic subtest vcs1: SKIP (0.000s)
[482.090133] Starting dynamic subtest: vecs0
[482.094536] Dynamic subtest vecs0: SKIP (0.000s)
[482.104001] Starting dynamic subtest: ccs0
[482.108366] Dynamic subtest ccs0: SKIP (0.000s)
[482.112830] Subtest busy-idle: SKIP (0.048s)
[482.151871] [097/131] (581s left) gem_sync (basic-store-each)
[482.239772] Starting subtest: basic-store-each
[484.939856] Subtest basic-store-each: SUCCESS (2.714s)
[485.125051] [098/131] (578s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[485.238474] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[486.561564] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (1.326s)
[486.791264] [099/131] (576s left) api_intel_allocator (reserve-simple)
[486.839188] Starting subtest: reserve-simple
[486.841477] Subtest reserve-simple: SUCCESS (0.004s)
[486.964771] [100/131] (576s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[487.020640] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[487.128504] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.107s)
[487.203804] [101/131] (576s left) kms_atomic_transition (modeset-transition-nonblocking)
[487.295247] Starting subtest: modeset-transition-nonblocking
[487.297627] Starting dynamic subtest: 1x-outputs
[498.391732] Dynamic subtest 1x-outputs: SUCCESS (11.093s)
[498.684131] Subtest modeset-transition-nonblocking: SUCCESS (11.387s)
[499.510616] [102/131] (564s left) gem_watchdog (default-physical)
[499.586040] Starting subtest: default-physical
[501.340292] Subtest default-physical: SUCCESS (1.767s)
[501.452214] [103/131] (562s left) gem_mmap (bad-object)
[501.528008] Subtest bad-object: SKIP (0.000s)
[501.602324] [104/131] (562s left) kms_plane_alpha_blend (constant-alpha-min)
[501.694012] Starting subtest: constant-alpha-min
[502.132740] Starting dynamic subtest: pipe-A-eDP-1
[502.822198] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.689s)
[502.832454] Starting dynamic subtest: pipe-D-eDP-1
[504.308564] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.484s)
[504.310728] Subtest constant-alpha-min: SUCCESS (2.613s)
[505.149059] [105/131] (558s left) perf (rc6-disable)
[505.285167] Starting subtest: rc6-disable
[505.481425] Subtest rc6-disable: SUCCESS (0.198s)
[505.525662] [106/131] (558s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[505.631571] Starting subtest: y-tiled-16bpp-rotate-90
[505.635971] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[505.736303] [107/131] (558s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[505.826695] Starting subtest: plane-use-after-nonblocking-unbind
[505.829047] Starting dynamic subtest: pipe-A-eDP-1
[505.907393] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.083s)
[506.202512] Starting dynamic subtest: pipe-B-eDP-1
[507.040203] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.847s)
[507.334739] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.511s)
[508.187984] [108/131] (555s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-render)
[508.293958] Starting subtest: psr-1p-offscren-pri-indfb-draw-render
[515.192761] Subtest psr-1p-offscren-pri-indfb-draw-render: SUCCESS (6.903s)
[515.345952] [109/131] (548s left) kms_content_protection (dp-mst-type-0)
[515.518812] Starting subtest: dp-mst-type-0
[515.523201] Subtest dp-mst-type-0: SKIP (0.000s)
[515.660749] [110/131] (548s left) gem_softpin (allocator-basic)
[515.715633] Starting subtest: allocator-basic
[515.782864] Subtest allocator-basic: SUCCESS (0.067s)
[515.930885] [111/131] (547s left) gem_softpin (noreloc)
[515.981436] Starting subtest: noreloc
[521.372680] Subtest noreloc: SUCCESS (5.391s)
[521.496327] [112/131] (542s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[521.594572] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[521.596947] Starting dynamic subtest: pipe-A-eDP-1
[522.470467] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.864s)
[522.481034] Starting dynamic subtest: pipe-B-eDP-1
[524.056724] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.587s)
[524.068404] Starting dynamic subtest: pipe-C-eDP-1
[525.609311] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.551s)
[525.620501] Starting dynamic subtest: pipe-D-eDP-1
[527.100990] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.490s)
[527.103358] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.497s)
[528.277838] [113/131] (535s left) syncobj_wait (invalid-reset-bad-pad)
[528.334722] Starting subtest: invalid-reset-bad-pad
[528.336958] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[528.418239] [114/131] (535s left) gem_exec_balancer (bonded-true-hang)
[528.666581] Starting subtest: bonded-true-hang
[528.671151] Subtest bonded-true-hang: SKIP (0.000s)
[528.779601] [115/131] (535s left) kms_atomic_interruptible (universal-setplane-primary)
[528.886941] Starting subtest: universal-setplane-primary
[528.889206] Starting dynamic subtest: pipe-A-eDP-1
[536.283771] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.401s)
[536.286059] Subtest universal-setplane-primary: SUCCESS (7.402s)
[537.116801] [116/131] (526s left) kms_lease (setcrtc-implicit-plane)
[537.221017] Starting subtest: setcrtc-implicit-plane
[537.223396] Starting dynamic subtest: pipe-A-eDP-1
[537.703795] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.480s)
[537.714236] Starting dynamic subtest: pipe-B-eDP-1
[538.827204] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.121s)
[538.838558] Starting dynamic subtest: pipe-C-eDP-1
[539.935791] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.108s)
[539.946934] Starting dynamic subtest: pipe-D-eDP-1
[541.055328] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.117s)
[541.057728] Subtest setcrtc-implicit-plane: SUCCESS (3.834s)
[541.898051] [117/131] (522s left) kms_plane (plane-position-covered)
[541.988154] Starting subtest: plane-position-covered
[542.514010] Starting dynamic subtest: pipe-A-plane-1
[543.739396] Dynamic subtest pipe-A-plane-1: SUCCESS (1.225s)
[543.750626] Starting dynamic subtest: pipe-A-plane-2
[544.977679] Dynamic subtest pipe-A-plane-2: SUCCESS (1.240s)
[544.987550] Starting dynamic subtest: pipe-A-plane-3
[546.202285] Dynamic subtest pipe-A-plane-3: SUCCESS (1.223s)
[546.212775] Starting dynamic subtest: pipe-A-plane-4
[547.407523] Dynamic subtest pipe-A-plane-4: SUCCESS (1.206s)
[547.418666] Starting dynamic subtest: pipe-A-plane-5
[547.446386] Dynamic subtest pipe-A-plane-5: SUCCESS (0.037s)
[548.555108] Starting dynamic subtest: pipe-B-plane-1
[549.787135] Dynamic subtest pipe-B-plane-1: SUCCESS (1.242s)
[549.798963] Starting dynamic subtest: pipe-B-plane-2
[551.069445] Dynamic subtest pipe-B-plane-2: SUCCESS (1.280s)
[551.081459] Starting dynamic subtest: pipe-B-plane-3
[552.297940] Dynamic subtest pipe-B-plane-3: SUCCESS (1.231s)
[552.308679] Starting dynamic subtest: pipe-B-plane-4
[553.527357] Dynamic subtest pipe-B-plane-4: SUCCESS (1.228s)
[553.538335] Starting dynamic subtest: pipe-B-plane-5
[553.566186] Dynamic subtest pipe-B-plane-5: SUCCESS (0.037s)
[553.568087] Subtest plane-position-covered: SUCCESS (11.579s)
[554.324757] [118/131] (509s left) gem_render_copy (linear)
[554.386310] Starting subtest: linear
[554.388724] Starting dynamic subtest: smem
[554.432342] Dynamic subtest smem: SUCCESS (0.046s)
[554.435273] Subtest linear: SUCCESS (0.046s)
[554.679375] [119/131] (509s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[554.784483] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[554.788519] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[554.893796] [120/131] (509s left) gem_mmap_wc (write-gtt-read-wc)
[554.948208] Subtest write-gtt-read-wc: SKIP (0.000s)
[555.015367] [121/131] (509s left) gem_mmap (pf-nonblock)
[555.075598] Subtest pf-nonblock: SKIP (0.000s)
[555.138364] [122/131] (509s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[555.200144] Starting subtest: saturated-hostile-nopreempt
[555.202482] Starting dynamic subtest: rcs0
[555.274919] Dynamic subtest rcs0: SKIP (0.072s)
[555.285645] Starting dynamic subtest: bcs0
[555.299676] Dynamic subtest bcs0: SKIP (0.023s)
[555.311493] Starting dynamic subtest: vcs0
[555.316048] Dynamic subtest vcs0: SKIP (0.014s)
[555.325935] Starting dynamic subtest: vcs1
[555.340466] Dynamic subtest vcs1: SKIP (0.024s)
[555.350338] Starting dynamic subtest: vecs0
[555.363604] Dynamic subtest vecs0: SKIP (0.022s)
[555.373525] Starting dynamic subtest: ccs0
[555.385637] Dynamic subtest ccs0: SKIP (0.021s)
[555.389848] Subtest saturated-hostile-nopreempt: SKIP (0.183s)
[555.464745] [123/131] (508s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[555.561785] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[555.566031] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[555.672930] [124/131] (508s left) syncobj_wait (invalid-signal-one-illegal-handle)
[555.741833] Starting subtest: invalid-signal-one-illegal-handle
[555.743745] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[555.851395] [125/131] (508s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[556.221396] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[557.025227] [126/131] (507s left) gem_exec_create (basic)
[557.083056] Starting subtest: basic
[557.085355] Starting dynamic subtest: smem
[560.309709] Dynamic subtest smem: SUCCESS (3.222s)
[560.312729] Subtest basic: SUCCESS (3.224s)
[560.492172] [127/131] (504s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-gtt)
[560.599429] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-gtt
[560.603965] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[560.705155] [128/131] (503s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[565.693559] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[565.695958] Starting dynamic subtest: pipe-A-eDP-1
[582.889406] Dynamic subtest pipe-A-eDP-1: SUCCESS (17.190s)
[582.900756] Starting dynamic subtest: pipe-B-eDP-1
[600.008478] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.118s)
[600.010874] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (34.311s)
[600.790394] [129/131] (463s left) kms_vrr (seamless-rr-switch-drrs)
[600.905182] Starting subtest: seamless-rr-switch-drrs
[600.912107] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[600.984338] [130/131] (463s left) kms_flip (flip-vs-panning-interruptible)
[601.085656] Starting subtest: flip-vs-panning-interruptible
[601.087966] Starting dynamic subtest: A-eDP1
[609.795152] Dynamic subtest A-eDP1: SUCCESS (8.710s)
[609.805411] Starting dynamic subtest: B-eDP1
[618.521001] Dynamic subtest B-eDP1: SUCCESS (8.724s)
[618.533207] Starting dynamic subtest: C-eDP1
[627.232372] Dynamic subtest C-eDP1: SUCCESS (8.713s)
[627.244501] Starting dynamic subtest: D-eDP1
[635.956867] Dynamic subtest D-eDP1: SUCCESS (8.725s)
[635.959223] Subtest flip-vs-panning-interruptible: SUCCESS (34.880s)
[637.111085] [131/131] (427s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[637.218285] Starting subtest: primary-y-tiled-reflect-x-90
[637.222977] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[637.290067] Closing watchdogs
results: parsing output: 0/ for test: kms_flip
results: parsing output: 1/ for test: kms_psr
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: kms_flip
results: parsing output: 4/ for test: kms_cursor_crc
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: gem_userptr_blits
results: parsing output: 7/ for test: kms_plane_scaling
results: parsing output: 8/ for test: gem_ctx_bad_destroy
results: parsing output: 9/ for test: kms_plane_alpha_blend
results: parsing output: 10/ for test: gem_ctx_isolation
results: parsing output: 11/ for test: vgem_basic
results: parsing output: 12/ for test: gem_exec_gttfill
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: kms_addfb_basic
results: parsing output: 17/ for test: kms_pm_rpm
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_async_flips
results: parsing output: 20/ for test: gem_exec_balancer
results: parsing output: 21/ for test: gem_ctx_persistence
results: parsing output: 22/ for test: gem_exec_nop
results: parsing output: 23/ for test: gem_workarounds
results: parsing output: 24/ for test: gem_exec_schedule
results: parsing output: 25/ for test: kms_pm_rpm
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: syncobj_wait
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: fbdev
results: parsing output: 30/ for test: api_intel_bb
results: parsing output: 31/ for test: i915_pm_rps
results: parsing output: 32/ for test: kms_panel_fitting
results: parsing output: 33/ for test: gem_render_copy
results: parsing output: 34/ for test: gem_exec_reloc
results: parsing output: 35/ for test: syncobj_timeline
results: parsing output: 36/ for test: gem_pxp
results: parsing output: 37/ for test: prime_busy
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: i915_module_load
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_invalid_mode
results: parsing output: 42/ for test: gem_media_fill
results: parsing output: 43/ for test: i915_drm_fdinfo
results: parsing output: 44/ for test: testdisplay
results: parsing output: 45/ for test: gem_userptr_blits
results: parsing output: 46/ for test: gem_create
results: parsing output: 47/ for test: gem_exec_fence
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: kms_ccs
results: parsing output: 50/ for test: gem_exec_reloc
results: parsing output: 51/ for test: gem_eio
results: parsing output: 52/ for test: kms_ccs
results: parsing output: 53/ for test: syncobj_timeline
results: parsing output: 54/ for test: gem_exec_fence
results: parsing output: 55/ for test: gem_exec_schedule
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_addfb_basic
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_chamelium_frames
results: parsing output: 61/ for test: syncobj_timeline
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: syncobj_wait
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: kms_cursor_legacy
results: parsing output: 66/ for test: gem_exercise_blt
results: parsing output: 67/ for test: kms_flip_scaled_crc
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: kms_selftest
results: parsing output: 70/ for test: kms_color
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: gem_exec_params
results: parsing output: 73/ for test: gem_render_copy_redux
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: gem_eio
results: parsing output: 76/ for test: gem_flink_basic
results: parsing output: 77/ for test: kms_cursor_crc
results: parsing output: 78/ for test: kms_sequence
results: parsing output: 79/ for test: gem_exec_schedule
results: parsing output: 80/ for test: kms_ccs
results: parsing output: 81/ for test: kms_fbcon_fbt
results: parsing output: 82/ for test: perf_pmu
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_flip
results: parsing output: 85/ for test: perf_pmu
results: parsing output: 86/ for test: gem_mmap_gtt
results: parsing output: 87/ for test: kms_force_connector_basic
results: parsing output: 88/ for test: kms_flip
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_psr2_sf
results: parsing output: 92/ for test: kms_dp_linktrain_fallback
results: parsing output: 93/ for test: gem_fence_thrash
results: parsing output: 94/ for test: kms_dsc
results: parsing output: 95/ for test: i915_drm_fdinfo
results: parsing output: 96/ for test: gem_sync
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: api_intel_allocator
results: parsing output: 99/ for test: syncobj_timeline
results: parsing output: 100/ for test: kms_atomic_transition
results: parsing output: 101/ for test: gem_watchdog
results: parsing output: 102/ for test: gem_mmap
results: parsing output: 103/ for test: kms_plane_alpha_blend
results: parsing output: 104/ for test: perf
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: kms_atomic_transition
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_content_protection
results: parsing output: 109/ for test: gem_softpin
results: parsing output: 110/ for test: gem_softpin
results: parsing output: 111/ for test: kms_ccs
results: parsing output: 112/ for test: syncobj_wait
results: parsing output: 113/ for test: gem_exec_balancer
results: parsing output: 114/ for test: kms_atomic_interruptible
results: parsing output: 115/ for test: kms_lease
results: parsing output: 116/ for test: kms_plane
results: parsing output: 117/ for test: gem_render_copy
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: gem_mmap_wc
results: parsing output: 120/ for test: gem_mmap
results: parsing output: 121/ for test: gem_ctx_persistence
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: syncobj_wait
results: parsing output: 124/ for test: kms_chamelium_edid
results: parsing output: 125/ for test: gem_exec_create
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_psr2_sf
results: parsing output: 128/ for test: kms_vrr
results: parsing output: 129/ for test: kms_flip
results: parsing output: 130/ for test: kms_rotation_crc
Done.