[106.017895] Initializing watchdogs
[106.018083]   /dev/watchdog0
[106.033719] [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]
[106.038174] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[106.040603] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[106.044208] [001/133] (960s left) gem_vm_create (execbuf)
[106.138534] Starting subtest: execbuf
[106.146041] Subtest execbuf: SUCCESS (0.009s)
[106.275972] [002/133] (960s left) gem_exec_reloc (basic-gtt-read)
[106.336211] Subtest basic-gtt-read: SKIP (0.000s)
[106.415437] [003/133] (960s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[106.500600] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[106.502802] Starting dynamic subtest: pipe-A
[106.587786] Dynamic subtest pipe-A: SUCCESS (0.089s)
[106.596820] Starting dynamic subtest: pipe-B
[107.732896] Dynamic subtest pipe-B: SUCCESS (1.144s)
[107.741629] Starting dynamic subtest: pipe-C
[108.834328] Dynamic subtest pipe-C: SUCCESS (1.101s)
[108.842779] Starting dynamic subtest: pipe-D
[109.968877] Dynamic subtest pipe-D: SUCCESS (1.134s)
[109.971153] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.470s)
[111.132797] [004/133] (955s left) kms_pm_rpm (modeset-pc8-residency-stress)
[113.095987] Starting subtest: modeset-pc8-residency-stress
[113.100910] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[113.478704] [005/133] (953s left) kms_flip (basic-flip-vs-dpms)
[113.568242] Starting subtest: basic-flip-vs-dpms
[113.570254] Starting dynamic subtest: A-eDP1
[116.156076] Dynamic subtest A-eDP1: SUCCESS (2.589s)
[116.164408] Starting dynamic subtest: B-eDP1
[118.325550] Dynamic subtest B-eDP1: SUCCESS (2.168s)
[118.335485] Starting dynamic subtest: C-eDP1
[120.405225] Dynamic subtest C-eDP1: SUCCESS (2.079s)
[120.413963] Starting dynamic subtest: D-eDP1
[122.478252] Dynamic subtest D-eDP1: SUCCESS (2.072s)
[122.480605] Subtest basic-flip-vs-dpms: SUCCESS (8.914s)
[123.287037] [006/133] (943s left) kms_async_flips (async-flip-dpms)
[123.392099] Starting subtest: async-flip-dpms
[123.766423] Starting dynamic subtest: pipe-A-eDP-1
[127.691779] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.925s)
[128.082558] Starting dynamic subtest: pipe-B-eDP-1
[130.866128] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.790s)
[131.265536] Starting dynamic subtest: pipe-C-eDP-1
[134.048144] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.786s)
[134.420556] Starting dynamic subtest: pipe-D-eDP-1
[137.204381] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.790s)
[137.206817] Subtest async-flip-dpms: SUCCESS (13.813s)
[138.423636] [007/133] (928s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[138.515120] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[138.517366] Starting dynamic subtest: pipe-A
[138.535129] Dynamic subtest pipe-A: SKIP (0.018s)
[138.543215] Starting dynamic subtest: pipe-B
[138.567201] Dynamic subtest pipe-B: SKIP (0.032s)
[138.574128] Starting dynamic subtest: pipe-C
[138.598349] Dynamic subtest pipe-C: SKIP (0.031s)
[138.605213] Starting dynamic subtest: pipe-D
[138.629651] Dynamic subtest pipe-D: SKIP (0.031s)
[138.633997] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.112s)
[138.768734] [008/133] (928s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[143.775427] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[143.780084] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.002s)
[144.633563] [009/133] (922s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[144.740459] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[144.744790] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[144.872144] [010/133] (922s left) syncobj_timeline (signal-array)
[144.937889] Starting subtest: signal-array
[144.940296] Subtest signal-array: SUCCESS (0.000s)
[145.047850] [011/133] (921s left) kms_big_fb (yf-tiled-addfb)
[145.145065] Starting subtest: yf-tiled-addfb
[145.149197] Subtest yf-tiled-addfb: SKIP (0.000s)
[145.273602] [012/133] (921s left) drm_buddy (drm_buddy)
[145.312356] Starting subtest: drm_buddy
[145.326920] Starting dynamic subtest: drm_test_buddy_alloc_limit
[145.451333] Dynamic subtest drm_test_buddy_alloc_limit: SUCCESS (0.124s)
[145.457886] Starting dynamic subtest: drm_test_buddy_alloc_optimistic
[145.569477] Dynamic subtest drm_test_buddy_alloc_optimistic: SUCCESS (0.117s)
[145.576341] Starting dynamic subtest: drm_test_buddy_alloc_pessimistic
[145.713319] Dynamic subtest drm_test_buddy_alloc_pessimistic: SUCCESS (0.144s)
[145.721964] Starting dynamic subtest: drm_test_buddy_alloc_pathological
[145.861382] Dynamic subtest drm_test_buddy_alloc_pathological: SUCCESS (0.148s)
[145.870042] Starting dynamic subtest: drm_test_buddy_alloc_contiguous
[146.014596] Dynamic subtest drm_test_buddy_alloc_contiguous: SUCCESS (0.153s)
[146.022470] Starting dynamic subtest: drm_test_buddy_alloc_clear
[146.186091] Dynamic subtest drm_test_buddy_alloc_clear: SUCCESS (0.171s)
[146.194946] Starting dynamic subtest: drm_test_buddy_alloc_range_bias
[146.318051] Dynamic subtest drm_test_buddy_alloc_range_bias: SUCCESS (0.130s)
[146.326697] Starting dynamic subtest: drm_test_buddy_fragmentation_performance
[150.455092] Dynamic subtest drm_test_buddy_fragmentation_performance: SUCCESS (4.137s)
[150.464174] Starting dynamic subtest: drm_test_buddy_alloc_exceeds_max_order
[150.598083] Dynamic subtest drm_test_buddy_alloc_exceeds_max_order: SUCCESS (0.141s)
[150.600164] Subtest drm_buddy: SUCCESS (5.284s)
[150.803972] [013/133] (916s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[150.900283] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[150.902466] Starting dynamic subtest: pipe-A-eDP-1
[150.924491] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[150.933738] Starting dynamic subtest: pipe-B-eDP-1
[150.956155] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[150.967355] Starting dynamic subtest: pipe-C-eDP-1
[150.989672] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[150.999474] Starting dynamic subtest: pipe-D-eDP-1
[151.022786] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[151.027061] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[153.202686] [014/133] (913s left) gem_exec_fence (syncobj-export)
[153.645889] Starting subtest: syncobj-export
[153.651113] Subtest syncobj-export: SUCCESS (0.005s)
[154.994338] [FACT gem_exec_fence (syncobj-export)] new: kernel.kmod_is_loaded.vgem: true
[154.997761] [015/133] (912s left) i915_pm_rpm (debugfs-forcewake-user)
[157.025966] Starting subtest: debugfs-forcewake-user
[168.425213] Subtest debugfs-forcewake-user: SUCCESS (11.400s)
[168.814213] [016/133] (898s left) gem_pwrite (basic-self)
[168.879839] Subtest basic-self: SKIP (0.000s)
[168.947152] [017/133] (898s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[169.047497] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[169.051902] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[169.156605] [018/133] (898s left) gem_ctx_param (get-priority-new-ctx)
[169.209670] Starting subtest: get-priority-new-ctx
[169.212043] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[169.330819] [019/133] (897s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier)
[169.428654] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier
[169.458054] Starting dynamic subtest: pipe-A-plane-0
[169.462593] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[169.471925] Starting dynamic subtest: pipe-A-plane-3
[169.476430] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[169.483678] Starting dynamic subtest: pipe-A-plane-5
[169.488049] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[170.573421] Starting dynamic subtest: pipe-B-plane-0
[170.577828] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[170.584926] Starting dynamic subtest: pipe-B-plane-3
[170.589559] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[170.596799] Starting dynamic subtest: pipe-B-plane-5
[170.601446] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[170.889195] Subtest pixel-format-4-tiled-lnl-ccs-modifier: SKIP (1.458s)
[171.758349] [020/133] (895s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[171.877826] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[171.881915] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[171.991581] [021/133] (895s left) syncobj_wait (multi-wait-for-submit-signaled)
[172.056823] Starting subtest: multi-wait-for-submit-signaled
[172.059104] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[172.182144] [022/133] (895s left) kms_addfb_basic (size-max)
[172.276119] Starting subtest: size-max
[172.278276] Subtest size-max: SUCCESS (0.000s)
[172.388014] [023/133] (895s left) gem_busy (extended)
[172.581758] Starting subtest: extended
[172.584315] Starting dynamic subtest: rcs0
[172.660271] Dynamic subtest rcs0: SUCCESS (0.078s)
[172.670741] Starting dynamic subtest: bcs0
[172.703700] Dynamic subtest bcs0: SUCCESS (0.042s)
[172.712774] Starting dynamic subtest: vcs0
[173.910732] Dynamic subtest vcs0: SUCCESS (1.204s)
[173.920952] Starting dynamic subtest: vcs1
[175.892980] Dynamic subtest vcs1: SUCCESS (1.980s)
[175.903638] Starting dynamic subtest: vecs0
[177.942327] Dynamic subtest vecs0: SUCCESS (2.047s)
[177.952575] Starting dynamic subtest: ccs0
[177.986995] Dynamic subtest ccs0: SUCCESS (0.044s)
[177.989557] Subtest extended: SUCCESS (5.406s)
[178.261934] [024/133] (889s left) perf_pmu (busy-accuracy-50)
[178.304643] Starting subtest: busy-accuracy-50
[178.306881] Starting dynamic subtest: rcs0
[179.847973] Dynamic subtest rcs0: SUCCESS (1.540s)
[179.860303] Starting dynamic subtest: bcs0
[181.391356] Dynamic subtest bcs0: SUCCESS (1.542s)
[181.401561] Starting dynamic subtest: vcs0
[182.927938] Dynamic subtest vcs0: SUCCESS (1.535s)
[182.938173] Starting dynamic subtest: vcs1
[184.470699] Dynamic subtest vcs1: SUCCESS (1.541s)
[184.481246] Starting dynamic subtest: vecs0
[186.010613] Dynamic subtest vecs0: SUCCESS (1.538s)
[186.020390] Starting dynamic subtest: ccs0
[187.555765] Dynamic subtest ccs0: SUCCESS (1.545s)
[187.558941] Subtest busy-accuracy-50: SUCCESS (9.249s)
[187.702879] [025/133] (879s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[187.810997] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[187.813240] Starting dynamic subtest: A-eDP1
[196.690602] Dynamic subtest A-eDP1: SUCCESS (8.879s)
[196.701830] Starting dynamic subtest: B-eDP1
[205.623946] Dynamic subtest B-eDP1: SUCCESS (8.931s)
[205.633474] Starting dynamic subtest: C-eDP1
[214.544666] Dynamic subtest C-eDP1: SUCCESS (8.919s)
[214.553788] Starting dynamic subtest: D-eDP1
[223.473764] Dynamic subtest D-eDP1: SUCCESS (8.927s)
[223.476747] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.665s)
[224.717535] [026/133] (842s left) gem_ctx_persistence (process)
[224.793307] Starting subtest: process
[225.052954] Subtest process: SUCCESS (0.259s)
[225.156893] [027/133] (842s left) sysfs_heartbeat_interval (precise)
[225.225271] Starting subtest: precise
[225.227228] Starting dynamic subtest: vecs0
[232.929733] Dynamic subtest vecs0: SUCCESS (7.705s)
[232.942264] Starting dynamic subtest: ccs0
[234.110759] Dynamic subtest ccs0: SUCCESS (1.180s)
[234.121560] Starting dynamic subtest: vcs0
[241.954788] Dynamic subtest vcs0: SUCCESS (7.840s)
[241.965717] Starting dynamic subtest: bcs0
[243.056950] Dynamic subtest bcs0: SUCCESS (1.103s)
[243.066422] Starting dynamic subtest: rcs0
[244.207030] Dynamic subtest rcs0: SUCCESS (1.151s)
[244.217315] Starting dynamic subtest: vcs1
[251.863332] Dynamic subtest vcs1: SUCCESS (7.653s)
[251.868127] Subtest precise: SUCCESS (26.639s)
[251.968197] [028/133] (815s left) prime_busy (hang-wait)
[252.040197] Starting subtest: hang-wait
[252.042069] Starting dynamic subtest: rcs0
[278.384702] Dynamic subtest rcs0: SUCCESS (26.342s)
[278.401759] Starting dynamic subtest: bcs0
[285.544954] Dynamic subtest bcs0: SUCCESS (7.160s)
[285.557591] Starting dynamic subtest: vcs0
[292.516120] Dynamic subtest vcs0: SUCCESS (6.968s)
[292.525093] Starting dynamic subtest: vcs1
[299.490780] Dynamic subtest vcs1: SUCCESS (6.973s)
[299.498411] Starting dynamic subtest: vecs0
[306.529237] Dynamic subtest vecs0: SUCCESS (7.035s)
[306.538254] Starting dynamic subtest: ccs0
[320.367816] Dynamic subtest ccs0: SUCCESS (13.836s)
[320.369884] Subtest hang-wait: SUCCESS (68.325s)
[320.537124] [029/133] (747s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[320.670467] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[320.674946] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[320.789727] [030/133] (746s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[320.885371] Starting subtest: primary-y-tiled-reflect-x-0
[320.955825] Subtest primary-y-tiled-reflect-x-0: SKIP (0.071s)
[321.105128] [031/133] (746s left) kms_rotation_crc (sprite-rotation-90)
[321.219349] Starting subtest: sprite-rotation-90
[321.223841] Subtest sprite-rotation-90: SKIP (0.001s)
[321.305276] [032/133] (746s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[321.705488] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[322.502425] [033/133] (745s left) gem_partial_pwrite_pread (write-display)
[322.578202] Subtest write-display: SKIP (0.000s)
[322.682127] [034/133] (745s left) kms_joiner (basic-big-joiner)
[322.792294] Starting subtest: basic-big-joiner
[322.796636] Subtest basic-big-joiner: SKIP (0.000s)
[322.894116] [035/133] (745s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[322.987050] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[322.989366] Starting dynamic subtest: pipe-A-eDP-1
[323.049294] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[323.056613] Starting dynamic subtest: pipe-B-eDP-1
[323.113587] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[323.123140] Starting dynamic subtest: pipe-C-eDP-1
[323.179948] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[323.188579] Starting dynamic subtest: pipe-D-eDP-1
[323.246521] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[323.250837] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.008s)
[325.319343] [036/133] (742s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[325.424582] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[325.428974] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[325.545535] [037/133] (742s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[325.649635] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[325.653656] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[325.787886] [038/133] (742s left) kms_hdr (invalid-metadata-sizes)
[325.891543] Starting subtest: invalid-metadata-sizes
[325.898230] Subtest invalid-metadata-sizes: SKIP (0.000s)
[325.973306] [039/133] (742s left) kms_psr (fbc-psr2-basic)
[326.075103] Starting subtest: fbc-psr2-basic
[326.076932] Starting dynamic subtest: eDP-1
[326.080970] Dynamic subtest eDP-1: SKIP (0.000s)
[326.085070] Subtest fbc-psr2-basic: SKIP (0.001s)
[326.155779] [040/133] (742s left) gem_exec_nop (basic-sequential)
[326.227658] Starting subtest: basic-sequential
[342.992556] Subtest basic-sequential: SUCCESS (16.770s)
[343.251535] [041/133] (725s left) kms_content_protection (dp-mst-lic-type-0)
[343.407532] Starting subtest: dp-mst-lic-type-0
[343.412134] Subtest dp-mst-lic-type-0: SKIP (0.000s)
[343.572191] [042/133] (724s left) kms_sequence (get-forked-busy)
[343.667356] Starting subtest: get-forked-busy
[343.669632] Starting dynamic subtest: pipe-A-eDP-1
[345.602914] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.934s)
[345.611675] Starting dynamic subtest: pipe-B-eDP-1
[348.181206] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.576s)
[348.190675] Starting dynamic subtest: pipe-C-eDP-1
[350.788813] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.609s)
[350.797442] Starting dynamic subtest: pipe-D-eDP-1
[353.415106] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.624s)
[353.417413] Subtest get-forked-busy: SUCCESS (9.748s)
[354.255008] [043/133] (714s left) gem_userptr_blits (map-fixed-invalidate)
[354.324420] Starting subtest: map-fixed-invalidate
[354.328591] Subtest map-fixed-invalidate: SKIP (0.000s)
[354.469140] [044/133] (713s left) gem_mmap_offset (clear-via-pagefault)
[354.520290] Starting subtest: clear-via-pagefault
[354.522568] Starting dynamic subtest: smem0
[387.207500] Dynamic subtest smem0: SUCCESS (32.683s)
[387.209578] Subtest clear-via-pagefault: SUCCESS (32.684s)
[387.357768] [045/133] (681s left) gem_mmap_gtt (basic-read)
[387.417523] Subtest basic-read: SKIP (0.000s)
[387.480125] [046/133] (681s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[387.583868] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[387.588180] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s)
[387.673808] [047/133] (680s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[387.746098] Starting subtest: rel-constants-invalid-rel-gen5
[387.748048] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[387.883980] [048/133] (680s left) gem_bad_reloc (negative-reloc-bltcopy)
[387.950890] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[388.036979] [049/133] (680s left) kms_big_fb (linear-32bpp-rotate-180)
[388.145024] Starting subtest: linear-32bpp-rotate-180
[389.734897] Subtest linear-32bpp-rotate-180: SUCCESS (1.590s)
[389.910488] [050/133] (678s left) gem_lmem_swapping (parallel-random-verify-ccs)
[389.945585] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[389.984399] [051/133] (678s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[390.087939] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[390.091845] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[390.220777] [052/133] (678s left) api_intel_allocator (default-alignment)
[390.289635] Starting subtest: default-alignment
[390.291517] Subtest default-alignment: SUCCESS (0.003s)
[390.446037] [053/133] (678s left) perf_pmu (busy-idle-check-all)
[390.478199] Starting subtest: busy-idle-check-all
[390.479791] Starting dynamic subtest: rcs0
[391.149933] Dynamic subtest rcs0: SUCCESS (0.672s)
[391.160309] Starting dynamic subtest: bcs0
[391.800690] Dynamic subtest bcs0: SUCCESS (0.649s)
[391.811354] Starting dynamic subtest: vcs0
[392.916292] Dynamic subtest vcs0: SUCCESS (1.112s)
[392.927451] Starting dynamic subtest: vcs1
[394.900089] Dynamic subtest vcs1: SUCCESS (1.982s)
[394.910289] Starting dynamic subtest: vecs0
[396.885491] Dynamic subtest vecs0: SUCCESS (1.984s)
[396.895899] Starting dynamic subtest: ccs0
[397.541929] Dynamic subtest ccs0: SUCCESS (0.656s)
[397.544573] Subtest busy-idle-check-all: SUCCESS (7.066s)
[397.686024] [054/133] (671s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[397.784263] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[397.788288] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[397.885110] [055/133] (671s left) api_intel_bb (intel-bb-blit-y)
[397.942489] Starting subtest: intel-bb-blit-y
[401.409667] Subtest intel-bb-blit-y: SUCCESS (3.468s)
[401.558754] [056/133] (667s left) kms_cursor_crc (cursor-onscreen-256x85)
[401.819215] Starting subtest: cursor-onscreen-256x85
[401.865918] Subtest cursor-onscreen-256x85: SKIP (0.046s)
[402.071404] [057/133] (666s left) gem_ctx_isolation (preservation-s3)
[402.141418] Starting subtest: preservation-S3
[402.143739] Starting dynamic subtest: rcs0
[418.972021] Dynamic subtest rcs0: SUCCESS (1.408s)
[418.981362] Starting dynamic subtest: bcs0
[434.963789] Dynamic subtest bcs0: SUCCESS (1.330s)
[434.973549] Starting dynamic subtest: vcs0
[450.969265] Dynamic subtest vcs0: SUCCESS (3.119s)
[450.981021] Starting dynamic subtest: vcs1
[468.969633] Dynamic subtest vcs1: SUCCESS (5.056s)
[468.979011] Starting dynamic subtest: vecs0
[486.959139] Dynamic subtest vecs0: SUCCESS (5.006s)
[486.974577] Starting dynamic subtest: ccs0
[505.212131] Dynamic subtest ccs0: SUCCESS (3.469s)
[505.216878] Subtest preservation-S3: SUCCESS (19.392s)
[505.422979] [058/133] (563s left) gem_exec_flush (basic-wb-rw-default)
[505.499635] Starting subtest: basic-wb-rw-default
[510.929577] Subtest basic-wb-rw-default: SUCCESS (5.471s)
[511.128835] [059/133] (557s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[511.177623] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[511.285080] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.108s)
[511.374688] [060/133] (557s left) gem_pxp (reject-modify-context-protection-off-1)
[511.510413] Starting subtest: reject-modify-context-protection-off-1
[511.513128] Subtest reject-modify-context-protection-off-1: SUCCESS (0.001s)
[511.642723] [061/133] (557s left) gem_softpin (reverse)
[511.695564] Starting subtest: reverse
[511.701769] Subtest reverse: SUCCESS (0.005s)
[511.856369] [062/133] (557s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[511.944734] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[511.949722] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[512.063647] [063/133] (557s left) perf (short-reads)
[512.182414] Starting subtest: short-reads
[512.197551] Subtest short-reads: SUCCESS (0.016s)
[512.239162] [064/133] (557s left) kms_lease (setcrtc-implicit-plane)
[512.325266] Starting subtest: setcrtc-implicit-plane
[512.327319] Starting dynamic subtest: pipe-A-eDP-1
[512.808015] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.482s)
[512.818863] Starting dynamic subtest: pipe-B-eDP-1
[513.924271] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.118s)
[513.940879] Starting dynamic subtest: pipe-C-eDP-1
[515.035848] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.118s)
[515.045281] Starting dynamic subtest: pipe-D-eDP-1
[516.159846] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.124s)
[516.162664] Subtest setcrtc-implicit-plane: SUCCESS (3.847s)
[517.015057] [065/133] (552s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[517.114186] Starting subtest: basic-max-pipe-crc-check
[517.118611] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[517.161060] [066/133] (552s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[517.269044] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[517.273886] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[517.396595] [067/133] (552s left) kms_psr (fbc-pr-cursor-plane-move)
[517.496698] Starting subtest: fbc-pr-cursor-plane-move
[517.501871] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[517.579084] [068/133] (551s left) gem_gpgpu_fill (basic)
[517.647709] Starting subtest: basic
[517.650270] Starting dynamic subtest: smem
[517.652876] Dynamic subtest smem: SUCCESS (0.007s)
[517.655740] Subtest basic: SUCCESS (0.008s)
[517.821276] [069/133] (551s left) gem_exec_reloc (basic-wc-noreloc)
[517.893864] Subtest basic-wc-noreloc: SKIP (0.000s)
[517.981196] [070/133] (551s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[522.990764] Starting subtest: pr-overlay-plane-update-continuous-sf
[522.996725] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.002s)
[523.861290] [071/133] (545s left) gem_caching (read-writes)
[523.932349] Subtest read-writes: SKIP (0.000s)
[524.018211] [072/133] (545s left) kms_async_flips (test-time-stamp-atomic)
[524.115683] Starting subtest: test-time-stamp-atomic
[524.487740] Starting dynamic subtest: pipe-A-eDP-1
[525.248648] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.760s)
[525.627660] Starting dynamic subtest: pipe-B-eDP-1
[526.380163] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.769s)
[526.774882] Starting dynamic subtest: pipe-C-eDP-1
[527.535826] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.770s)
[527.899000] Starting dynamic subtest: pipe-D-eDP-1
[528.669229] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.776s)
[528.672188] Subtest test-time-stamp-atomic: SUCCESS (4.559s)
[529.840960] [073/133] (539s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[529.946318] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[529.951349] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[530.048344] [074/133] (539s left) syncobj_timeline (multi-wait-all-available-signaled)
[530.095176] Starting subtest: multi-wait-all-available-signaled
[530.097732] Subtest multi-wait-all-available-signaled: SUCCESS (0.000s)
[530.200178] [075/133] (539s left) kms_color (legacy-gamma)
[530.294676] Starting subtest: legacy-gamma
[530.297430] Starting dynamic subtest: pipe-A-eDP-1
[531.050473] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.757s)
[531.060691] Starting dynamic subtest: pipe-B-eDP-1
[532.477750] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.426s)
[532.488080] Starting dynamic subtest: pipe-C-eDP-1
[533.820723] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.344s)
[533.837359] Starting dynamic subtest: pipe-D-eDP-1
[535.161752] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.339s)
[535.164711] Subtest legacy-gamma: SUCCESS (4.871s)
[535.981674] [076/133] (533s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[536.093848] Starting subtest: yf-tiled-32bpp-rotate-0
[536.099105] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[536.223649] [077/133] (533s left) gem_exec_schedule (u-independent)
[536.299492] Starting subtest: u-independent
[536.301545] Starting dynamic subtest: rcs0
[537.699170] Dynamic subtest rcs0: SUCCESS (1.408s)
[537.710861] Starting dynamic subtest: vcs0
[539.712622] Dynamic subtest vcs0: SUCCESS (2.009s)
[539.724885] Starting dynamic subtest: vcs1
[541.755499] Dynamic subtest vcs1: SUCCESS (2.039s)
[541.767553] Starting dynamic subtest: vecs0
[543.751072] Dynamic subtest vecs0: SUCCESS (1.992s)
[543.763839] Starting dynamic subtest: ccs0
[545.698761] Dynamic subtest ccs0: SUCCESS (1.944s)
[545.701931] Subtest u-independent: SUCCESS (9.404s)
[546.014951] [078/133] (523s left) gem_partial_pwrite_pread (reads)
[546.085035] Subtest reads: SKIP (0.000s)
[546.174053] [079/133] (523s left) kms_atomic_interruptible (legacy-dpms)
[546.277454] Starting subtest: legacy-dpms
[546.279841] Starting dynamic subtest: pipe-A-eDP-1
[553.705876] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.424s)
[553.708441] Subtest legacy-dpms: SUCCESS (7.426s)
[554.571455] [080/133] (515s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[554.685457] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[561.469853] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.788s)
[561.605393] [081/133] (508s left) syncobj_wait (multi-wait-submitted)
[561.670905] Starting subtest: multi-wait-submitted
[561.772637] Subtest multi-wait-submitted: SUCCESS (0.102s)
[561.864202] [082/133] (508s left) gem_exec_fence (syncobj-unused-fence)
[562.316632] Starting subtest: syncobj-unused-fence
[562.323301] Subtest syncobj-unused-fence: SUCCESS (0.007s)
[563.804418] [083/133] (506s left) gem_madvise (dontneed-before-mmap)
[563.842847] Starting subtest: dontneed-before-mmap
[563.869856] Subtest dontneed-before-mmap: SUCCESS (0.029s)
[563.994172] [084/133] (506s left) kms_dsc (dsc-fractional-bpp)
[564.091768] Starting subtest: dsc-fractional-bpp
[564.108895] Subtest dsc-fractional-bpp: SKIP (0.000s)
[564.175696] [085/133] (506s left) kms_vblank (ts-continuation-dpms-suspend)
[564.272841] Starting subtest: ts-continuation-dpms-suspend
[564.275553] Starting dynamic subtest: pipe-A-eDP-1
[581.468815] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.900s)
[581.484541] Starting dynamic subtest: pipe-D-eDP-1
[599.488440] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.504s)
[599.491215] Subtest ts-continuation-dpms-suspend: SUCCESS (4.409s)
[600.289794] [086/133] (469s left) gen7_exec_parse (oacontrol-tracking)
[600.350627] Subtest oacontrol-tracking: SKIP (0.000s)
[600.415963] [087/133] (469s left) gem_userptr_blits (sync-overlap)
[600.484461] Starting subtest: sync-overlap
[600.486603] Subtest sync-overlap: SUCCESS (0.000s)
[600.637873] [088/133] (469s left) i915_suspend (debugfs-reader)
[600.687630] Starting subtest: debugfs-reader
[618.941712] Subtest debugfs-reader: SUCCESS (3.167s)
[619.081489] [089/133] (451s left) gem_render_copy (y-tiled-ccs-to-linear)
[619.143739] Starting subtest: y-tiled-ccs-to-linear
[619.148496] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[619.336523] [090/133] (451s left) gem_exec_store (pages)
[619.400875] Starting subtest: pages
[619.403473] Starting dynamic subtest: rcs0
[619.507751] Dynamic subtest rcs0: SUCCESS (0.111s)
[619.518874] Starting dynamic subtest: bcs0
[619.575961] Dynamic subtest bcs0: SUCCESS (0.067s)
[619.586333] Starting dynamic subtest: vcs0
[619.641910] Dynamic subtest vcs0: SUCCESS (0.066s)
[619.651835] Starting dynamic subtest: vcs1
[619.715912] Dynamic subtest vcs1: SUCCESS (0.073s)
[619.725961] Starting dynamic subtest: vecs0
[619.787922] Dynamic subtest vecs0: SUCCESS (0.072s)
[619.797496] Starting dynamic subtest: ccs0
[619.860757] Dynamic subtest ccs0: SUCCESS (0.073s)
[619.863740] Subtest pages: SUCCESS (0.468s)
[620.056809] [091/133] (450s left) kms_dp_linktrain_fallback (dp-fallback)
[620.160504] Starting subtest: dp-fallback
[620.167862] Subtest dp-fallback: SKIP (0.000s)
[620.243109] [092/133] (450s left) syncobj_timeline (multi-wait-all-signaled)
[620.295124] Starting subtest: multi-wait-all-signaled
[620.297824] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[620.413148] [093/133] (450s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[620.464343] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[620.568390] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.105s)
[620.658825] [094/133] (450s left) kms_flip (2x-plain-flip)
[620.744000] Starting subtest: 2x-plain-flip
[620.752334] Subtest 2x-plain-flip: SKIP (0.011s)
[620.846530] [095/133] (449s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[621.244993] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[622.052426] [096/133] (448s left) gem_mmap (basic)
[622.112888] Subtest basic: SKIP (0.000s)
[622.181372] [097/133] (448s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[622.300449] Starting subtest: cursorA-vs-flipA-toggle
[633.399649] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.137s)
[634.262249] [098/133] (436s left) gem_exec_balancer (nop)
[634.345837] Starting subtest: nop
[681.013334] Subtest nop: SUCCESS (46.675s)
[681.326050] [099/133] (389s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[681.435818] Starting subtest: x-tiled-64bpp-rotate-0
[683.026997] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.591s)
[683.219346] [100/133] (387s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[683.327045] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[687.367312] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (4.044s)
[688.539307] [101/133] (382s left) kms_setmode (clone-exclusive-crtc)
[688.603955] Starting subtest: clone-exclusive-crtc
[688.612055] Subtest clone-exclusive-crtc: SKIP (0.000s)
[688.706390] [102/133] (382s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[688.807999] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[698.197634] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.394s)
[698.336394] [103/133] (372s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[698.401876] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[698.407753] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[698.597383] [104/133] (372s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[698.684820] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[698.687492] Starting dynamic subtest: pipe-A-eDP-1
[699.539860] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.848s)
[699.549466] Starting dynamic subtest: pipe-B-eDP-1
[701.135472] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.594s)
[701.147060] Starting dynamic subtest: pipe-C-eDP-1
[702.632638] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.496s)
[702.642671] Starting dynamic subtest: pipe-D-eDP-1
[704.133838] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.501s)
[704.136571] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.444s)
[705.368374] [105/133] (365s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[705.469042] Starting subtest: 2x-flip-vs-modeset-vs-hang
[705.480787] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.010s)
[705.571487] [106/133] (365s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[705.778063] Starting subtest: cursor-rapid-movement-128x128
[705.783772] Starting dynamic subtest: pipe-A-eDP-1
[706.324112] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.543s)
[706.359043] Starting dynamic subtest: pipe-D-eDP-1
[707.578613] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.232s)
[707.581059] Subtest cursor-rapid-movement-128x128: SUCCESS (1.802s)
[708.429861] [107/133] (362s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[708.535920] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[708.541500] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[708.666093] [108/133] (362s left) gem_mmap_wc (read-write-distinct)
[708.733727] Subtest read-write-distinct: SKIP (0.000s)
[708.799943] [109/133] (362s left) kms_plane_cursor (primary)
[708.894504] Starting subtest: primary
[708.899040] Starting dynamic subtest: pipe-A-eDP-1-size-64
[711.436817] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.543s)
[711.459082] Starting dynamic subtest: pipe-A-eDP-1-size-128
[713.991953] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.538s)
[714.015911] Starting dynamic subtest: pipe-A-eDP-1-size-256
[716.560835] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.549s)
[716.873980] Starting dynamic subtest: pipe-B-eDP-1-size-64
[720.109623] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.248s)
[720.133378] Starting dynamic subtest: pipe-B-eDP-1-size-128
[722.666875] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.538s)
[722.690936] Starting dynamic subtest: pipe-B-eDP-1-size-256
[725.279854] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.593s)
[725.596195] Starting dynamic subtest: pipe-C-eDP-1-size-64
[728.480083] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.895s)
[728.506765] Starting dynamic subtest: pipe-C-eDP-1-size-128
[730.703048] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.203s)
[730.730059] Starting dynamic subtest: pipe-C-eDP-1-size-256
[732.926330] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.202s)
[733.251007] Starting dynamic subtest: pipe-D-eDP-1-size-64
[736.138941] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.898s)
[736.166597] Starting dynamic subtest: pipe-D-eDP-1-size-128
[738.350441] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.192s)
[738.377253] Starting dynamic subtest: pipe-D-eDP-1-size-256
[740.595424] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.224s)
[740.902347] Subtest primary: SUCCESS (32.003s)
[741.773514] [110/133] (329s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[741.882085] Starting subtest: fbc-indfb-scaledprimary
[744.868973] Subtest fbc-indfb-scaledprimary: SUCCESS (2.990s)
[746.075158] [111/133] (325s left) kms_psr (psr2-sprite-mmap-cpu)
[746.178481] Starting subtest: psr2-sprite-mmap-cpu
[746.180702] Starting dynamic subtest: eDP-1
[747.949010] Dynamic subtest eDP-1: SUCCESS (1.769s)
[747.951808] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.770s)
[748.827829] [112/133] (322s left) i915_drm_fdinfo (memory-info-resident)
[748.871210] Starting subtest: memory-info-resident
[748.873934] Starting dynamic subtest: smem0
[751.415657] Dynamic subtest smem0: SUCCESS (2.546s)
[751.418392] Subtest memory-info-resident: SUCCESS (2.547s)
[751.504367] [113/133] (319s left) gem_exec_schedule (preempt-engines)
[751.587663] Starting subtest: preempt-engines
[751.589680] Starting dynamic subtest: rcs0
[753.942820] Dynamic subtest rcs0: SUCCESS (2.360s)
[753.954368] Starting dynamic subtest: bcs0
[756.277589] Dynamic subtest bcs0: SUCCESS (2.333s)
[756.289903] Starting dynamic subtest: vcs0
[758.712924] Dynamic subtest vcs0: SUCCESS (2.434s)
[758.722794] Starting dynamic subtest: vcs1
[761.025453] Dynamic subtest vcs1: SUCCESS (2.311s)
[761.035509] Starting dynamic subtest: vecs0
[763.338689] Dynamic subtest vecs0: SUCCESS (2.312s)
[763.356757] Starting dynamic subtest: ccs0
[765.631649] Dynamic subtest ccs0: SUCCESS (2.291s)
[765.634308] Subtest preempt-engines: SUCCESS (14.051s)
[765.940027] [114/133] (305s left) gen3_render_tiledx_blits
[766.073367] [115/133] (305s left) gem_fenced_exec_thrash (no-spare-fences)
[766.145330] Subtest no-spare-fences: SKIP (0.000s)
[766.228871] [116/133] (305s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[766.330701] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[766.333397] Starting dynamic subtest: pipe-A-eDP-1
[766.478837] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.135s)
[766.490742] Starting dynamic subtest: pipe-B-eDP-1
[766.514546] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[766.524060] Starting dynamic subtest: pipe-C-eDP-1
[766.546966] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[766.556189] Starting dynamic subtest: pipe-D-eDP-1
[766.579612] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[766.581938] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.145s)
[768.791326] [117/133] (302s left) kms_psr (psr-sprite-plane-onoff)
[768.884219] Starting subtest: psr-sprite-plane-onoff
[768.886751] Starting dynamic subtest: eDP-1
[770.633299] Dynamic subtest eDP-1: SUCCESS (1.751s)
[770.635946] Subtest psr-sprite-plane-onoff: SUCCESS (1.752s)
[771.464696] [118/133] (300s left) kms_psr (fbc-psr-primary-mmap-gtt)
[771.557842] Starting subtest: fbc-psr-primary-mmap-gtt
[771.560625] Starting dynamic subtest: eDP-1
[771.565703] Dynamic subtest eDP-1: SKIP (0.000s)
[771.570900] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[771.651429] [119/133] (300s left) kms_properties (crtc-properties-atomic)
[771.750989] Starting subtest: crtc-properties-atomic
[771.753802] Starting dynamic subtest: pipe-A-eDP-1
[772.213848] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.465s)
[772.224317] Starting dynamic subtest: pipe-B-eDP-1
[773.413539] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.199s)
[773.423618] Starting dynamic subtest: pipe-C-eDP-1
[774.548387] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.134s)
[774.559368] Starting dynamic subtest: pipe-D-eDP-1
[775.690407] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.139s)
[775.692878] Subtest crtc-properties-atomic: SUCCESS (3.942s)
[776.504192] [120/133] (295s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[776.614312] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[776.619283] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[776.721498] [121/133] (295s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[776.813569] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[776.822364] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[776.909108] [122/133] (294s left) kms_pm_backlight (brightness-with-dpms)
[777.011651] Starting subtest: brightness-with-dpms
[777.064753] Starting dynamic subtest: eDP-1
[779.494038] Dynamic subtest eDP-1: SUCCESS (2.433s)
[779.496762] Subtest brightness-with-dpms: SUCCESS (2.485s)
[780.363456] [123/133] (291s left) i915_drm_fdinfo (virtual-busy-idle)
[780.410594] Starting subtest: virtual-busy-idle
[780.415837] Subtest virtual-busy-idle: SKIP (0.000s)
[780.488240] [124/133] (291s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[780.589794] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[780.594920] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[780.713461] [125/133] (291s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[780.818994] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[788.338285] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.524s)
[788.488588] [126/133] (283s left) perf_pmu (all-busy-check-all)
[788.532561] Starting subtest: all-busy-check-all
[789.661345] Subtest all-busy-check-all: SUCCESS (1.127s)
[789.802148] [127/133] (282s left) gem_ctx_sseu (invalid-args)
[789.862859] Subtest invalid-args: SKIP (0.000s)
[789.956442] [128/133] (282s left) kms_psr (pr-primary-page-flip)
[790.045933] Starting subtest: pr-primary-page-flip
[790.051566] Subtest pr-primary-page-flip: SKIP (0.000s)
[790.131579] [129/133] (282s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[790.227818] Starting subtest: random-ccs-data-yf-tiled-ccs
[790.230523] Starting dynamic subtest: pipe-A-eDP-1
[790.259430] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[790.270471] Starting dynamic subtest: pipe-B-eDP-1
[790.298944] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[790.308461] Starting dynamic subtest: pipe-C-eDP-1
[790.336462] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[790.345681] Starting dynamic subtest: pipe-D-eDP-1
[790.373514] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[790.379352] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.004s)
[792.475484] [130/133] (279s left) gem_close_race (multigpu-basic-threads)
[792.549064] Starting subtest: multigpu-basic-threads
[792.554730] Subtest multigpu-basic-threads: SKIP (0.000s)
[792.784194] [131/133] (279s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[792.905102] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[793.542679] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.638s)
[793.749204] [132/133] (278s left) kms_cursor_edge_walk (128x128-top-bottom)
[793.846205] Starting subtest: 128x128-top-bottom
[793.848804] Starting dynamic subtest: pipe-A-eDP-1
[797.315353] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.469s)
[797.325961] Starting dynamic subtest: pipe-D-eDP-1
[800.449927] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.134s)
[800.452363] Subtest 128x128-top-bottom: SUCCESS (6.606s)
[801.293201] [133/133] (271s left) gem_exec_balancer (sequential)
[801.367802] Starting subtest: sequential
[804.418953] Subtest sequential: SUCCESS (3.051s)
[804.780326] Closing watchdogs
results: parsing output: 0/ for test: gem_vm_create
results: parsing output: 1/ for test: gem_exec_reloc
results: parsing output: 2/ for test: kms_plane_scaling
results: parsing output: 3/ for test: kms_pm_rpm
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: kms_async_flips
results: parsing output: 6/ for test: kms_plane_scaling
results: parsing output: 7/ for test: kms_psr2_sf
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: drm_buddy
results: parsing output: 12/ for test: kms_ccs
results: parsing output: 13/ for test: gem_exec_fence
results: parsing output: 14/ for test: i915_pm_rpm
results: parsing output: 15/ for test: gem_pwrite
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: gem_ctx_param
results: parsing output: 18/ for test: kms_plane
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: syncobj_wait
results: parsing output: 21/ for test: kms_addfb_basic
results: parsing output: 22/ for test: gem_busy
results: parsing output: 23/ for test: perf_pmu
results: parsing output: 24/ for test: kms_flip
results: parsing output: 25/ for test: gem_ctx_persistence
results: parsing output: 26/ for test: sysfs_heartbeat_interval
results: parsing output: 27/ for test: prime_busy
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_rotation_crc
results: parsing output: 30/ for test: kms_rotation_crc
results: parsing output: 31/ for test: kms_chamelium_edid
results: parsing output: 32/ for test: gem_partial_pwrite_pread
results: parsing output: 33/ for test: kms_joiner
results: parsing output: 34/ for test: kms_ccs
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_hdr
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: gem_exec_nop
results: parsing output: 40/ for test: kms_content_protection
results: parsing output: 41/ for test: kms_sequence
results: parsing output: 42/ for test: gem_userptr_blits
results: parsing output: 43/ for test: gem_mmap_offset
results: parsing output: 44/ for test: gem_mmap_gtt
results: parsing output: 45/ for test: kms_flip_scaled_crc
results: parsing output: 46/ for test: gem_exec_params
results: parsing output: 47/ for test: gem_bad_reloc
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: gem_lmem_swapping
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: api_intel_allocator
results: parsing output: 52/ for test: perf_pmu
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: api_intel_bb
results: parsing output: 55/ for test: kms_cursor_crc
results: parsing output: 56/ for test: gem_ctx_isolation
results: parsing output: 57/ for test: gem_exec_flush
results: parsing output: 58/ for test: syncobj_timeline
results: parsing output: 59/ for test: gem_pxp
results: parsing output: 60/ for test: gem_softpin
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: perf
results: parsing output: 63/ for test: kms_lease
results: parsing output: 64/ for test: kms_multipipe_modeset
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: gem_gpgpu_fill
results: parsing output: 68/ for test: gem_exec_reloc
results: parsing output: 69/ for test: kms_psr2_sf
results: parsing output: 70/ for test: gem_caching
results: parsing output: 71/ for test: kms_async_flips
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: syncobj_timeline
results: parsing output: 74/ for test: kms_color
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: gem_exec_schedule
results: parsing output: 77/ for test: gem_partial_pwrite_pread
results: parsing output: 78/ for test: kms_atomic_interruptible
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: syncobj_wait
results: parsing output: 81/ for test: gem_exec_fence
results: parsing output: 82/ for test: gem_madvise
results: parsing output: 83/ for test: kms_dsc
results: parsing output: 84/ for test: kms_vblank
results: parsing output: 85/ for test: gen7_exec_parse
results: parsing output: 86/ for test: gem_userptr_blits
results: parsing output: 87/ for test: i915_suspend
results: parsing output: 88/ for test: gem_render_copy
results: parsing output: 89/ for test: gem_exec_store
results: parsing output: 90/ for test: kms_dp_linktrain_fallback
results: parsing output: 91/ for test: syncobj_timeline
results: parsing output: 92/ for test: syncobj_timeline
results: parsing output: 93/ for test: kms_flip
results: parsing output: 94/ for test: kms_chamelium_hpd
results: parsing output: 95/ for test: gem_mmap
results: parsing output: 96/ for test: kms_cursor_legacy
results: parsing output: 97/ for test: gem_exec_balancer
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_setmode
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_render_copy
results: parsing output: 103/ for test: kms_ccs
results: parsing output: 104/ for test: kms_flip
results: parsing output: 105/ for test: kms_cursor_crc
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_mmap_wc
results: parsing output: 108/ for test: kms_plane_cursor
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_psr
results: parsing output: 111/ for test: i915_drm_fdinfo
results: parsing output: 112/ for test: gem_exec_schedule
results: parsing output: 113/ for test: gen3_render_tiledx_blits
results: parsing output: 114/ for test: gem_fenced_exec_thrash
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: kms_properties
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_flip_scaled_crc
results: parsing output: 121/ for test: kms_pm_backlight
results: parsing output: 122/ for test: i915_drm_fdinfo
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: perf_pmu
results: parsing output: 126/ for test: gem_ctx_sseu
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: kms_ccs
results: parsing output: 129/ for test: gem_close_race
results: parsing output: 130/ for test: kms_big_fb
results: parsing output: 131/ for test: kms_cursor_edge_walk
results: parsing output: 132/ for test: gem_exec_balancer
Done.