[56.276944] Initializing watchdogs
[56.277022]   /dev/watchdog0
[56.291587] [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.296045] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.298270] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.301682] [001/133] (960s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[56.374946] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[56.377429] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[56.483458] [002/133] (960s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[56.585230] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[56.587317] Starting dynamic subtest: pipe-A
[57.826528] Dynamic subtest pipe-A: SUCCESS (1.244s)
[57.834657] Starting dynamic subtest: pipe-B
[60.107781] Dynamic subtest pipe-B: SUCCESS (2.281s)
[60.116429] Starting dynamic subtest: pipe-C
[61.269363] Dynamic subtest pipe-C: SUCCESS (1.161s)
[61.277981] Starting dynamic subtest: pipe-D
[62.507414] Dynamic subtest pipe-D: SUCCESS (1.237s)
[62.509772] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.925s)
[63.700986] [003/133] (953s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[63.809531] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[63.811911] Starting dynamic subtest: pipe-A-eDP-1
[63.906297] Dynamic subtest pipe-A-eDP-1: SKIP (0.101s)
[63.914487] Starting dynamic subtest: pipe-B-eDP-1
[65.081471] Dynamic subtest pipe-B-eDP-1: SKIP (1.174s)
[65.086023] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.277s)
[66.260142] [004/133] (950s left) kms_feature_discovery (dp-mst)
[66.348874] Starting subtest: dp-mst
[66.353324] Subtest dp-mst: SKIP (0.000s)
[66.429942] [005/133] (950s left) gem_tiled_pread_pwrite
[66.553338] [006/133] (950s left) gem_eio (in-flight-10ms)
[66.716561] Starting subtest: in-flight-10ms
[75.027043] Subtest in-flight-10ms: SUCCESS (8.310s)
[75.157271] [FACT gem_eio (in-flight-10ms)] new: kernel.kmod_is_loaded.vgem: true
[75.161169] [007/133] (941s left) kms_cursor_crc (cursor-onscreen-512x170)
[75.465762] Starting subtest: cursor-onscreen-512x170
[75.470832] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[75.606535] [008/133] (941s left) kms_chamelium_edid (dp-edid-read)
[75.991846] Subtest dp-edid-read: SKIP (0.000s)
[76.769020] [009/133] (940s left) kms_psr (pr-basic)
[76.875190] Starting subtest: pr-basic
[76.879587] Subtest pr-basic: SKIP (0.000s)
[76.947152] [010/133] (940s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[77.035660] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[77.038359] Starting dynamic subtest: pipe-A-eDP-1
[77.061777] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[77.072202] Starting dynamic subtest: pipe-B-eDP-1
[77.093160] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[77.101215] Starting dynamic subtest: pipe-C-eDP-1
[77.122867] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[77.130480] Starting dynamic subtest: pipe-D-eDP-1
[77.152577] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[77.156613] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[79.354344] [011/133] (937s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[79.411571] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[79.416276] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[79.607124] [012/133] (937s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[79.709393] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[86.572826] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.868s)
[86.685283] [013/133] (930s left) sysfs_preempt_timeout (timeout)
[86.753724] Starting subtest: timeout
[86.756172] Starting dynamic subtest: vecs0
[96.336062] Dynamic subtest vecs0: SUCCESS (9.579s)
[96.347063] Starting dynamic subtest: ccs0
[97.514056] Dynamic subtest ccs0: SUCCESS (1.177s)
[97.524970] Starting dynamic subtest: vcs0
[107.335621] Dynamic subtest vcs0: SUCCESS (9.820s)
[107.346372] Starting dynamic subtest: bcs0
[108.526189] Dynamic subtest bcs0: SUCCESS (1.190s)
[108.536084] Starting dynamic subtest: rcs0
[109.786070] Dynamic subtest rcs0: SUCCESS (1.260s)
[109.797744] Starting dynamic subtest: vcs1
[119.309673] Dynamic subtest vcs1: SUCCESS (9.520s)
[119.312280] Subtest timeout: SUCCESS (32.553s)
[119.387677] [014/133] (897s left) gem_create (create-ext-set-pat)
[119.558334] Starting subtest: create-ext-set-pat
[119.560623] Subtest create-ext-set-pat: SUCCESS (0.001s)
[119.665920] [015/133] (897s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[119.771297] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[120.495406] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.726s)
[120.645724] [016/133] (896s left) kms_async_flips (async-flip-hang)
[120.738086] Starting subtest: async-flip-hang
[121.122393] Starting dynamic subtest: pipe-A-eDP-1
[136.743431] Dynamic subtest pipe-A-eDP-1: SUCCESS (15.618s)
[137.122368] Starting dynamic subtest: pipe-B-eDP-1
[152.742260] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.625s)
[153.143714] Starting dynamic subtest: pipe-C-eDP-1
[168.737541] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.596s)
[169.127839] Starting dynamic subtest: pipe-D-eDP-1
[184.741899] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.618s)
[184.744746] Subtest async-flip-hang: SUCCESS (64.002s)
[185.908461] [017/133] (831s left) kms_prop_blob (invalid-set-prop)
[185.963790] Starting subtest: invalid-set-prop
[185.966202] Subtest invalid-set-prop: SUCCESS (0.000s)
[186.058701] [018/133] (831s left) perf_pmu (busy-idle)
[186.104604] Starting subtest: busy-idle
[186.106896] Starting dynamic subtest: rcs0
[186.790274] Dynamic subtest rcs0: SUCCESS (0.688s)
[186.802203] Starting dynamic subtest: bcs0
[187.450942] Dynamic subtest bcs0: SUCCESS (0.660s)
[187.462963] Starting dynamic subtest: vcs0
[189.324331] Dynamic subtest vcs0: SUCCESS (1.870s)
[189.336184] Starting dynamic subtest: vcs1
[191.307532] Dynamic subtest vcs1: SUCCESS (1.982s)
[191.318572] Starting dynamic subtest: vecs0
[193.290834] Dynamic subtest vecs0: SUCCESS (1.982s)
[193.302363] Starting dynamic subtest: ccs0
[193.956042] Dynamic subtest ccs0: SUCCESS (0.665s)
[193.958637] Subtest busy-idle: SUCCESS (7.855s)
[194.065750] [019/133] (823s left) gem_exec_params (invalid-fence-in-submit)
[194.128124] Starting subtest: invalid-fence-in-submit
[194.138473] Subtest invalid-fence-in-submit: SUCCESS (0.008s)
[194.244316] [020/133] (823s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[194.343965] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[194.348079] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[194.435902] [021/133] (823s left) kms_big_fb (linear-32bpp-rotate-90)
[194.531421] Starting subtest: linear-32bpp-rotate-90
[194.549971] Subtest linear-32bpp-rotate-90: SKIP (0.019s)
[194.665728] [022/133] (822s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[194.768741] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[199.220587] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.455s)
[200.419784] [023/133] (817s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[200.515133] Starting subtest: flip-primary-invalidate-overlay
[212.143893] Subtest flip-primary-invalidate-overlay: SUCCESS (11.631s)
[212.304999] [024/133] (805s left) gem_ctx_persistence (legacy-engines-mixed)
[212.377641] Starting subtest: legacy-engines-mixed
[212.379694] Starting dynamic subtest: render
[212.454465] Dynamic subtest render: SUCCESS (0.076s)
[212.465727] Starting dynamic subtest: bsd1
[212.505565] Dynamic subtest bsd1: SUCCESS (0.049s)
[212.516418] Starting dynamic subtest: bsd2
[212.559243] Dynamic subtest bsd2: SUCCESS (0.052s)
[212.570037] Starting dynamic subtest: blt
[212.585093] Dynamic subtest blt: SUCCESS (0.024s)
[212.593464] Starting dynamic subtest: vebox
[212.646348] Dynamic subtest vebox: SUCCESS (0.060s)
[212.648465] Subtest legacy-engines-mixed: SUCCESS (0.269s)
[212.725446] [025/133] (805s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[212.819169] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[212.820775] Starting dynamic subtest: pipe-A-eDP-1
[213.240544] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.422s)
[213.251542] Starting dynamic subtest: pipe-B-eDP-1
[213.268501] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.003s)
[213.277624] Starting dynamic subtest: pipe-C-eDP-1
[213.293488] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[213.301901] Starting dynamic subtest: pipe-D-eDP-1
[213.317368] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[213.319119] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.436s)
[215.477046] [026/133] (802s left) gem_workarounds (suspend-resume)
[215.550794] Starting subtest: suspend-resume
[232.089248] Subtest suspend-resume: SUCCESS (1.270s)
[232.227032] [027/133] (785s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[232.329456] Starting subtest: fbc-psr-cursor-mmap-cpu
[232.331787] Starting dynamic subtest: eDP-1
[232.336219] Dynamic subtest eDP-1: SKIP (0.000s)
[232.340530] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.001s)
[232.428609] [028/133] (785s left) kms_pm_dc (dc3co-vpb-simulation)
[233.536101] Starting subtest: dc3co-vpb-simulation
[242.805993] Subtest dc3co-vpb-simulation: SKIP (9.265s)
[242.930015] [029/133] (774s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[243.028465] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[243.030701] Starting dynamic subtest: pipe-A
[243.048272] Dynamic subtest pipe-A: SKIP (0.017s)
[243.062609] Starting dynamic subtest: pipe-B
[243.081189] Dynamic subtest pipe-B: SKIP (0.031s)
[243.095445] Starting dynamic subtest: pipe-C
[243.110611] Dynamic subtest pipe-C: SKIP (0.031s)
[243.123641] Starting dynamic subtest: pipe-D
[243.141828] Dynamic subtest pipe-D: SKIP (0.031s)
[243.145650] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.111s)
[243.243281] [030/133] (774s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[243.346661] Starting subtest: psr-rgb565-draw-mmap-cpu
[250.160700] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.814s)
[250.286916] [031/133] (767s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[250.378784] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[250.392293] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.013s)
[250.494067] [032/133] (767s left) fbdev (unaligned-write)
[250.533089] Starting subtest: unaligned-write
[250.635404] Subtest unaligned-write: SUCCESS (0.103s)
[250.702980] [033/133] (767s left) syncobj_wait (invalid-wait-illegal-handle)
[250.751437] Starting subtest: invalid-wait-illegal-handle
[250.753701] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[250.863112] [034/133] (767s left) gem_exec_balancer (bonded-pair)
[250.921953] Starting subtest: bonded-pair
[250.926616] Subtest bonded-pair: SKIP (0.000s)
[251.245761] [035/133] (766s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping)
[251.335479] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping
[251.360893] Starting dynamic subtest: pipe-A-plane-0
[251.649767] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[251.660317] Starting dynamic subtest: pipe-A-plane-3
[251.883238] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[252.992677] Starting dynamic subtest: pipe-B-plane-0
[253.284269] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[253.294432] Starting dynamic subtest: pipe-B-plane-3
[253.517940] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[253.828652] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.493s)
[254.669158] [036/133] (763s left) kms_content_protection (dp-mst-type-0-hdcp14)
[254.814735] Starting subtest: dp-mst-type-0-hdcp14
[254.819377] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s)
[254.955898] [037/133] (763s left) i915_pm_rps (thresholds-idle)
[255.015547] Starting subtest: thresholds-idle
[255.019689] Subtest thresholds-idle: SKIP (0.001s)
[255.106618] [038/133] (763s left) gem_exec_params (no-vebox)
[255.162375] Starting subtest: no-vebox
[255.167260] Subtest no-vebox: SUCCESS (0.002s)
[256.625810] [039/133] (761s left) kms_psr (fbc-pr-basic)
[256.720599] Starting subtest: fbc-pr-basic
[256.724829] Subtest fbc-pr-basic: SKIP (0.000s)
[256.819505] [040/133] (761s left) gem_media_vme
[256.959613] [041/133] (761s left) gem_exec_schedule (in-order)
[257.041290] Starting subtest: in-order
[257.043665] Starting dynamic subtest: rcs0
[257.146485] Dynamic subtest rcs0: SUCCESS (0.114s)
[257.156150] Starting dynamic subtest: vcs0
[257.236215] Dynamic subtest vcs0: SUCCESS (0.087s)
[257.248921] Starting dynamic subtest: vcs1
[257.320034] Dynamic subtest vcs1: SUCCESS (0.083s)
[257.332925] Starting dynamic subtest: vecs0
[257.403627] Dynamic subtest vecs0: SUCCESS (0.083s)
[257.416395] Starting dynamic subtest: ccs0
[257.489041] Dynamic subtest ccs0: SUCCESS (0.085s)
[257.491835] Subtest in-order: SUCCESS (0.456s)
[258.632378] [042/133] (759s left) kms_addfb_basic (clobberred-modifier)
[258.688685] Starting subtest: clobberred-modifier
[258.692933] Subtest clobberred-modifier: SKIP (0.000s)
[258.830069] [043/133] (759s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[258.928805] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[265.760437] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.834s)
[265.913086] [044/133] (752s left) gen7_exec_parse (basic-allocation)
[265.978125] Subtest basic-allocation: SKIP (0.000s)
[266.049640] [045/133] (752s left) gem_pwrite_snooped
[266.183601] [046/133] (752s left) kms_frontbuffer_tracking (psr-1p-rte)
[266.281698] Starting subtest: psr-1p-rte
[271.732642] Subtest psr-1p-rte: SUCCESS (5.454s)
[271.858469] [047/133] (746s left) gen9_exec_parse (bb-start-cmd)
[271.919219] Subtest bb-start-cmd: SKIP (0.000s)
[271.985896] [048/133] (746s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[272.083509] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[272.088003] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[272.177284] [049/133] (746s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[272.235866] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[272.237828] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[272.352010] [050/133] (746s left) gem_mmap_wc (write-prefaulted)
[272.406799] Subtest write-prefaulted: SKIP (0.000s)
[272.474654] [051/133] (746s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[272.598108] Starting subtest: short-flip-before-cursor-toggle
[273.517465] Subtest short-flip-before-cursor-toggle: SUCCESS (0.917s)
[274.368228] [052/133] (744s left) kms_cursor_edge_walk (256x256-top-edge)
[274.469764] Starting subtest: 256x256-top-edge
[274.472094] Starting dynamic subtest: pipe-A-eDP-1
[277.911636] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.442s)
[277.922829] Starting dynamic subtest: pipe-D-eDP-1
[281.048862] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.136s)
[281.051196] Subtest 256x256-top-edge: SUCCESS (6.581s)
[281.848780] [053/133] (737s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[281.955664] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[281.959670] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[282.056418] [054/133] (736s left) gem_ctx_shared (exec-shared-gtt)
[282.119814] Starting subtest: exec-shared-gtt
[282.122077] Starting dynamic subtest: rcs0
[282.125388] Dynamic subtest rcs0: SUCCESS (0.008s)
[282.137402] Starting dynamic subtest: bcs0
[282.139619] Dynamic subtest bcs0: SUCCESS (0.004s)
[282.149553] Starting dynamic subtest: vcs0
[282.151823] Dynamic subtest vcs0: SUCCESS (0.006s)
[282.161511] Starting dynamic subtest: vcs1
[282.163372] Dynamic subtest vcs1: SUCCESS (0.007s)
[282.173249] Starting dynamic subtest: vecs0
[282.175538] Dynamic subtest vecs0: SUCCESS (0.005s)
[282.185264] Starting dynamic subtest: ccs0
[282.187114] Dynamic subtest ccs0: SUCCESS (0.005s)
[282.188950] Subtest exec-shared-gtt: SUCCESS (0.039s)
[282.343912] [055/133] (736s left) perf (non-system-wide-paranoid)
[282.474676] Starting subtest: non-system-wide-paranoid
[282.498413] Subtest non-system-wide-paranoid: SUCCESS (0.026s)
[282.551866] [056/133] (736s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[282.644615] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs
[282.646921] Starting dynamic subtest: pipe-A-eDP-1
[282.669390] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[282.679904] Starting dynamic subtest: pipe-B-eDP-1
[282.700434] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[282.709382] Starting dynamic subtest: pipe-C-eDP-1
[282.730295] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[282.739934] Starting dynamic subtest: pipe-D-eDP-1
[282.761444] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[282.765755] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[284.829669] [057/133] (734s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[284.922575] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[284.924739] Starting dynamic subtest: pipe-A-default-mode
[286.134172] Dynamic subtest pipe-A-default-mode: SKIP (1.210s)
[286.138491] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.212s)
[286.292472] [058/133] (732s left) kms_async_flips (invalid-async-flip-atomic)
[286.405462] Starting subtest: invalid-async-flip-atomic
[286.779008] Starting dynamic subtest: pipe-A-eDP-1
[287.590020] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.810s)
[287.946765] Starting dynamic subtest: pipe-B-eDP-1
[288.720137] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.781s)
[289.080450] Starting dynamic subtest: pipe-C-eDP-1
[289.849549] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.778s)
[290.207439] Starting dynamic subtest: pipe-D-eDP-1
[290.969581] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.771s)
[290.971731] Subtest invalid-async-flip-atomic: SUCCESS (4.567s)
[292.123266] [059/133] (727s left) api_intel_bb (object-reloc-purge-cache)
[292.178599] Starting subtest: object-reloc-purge-cache
[292.182608] Subtest object-reloc-purge-cache: SKIP (0.003s)
[292.298726] [060/133] (727s left) gem_exec_fence (keep-in-fence)
[292.473525] Starting subtest: keep-in-fence
[292.475812] Starting dynamic subtest: rcs0
[292.529578] Dynamic subtest rcs0: SUCCESS (0.055s)
[292.544312] Starting dynamic subtest: bcs0
[292.584002] Dynamic subtest bcs0: SUCCESS (0.052s)
[292.596661] Starting dynamic subtest: vcs0
[294.578736] Dynamic subtest vcs0: SUCCESS (1.991s)
[294.590457] Starting dynamic subtest: vcs1
[296.561689] Dynamic subtest vcs1: SUCCESS (1.980s)
[296.576969] Starting dynamic subtest: vecs0
[298.546565] Dynamic subtest vecs0: SUCCESS (1.981s)
[298.564183] Starting dynamic subtest: ccs0
[298.774982] Dynamic subtest ccs0: SUCCESS (0.227s)
[298.777684] Subtest keep-in-fence: SUCCESS (6.302s)
[300.650765] [061/133] (718s left) gem_exec_schedule (smoketest-all)
[300.726861] Starting subtest: smoketest-all
[333.120993] Subtest smoketest-all: SUCCESS (32.350s)
[334.577194] [062/133] (684s left) api_intel_allocator (execbuf-with-allocator)
[334.623662] Starting subtest: execbuf-with-allocator
[334.632562] Subtest execbuf-with-allocator: SUCCESS (0.009s)
[334.751057] [063/133] (684s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[334.847194] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[334.849494] Starting dynamic subtest: pipe-A-default-mode
[337.568020] Dynamic subtest pipe-A-default-mode: SUCCESS (2.720s)
[337.570195] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.721s)
[338.395022] [064/133] (681s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[338.509773] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[338.513489] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[338.636168] [065/133] (680s left) perf_pmu (invalid-init)
[338.681927] Starting subtest: invalid-init
[338.684188] Subtest invalid-init: SUCCESS (0.000s)
[338.802410] [066/133] (680s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[338.898460] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[338.902409] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[339.003515] [067/133] (680s left) prime_vgem (basic-fence-mmap)
[339.080409] Starting subtest: basic-fence-mmap
[339.084931] Subtest basic-fence-mmap: SKIP (0.000s)
[339.181336] [068/133] (680s left) kms_psr (psr2-primary-blt)
[339.275615] Starting subtest: psr2-primary-blt
[339.277850] Starting dynamic subtest: eDP-1
[340.977457] Dynamic subtest eDP-1: SUCCESS (1.700s)
[340.979666] Subtest psr2-primary-blt: SUCCESS (1.701s)
[341.844453] [069/133] (677s left) gem_exec_schedule (u-semaphore-resolve)
[341.935984] Starting subtest: u-semaphore-resolve
[341.966356] Subtest u-semaphore-resolve: SUCCESS (0.039s)
[342.318778] [070/133] (677s left) gem_exercise_blt (fast-copy-emit)
[342.375615] Starting subtest: fast-copy-emit
[342.377961] Starting dynamic subtest: linear-smem-smem-emit
[342.399729] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.023s)
[342.411958] Starting dynamic subtest: xmajor-smem-smem-emit
[342.416663] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.016s)
[342.426634] Starting dynamic subtest: tile4-smem-smem-emit
[342.432898] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.016s)
[342.443787] Starting dynamic subtest: tile64-smem-smem-emit
[342.450547] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.017s)
[342.452808] Subtest fast-copy-emit: SUCCESS (0.075s)
[342.579831] [071/133] (677s left) kms_vblank (query-forked-busy)
[342.672512] Starting subtest: query-forked-busy
[342.674415] Starting dynamic subtest: pipe-A-eDP-1
[344.557049] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.885s)
[344.574985] Starting dynamic subtest: pipe-D-eDP-1
[347.113372] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.554s)
[347.115737] Subtest query-forked-busy: SUCCESS (4.443s)
[347.906936] [072/133] (671s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[347.992005] Starting subtest: fbc-rgb101010-draw-pwrite
[353.368358] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.379s)
[354.505820] [073/133] (665s left) kms_sequence (queue-busy)
[354.601445] Starting subtest: queue-busy
[354.603654] Starting dynamic subtest: pipe-A-eDP-1
[356.535838] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.932s)
[356.546200] Starting dynamic subtest: pipe-B-eDP-1
[359.108363] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.573s)
[359.122810] Starting dynamic subtest: pipe-C-eDP-1
[361.711421] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.602s)
[361.722223] Starting dynamic subtest: pipe-D-eDP-1
[364.245270] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.531s)
[364.247681] Subtest queue-busy: SUCCESS (9.646s)
[365.130750] [074/133] (654s left) gem_eio (in-flight-internal-10ms)
[365.367275] Starting subtest: in-flight-internal-10ms
[366.665385] Subtest in-flight-internal-10ms: SUCCESS (1.296s)
[366.810375] [075/133] (653s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[366.921033] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[398.864372] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.942s)
[399.658919] [076/133] (620s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[399.770061] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[399.774181] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[399.883492] [077/133] (620s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[399.976679] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[403.989250] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (4.015s)
[405.181198] [078/133] (614s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[405.291478] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[405.295734] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[405.395915] [079/133] (614s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[405.490257] Starting subtest: y-tiled-8bpp-rotate-0
[405.494923] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[405.590801] [080/133] (614s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[405.685268] Starting subtest: fbcpsr-shrfb-scaledprimary
[411.492345] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.810s)
[411.620692] [081/133] (608s left) kms_prop_blob (basic)
[411.680623] Starting subtest: basic
[411.682530] Subtest basic: SUCCESS (0.000s)
[411.770312] [082/133] (608s left) i915_drm_fdinfo (busy)
[411.813279] Starting subtest: busy
[411.815129] Starting dynamic subtest: rcs0
[411.833947] Dynamic subtest rcs0: SKIP (0.020s)
[411.844657] Starting dynamic subtest: bcs0
[411.848509] Dynamic subtest bcs0: SKIP (0.000s)
[411.858348] Starting dynamic subtest: vcs0
[411.862821] Dynamic subtest vcs0: SKIP (0.000s)
[411.871953] Starting dynamic subtest: vcs1
[411.876080] Dynamic subtest vcs1: SKIP (0.000s)
[411.887689] Starting dynamic subtest: vecs0
[411.891532] Dynamic subtest vecs0: SKIP (0.000s)
[411.900506] Starting dynamic subtest: ccs0
[411.904445] Dynamic subtest ccs0: SKIP (0.000s)
[411.908392] Subtest busy: SKIP (0.025s)
[411.945461] [083/133] (608s left) kms_psr (fbc-psr2-primary-page-flip)
[412.051472] Starting subtest: fbc-psr2-primary-page-flip
[412.053664] Starting dynamic subtest: eDP-1
[412.057702] Dynamic subtest eDP-1: SKIP (0.000s)
[412.061743] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[412.125967] [084/133] (608s left) syncobj_timeline (wait-all-for-submit-complex)
[412.176497] Starting subtest: wait-all-for-submit-complex
[412.390409] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[412.469215] [085/133] (607s left) dmabuf (all-tests)
[412.504208] Starting subtest: all-tests
[412.508750] Subtest all-tests: SKIP (0.000s)
[412.558526] [086/133] (607s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[412.652532] Starting subtest: psr-rgb565-draw-render
[419.791098] Subtest psr-rgb565-draw-render: SUCCESS (7.139s)
[419.892304] [087/133] (600s left) gem_mmap_gtt (zero-extend)
[419.952954] Subtest zero-extend: SKIP (0.000s)
[420.016603] [088/133] (600s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[420.110645] Starting subtest: x-tiled-32bpp-rotate-270
[420.130341] Subtest x-tiled-32bpp-rotate-270: SKIP (0.019s)
[420.260705] [089/133] (600s left) kms_vrr (flipline)
[420.380480] Starting subtest: flipline
[420.386754] Subtest flipline: SKIP (0.000s)
[420.454242] [090/133] (600s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[420.514408] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[420.518936] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[420.694623] [091/133] (599s left) kms_plane_multiple (2x-tiling-y)
[420.786803] Starting subtest: 2x-tiling-y
[420.790957] Subtest 2x-tiling-y: SKIP (0.000s)
[420.868694] [092/133] (599s left) gem_exec_fence (basic-wait)
[421.036966] Starting subtest: basic-wait
[421.039337] Starting dynamic subtest: rcs0
[421.129458] Dynamic subtest rcs0: SUCCESS (0.092s)
[421.142195] Starting dynamic subtest: bcs0
[421.184699] Dynamic subtest bcs0: SUCCESS (0.053s)
[421.197080] Starting dynamic subtest: vcs0
[421.236576] Dynamic subtest vcs0: SUCCESS (0.050s)
[421.248663] Starting dynamic subtest: vcs1
[421.293524] Dynamic subtest vcs1: SUCCESS (0.054s)
[421.304848] Starting dynamic subtest: vecs0
[421.355222] Dynamic subtest vecs0: SUCCESS (0.060s)
[421.365955] Starting dynamic subtest: ccs0
[421.417902] Dynamic subtest ccs0: SUCCESS (0.060s)
[421.420249] Subtest basic-wait: SUCCESS (0.382s)
[423.686361] [093/133] (597s left) kms_color (ctm-0-50)
[423.782384] Starting subtest: ctm-0-50
[423.784636] Starting dynamic subtest: pipe-A-eDP-1
[427.320878] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.540s)
[427.332777] Starting dynamic subtest: pipe-B-eDP-1
[431.529075] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.206s)
[431.540237] Starting dynamic subtest: pipe-C-eDP-1
[435.575584] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.043s)
[435.586421] Starting dynamic subtest: pipe-D-eDP-1
[439.584759] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.008s)
[439.586624] Subtest ctm-0-50: SUCCESS (15.800s)
[440.405131] [094/133] (580s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[440.511909] Starting subtest: 4-tiled-32bpp-rotate-90
[440.531432] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.019s)
[440.646039] [095/133] (580s left) syncobj_wait (wait-all-delayed-signal)
[440.710351] Starting subtest: wait-all-delayed-signal
[440.815504] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[440.926447] [096/133] (579s left) i915_pm_rpm (gem-pread)
[442.772435] Starting subtest: gem-pread
[444.913899] Subtest gem-pread: SUCCESS (2.145s)
[445.002447] [097/133] (575s left) gem_softpin (allocator-basic)
[445.068148] Starting subtest: allocator-basic
[445.143259] Subtest allocator-basic: SUCCESS (0.075s)
[445.278126] [098/133] (575s left) gem_basic (create-close)
[445.331280] Starting subtest: create-close
[445.335601] Subtest create-close: SUCCESS (0.000s)
[445.437633] [099/133] (575s left) syncobj_timeline (invalid-query-zero-handles)
[445.499495] Starting subtest: invalid-query-zero-handles
[445.501396] Subtest invalid-query-zero-handles: SUCCESS (0.000s)
[445.594542] [100/133] (575s left) gem_exec_params (invalid-flag)
[445.648273] Starting subtest: invalid-flag
[445.650679] Subtest invalid-flag: SUCCESS (0.000s)
[445.771817] [101/133] (575s left) kms_invalid_mode (int-max-clock)
[445.867939] Starting subtest: int-max-clock
[445.870167] Starting dynamic subtest: pipe-A-eDP-1
[446.149495] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[446.160187] Starting dynamic subtest: pipe-B-eDP-1
[446.162388] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[446.172172] Starting dynamic subtest: pipe-C-eDP-1
[446.174413] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[446.183936] Starting dynamic subtest: pipe-D-eDP-1
[446.185769] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[446.188113] Subtest int-max-clock: SUCCESS (0.290s)
[447.003191] [102/133] (574s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[447.383531] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[448.208131] [103/133] (572s left) gem_eio (wait-immediate)
[448.439321] Starting subtest: wait-immediate
[448.832232] Subtest wait-immediate: SUCCESS (0.391s)
[448.980855] [104/133] (572s left) kms_cursor_crc (cursor-random-max-size)
[449.324850] Starting subtest: cursor-random-max-size
[449.330506] Subtest cursor-random-max-size: SKIP (0.000s)
[449.440735] [105/133] (571s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[449.542712] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[454.000077] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.460s)
[455.136411] [106/133] (566s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[455.233581] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[455.235832] Starting dynamic subtest: pipe-A-eDP-1
[455.260752] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[455.271357] Starting dynamic subtest: pipe-B-eDP-1
[455.294924] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[455.305271] Starting dynamic subtest: pipe-C-eDP-1
[455.328938] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[455.339043] Starting dynamic subtest: pipe-D-eDP-1
[455.363099] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[455.367153] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[457.484457] [107/133] (563s left) gem_ctx_param (set-priority-range)
[457.537520] Starting subtest: set-priority-range
[457.550201] Subtest set-priority-range: SUCCESS (0.014s)
[457.655556] [108/133] (563s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[457.766677] Starting subtest: cursorB-vs-flipA-legacy
[457.771255] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[457.931940] [109/133] (563s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[458.028558] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[458.032780] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[458.121896] [110/133] (563s left) gem_ctx_persistence (engines-mixed-process)
[458.186274] Starting subtest: engines-mixed-process
[458.188136] Starting dynamic subtest: rcs0
[459.489029] Dynamic subtest rcs0: SUCCESS (1.301s)
[459.501409] Starting dynamic subtest: bcs0
[461.538385] Dynamic subtest bcs0: SUCCESS (2.049s)
[461.549623] Starting dynamic subtest: vcs0
[463.534993] Dynamic subtest vcs0: SUCCESS (1.998s)
[463.547088] Starting dynamic subtest: vcs1
[465.504707] Dynamic subtest vcs1: SUCCESS (1.968s)
[465.514918] Starting dynamic subtest: vecs0
[467.521406] Dynamic subtest vecs0: SUCCESS (2.015s)
[467.534000] Starting dynamic subtest: ccs0
[469.549139] Dynamic subtest ccs0: SUCCESS (2.026s)
[469.551513] Subtest engines-mixed-process: SUCCESS (11.365s)
[469.630060] [111/133] (551s left) syncobj_wait (reset-unsignaled)
[469.683643] Starting subtest: reset-unsignaled
[469.685921] Subtest reset-unsignaled: SUCCESS (0.000s)
[469.802155] [112/133] (551s left) gem_exec_whisper (basic-fds)
[469.868407] Starting subtest: basic-fds
[478.443343] Subtest basic-fds: SUCCESS (8.574s)
[478.632932] [113/133] (542s left) gem_workarounds (basic-read)
[478.707424] Starting subtest: basic-read
[478.731291] Subtest basic-read: SUCCESS (0.024s)
[478.850213] [114/133] (542s left) gem_ctx_bad_destroy (invalid-ctx)
[478.906854] Starting subtest: invalid-ctx
[478.909148] Subtest invalid-ctx: SUCCESS (0.000s)
[479.003636] [115/133] (542s left) gem_mmap_gtt (medium-copy-odd)
[479.067229] Subtest medium-copy-odd: SKIP (0.000s)
[479.131181] [116/133] (542s left) gem_unfence_active_buffers
[479.307151] [117/133] (542s left) kms_rotation_crc (sprite-rotation-90)
[479.414401] Starting subtest: sprite-rotation-90
[479.418934] Subtest sprite-rotation-90: SKIP (0.001s)
[479.492521] [118/133] (542s left) prime_vgem (basic-fence-blt)
[479.568538] Starting subtest: basic-fence-blt
[479.658110] Subtest basic-fence-blt: SUCCESS (0.089s)
[479.794597] [119/133] (542s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[479.890696] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[479.892448] Starting dynamic subtest: pipe-A-eDP-1
[479.939183] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[479.949603] Starting dynamic subtest: pipe-B-eDP-1
[479.994269] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[480.004690] Starting dynamic subtest: pipe-C-eDP-1
[480.053382] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[480.064624] Starting dynamic subtest: pipe-D-eDP-1
[480.111124] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[480.114798] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.009s)
[482.067514] [120/133] (539s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[482.162184] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[482.166173] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[482.260215] [121/133] (539s left) kms_pipe_crc_basic (suspend-read-crc)
[482.355407] Starting subtest: suspend-read-crc
[482.357650] Starting dynamic subtest: pipe-A-eDP-1
[499.984344] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.538s)
[500.004503] Starting dynamic subtest: pipe-B-eDP-1
[518.015123] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.209s)
[518.026603] Starting dynamic subtest: pipe-C-eDP-1
[535.970513] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.066s)
[535.982329] Starting dynamic subtest: pipe-D-eDP-1
[553.954488] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.045s)
[553.956826] Subtest suspend-read-crc: SUCCESS (11.864s)
[554.784989] [122/133] (467s left) gem_userptr_blits (process-exit)
[554.876449] Starting subtest: process-exit
[554.883897] Subtest process-exit: SUCCESS (0.008s)
[555.031632] [123/133] (467s left) i915_fb_tiling (basic-x-tiling)
[555.087356] Subtest basic-x-tiling: SKIP (0.000s)
[555.147415] [124/133] (466s left) gem_ctx_param (invalid-param-set)
[555.200858] Starting subtest: invalid-param-set
[555.203181] Subtest invalid-param-set: SUCCESS (0.000s)
[555.296514] [125/133] (466s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[555.400396] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[555.402620] Starting dynamic subtest: A-eDP1
[559.110349] Dynamic subtest A-eDP1: SUCCESS (3.701s)
[559.122505] Starting dynamic subtest: B-eDP1
[562.310657] Dynamic subtest B-eDP1: SUCCESS (3.196s)
[562.322646] Starting dynamic subtest: C-eDP1
[565.420254] Dynamic subtest C-eDP1: SUCCESS (3.106s)
[565.431787] Starting dynamic subtest: D-eDP1
[568.527683] Dynamic subtest D-eDP1: SUCCESS (3.105s)
[568.529892] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.116s)
[569.340732] [126/133] (452s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[569.447783] Starting subtest: yf-tiled-64bpp-rotate-90
[569.452191] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[569.557868] [127/133] (452s left) kms_lease (atomic-implicit-crtc)
[569.640003] Starting subtest: atomic-implicit-crtc
[569.642298] Starting dynamic subtest: pipe-A-eDP-1
[569.653636] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[569.671590] Starting dynamic subtest: pipe-B-eDP-1
[569.682826] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[569.695309] Starting dynamic subtest: pipe-C-eDP-1
[569.706247] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[569.716610] Starting dynamic subtest: pipe-D-eDP-1
[569.727667] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[569.730407] Subtest atomic-implicit-crtc: SUCCESS (0.036s)
[569.781522] [128/133] (452s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[569.885505] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[577.173233] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.285s)
[577.309774] [129/133] (444s left) kms_hdr (bpc-switch-dpms)
[577.398808] Starting subtest: bpc-switch-dpms
[578.441225] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[582.876770] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SUCCESS (4.433s)
[583.928817] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[588.327224] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SUCCESS (4.412s)
[588.329369] Subtest bpc-switch-dpms: SUCCESS (10.931s)
[588.431102] [130/133] (433s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[588.552395] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[588.556717] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[588.698631] [131/133] (433s left) gem_fence_thrash (bo-write-verify-threaded-none)
[588.735484] Starting subtest: bo-write-verify-threaded-none
[588.745313] Subtest bo-write-verify-threaded-none: SKIP (0.011s)
[588.807296] [132/133] (433s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[588.859247] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[588.959455] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.101s)
[589.043134] [133/133] (433s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[589.139262] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[589.143319] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[589.238657] Closing watchdogs
results: parsing output: 0/ for test: syncobj_timeline
results: parsing output: 1/ for test: kms_plane_scaling
results: parsing output: 2/ for test: kms_psr2_sf
results: parsing output: 3/ for test: kms_feature_discovery
results: parsing output: 4/ for test: gem_tiled_pread_pwrite
results: parsing output: 5/ for test: gem_eio
results: parsing output: 6/ for test: kms_cursor_crc
results: parsing output: 7/ for test: kms_chamelium_edid
results: parsing output: 8/ for test: kms_psr
results: parsing output: 9/ for test: kms_ccs
results: parsing output: 10/ for test: gem_render_copy
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: sysfs_preempt_timeout
results: parsing output: 13/ for test: gem_create
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: kms_async_flips
results: parsing output: 16/ for test: kms_prop_blob
results: parsing output: 17/ for test: perf_pmu
results: parsing output: 18/ for test: gem_exec_params
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_psr_stress_test
results: parsing output: 23/ for test: gem_ctx_persistence
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: gem_workarounds
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: kms_pm_dc
results: parsing output: 28/ for test: kms_plane_scaling
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_flip
results: parsing output: 31/ for test: fbdev
results: parsing output: 32/ for test: syncobj_wait
results: parsing output: 33/ for test: gem_exec_balancer
results: parsing output: 34/ for test: kms_plane
results: parsing output: 35/ for test: kms_content_protection
results: parsing output: 36/ for test: i915_pm_rps
results: parsing output: 37/ for test: gem_exec_params
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: gem_media_vme
results: parsing output: 40/ for test: gem_exec_schedule
results: parsing output: 41/ for test: kms_addfb_basic
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gen7_exec_parse
results: parsing output: 44/ for test: gem_pwrite_snooped
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gen9_exec_parse
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: syncobj_timeline
results: parsing output: 49/ for test: gem_mmap_wc
results: parsing output: 50/ for test: kms_cursor_legacy
results: parsing output: 51/ for test: kms_cursor_edge_walk
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: gem_ctx_shared
results: parsing output: 54/ for test: perf
results: parsing output: 55/ for test: kms_ccs
results: parsing output: 56/ for test: kms_flip_scaled_crc
results: parsing output: 57/ for test: kms_async_flips
results: parsing output: 58/ for test: api_intel_bb
results: parsing output: 59/ for test: gem_exec_fence
results: parsing output: 60/ for test: gem_exec_schedule
results: parsing output: 61/ for test: api_intel_allocator
results: parsing output: 62/ for test: kms_flip_scaled_crc
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: perf_pmu
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: prime_vgem
results: parsing output: 67/ for test: kms_psr
results: parsing output: 68/ for test: gem_exec_schedule
results: parsing output: 69/ for test: gem_exercise_blt
results: parsing output: 70/ for test: kms_vblank
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_sequence
results: parsing output: 73/ for test: gem_eio
results: parsing output: 74/ for test: kms_cursor_legacy
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_prop_blob
results: parsing output: 81/ for test: i915_drm_fdinfo
results: parsing output: 82/ for test: kms_psr
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: dmabuf
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_mmap_gtt
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: kms_vrr
results: parsing output: 89/ for test: gem_render_copy
results: parsing output: 90/ for test: kms_plane_multiple
results: parsing output: 91/ for test: gem_exec_fence
results: parsing output: 92/ for test: kms_color
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: syncobj_wait
results: parsing output: 95/ for test: i915_pm_rpm
results: parsing output: 96/ for test: gem_softpin
results: parsing output: 97/ for test: gem_basic
results: parsing output: 98/ for test: syncobj_timeline
results: parsing output: 99/ for test: gem_exec_params
results: parsing output: 100/ for test: kms_invalid_mode
results: parsing output: 101/ for test: kms_chamelium_hpd
results: parsing output: 102/ for test: gem_eio
results: parsing output: 103/ for test: kms_cursor_crc
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_ccs
results: parsing output: 106/ for test: gem_ctx_param
results: parsing output: 107/ for test: kms_cursor_legacy
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_ctx_persistence
results: parsing output: 110/ for test: syncobj_wait
results: parsing output: 111/ for test: gem_exec_whisper
results: parsing output: 112/ for test: gem_workarounds
results: parsing output: 113/ for test: gem_ctx_bad_destroy
results: parsing output: 114/ for test: gem_mmap_gtt
results: parsing output: 115/ for test: gem_unfence_active_buffers
results: parsing output: 116/ for test: kms_rotation_crc
results: parsing output: 117/ for test: prime_vgem
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_pipe_crc_basic
results: parsing output: 121/ for test: gem_userptr_blits
results: parsing output: 122/ for test: i915_fb_tiling
results: parsing output: 123/ for test: gem_ctx_param
results: parsing output: 124/ for test: kms_flip
results: parsing output: 125/ for test: kms_big_fb
results: parsing output: 126/ for test: kms_lease
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_hdr
results: parsing output: 129/ for test: kms_cursor_legacy
results: parsing output: 130/ for test: gem_fence_thrash
results: parsing output: 131/ for test: syncobj_timeline
results: parsing output: 132/ for test: kms_big_fb
Done.