[56.539860] Initializing watchdogs
[56.539907]   /dev/watchdog0
[56.554684] [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.559127] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.561617] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.565292] [001/133] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[56.692442] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[56.696716] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[56.776315] [002/133] (960s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[56.870581] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[56.872752] Starting dynamic subtest: pipe-A-eDP-1
[56.894546] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[56.902890] Starting dynamic subtest: pipe-B-eDP-1
[56.925059] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[56.933591] Starting dynamic subtest: pipe-C-eDP-1
[56.954832] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[56.963275] Starting dynamic subtest: pipe-D-eDP-1
[56.984981] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[56.989295] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.003s)
[59.118986] [003/133] (958s left) syncobj_timeline (wait-all-interrupted)
[59.174450] Starting subtest: wait-all-interrupted
[59.276092] Subtest wait-all-interrupted: SUCCESS (0.103s)
[59.346788] [004/133] (957s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[59.449940] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[62.986564] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.540s)
[64.202567] [005/133] (953s left) kms_pm_lpsp (kms-lpsp)
[65.304297] Starting subtest: kms-lpsp
[65.306223] Starting dynamic subtest: pipe-A-eDP-1
[65.470843] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.168s)
[65.767864] Subtest kms-lpsp: SUCCESS (0.466s)
[66.613750] [006/133] (950s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[66.712994] Starting subtest: yf-tiled-8bpp-rotate-180
[66.716888] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[66.875388] [007/133] (950s left) kms_cursor_crc (cursor-random-512x170)
[67.405052] Starting subtest: cursor-random-512x170
[67.409749] Subtest cursor-random-512x170: SKIP (0.001s)
[67.747595] [008/133] (949s left) kms_psr (fbc-pr-suspend)
[67.873237] Starting subtest: fbc-pr-suspend
[67.878037] Subtest fbc-pr-suspend: SKIP (0.000s)
[68.024066] [009/133] (949s left) kms_chamelium_edid (dp-edid-resolution-list)
[68.418999] Subtest dp-edid-resolution-list: SKIP (0.000s)
[69.240355] [010/133] (948s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[69.340171] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[69.342537] Starting dynamic subtest: pipe-A-default-mode
[70.532454] Dynamic subtest pipe-A-default-mode: SKIP (1.189s)
[70.536630] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.190s)
[70.676814] [011/133] (946s left) kms_plane_alpha_blend (alpha-transparent-fb)
[70.779769] Starting subtest: alpha-transparent-fb
[71.081352] Starting dynamic subtest: pipe-A-eDP-1
[71.743437] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.659s)
[71.752406] Starting dynamic subtest: pipe-D-eDP-1
[73.098668] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.356s)
[73.101078] Subtest alpha-transparent-fb: SUCCESS (2.321s)
[73.974486] [012/133] (943s left) syncobj_eventfd (invalid-bad-flags)
[74.036600] Starting subtest: invalid-bad-flags
[74.038558] Subtest invalid-bad-flags: SUCCESS (0.000s)
[74.126047] [013/133] (943s left) gem_ctx_sseu (invalid-args)
[74.186105] Subtest invalid-args: SKIP (0.000s)
[74.241958] [014/133] (943s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[74.344647] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[74.347055] Starting dynamic subtest: pipe-A-eDP-1
[74.369786] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[74.379955] Starting dynamic subtest: pipe-B-eDP-1
[74.401174] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[74.408692] Starting dynamic subtest: pipe-C-eDP-1
[74.430938] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[74.439435] Starting dynamic subtest: pipe-D-eDP-1
[74.461212] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[74.465308] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[76.567193] [015/133] (941s left) kms_cursor_edge_walk (128x128-left-edge)
[76.666243] Starting subtest: 128x128-left-edge
[76.668538] Starting dynamic subtest: pipe-A-eDP-1
[80.134841] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.469s)
[80.142567] Starting dynamic subtest: pipe-D-eDP-1
[83.261513] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.125s)
[83.263863] Subtest 128x128-left-edge: SUCCESS (6.596s)
[84.068619] [016/133] (933s left) fbdev (eof)
[84.109328] Starting subtest: eof
[84.111637] Subtest eof: SUCCESS (0.000s)
[84.181110] [017/133] (933s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[84.271056] Starting subtest: fbc-pr-cursor-mmap-gtt
[84.275612] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[84.340782] [018/133] (933s left) gem_flink_basic (double-flink)
[84.408022] Starting subtest: double-flink
[84.410510] Subtest double-flink: SUCCESS (0.000s)
[84.509893] [019/133] (933s left) kms_psr (psr-primary-mmap-cpu)
[84.609797] Starting subtest: psr-primary-mmap-cpu
[84.612143] Starting dynamic subtest: eDP-1
[86.363849] Dynamic subtest eDP-1: SUCCESS (1.753s)
[86.366312] Subtest psr-primary-mmap-cpu: SUCCESS (1.754s)
[87.225803] [020/133] (930s left) syncobj_timeline (multi-wait-all-available-signaled)
[87.285999] Starting subtest: multi-wait-all-available-signaled
[87.288757] Subtest multi-wait-all-available-signaled: SUCCESS (0.000s)
[87.385538] [021/133] (930s left) gem_exec_reloc (basic-scanout)
[87.448068] Subtest basic-scanout: SKIP (0.000s)
[87.537353] [022/133] (930s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[87.590259] Starting subtest: saturated-hostile-nopreempt
[87.592528] Starting dynamic subtest: rcs0
[87.648241] Dynamic subtest rcs0: SKIP (0.055s)
[87.658419] Starting dynamic subtest: bcs0
[87.666046] Dynamic subtest bcs0: SKIP (0.017s)
[87.673289] Starting dynamic subtest: vcs0
[87.687602] Dynamic subtest vcs0: SKIP (0.022s)
[87.694476] Starting dynamic subtest: vcs1
[87.701303] Dynamic subtest vcs1: SKIP (0.014s)
[87.708332] Starting dynamic subtest: vecs0
[87.714743] Dynamic subtest vecs0: SKIP (0.013s)
[87.721429] Starting dynamic subtest: ccs0
[87.727715] Dynamic subtest ccs0: SKIP (0.013s)
[87.732020] Subtest saturated-hostile-nopreempt: SKIP (0.136s)
[87.811232] [023/133] (930s left) sw_sync (alloc_fence_invalid_timeline)
[87.845514] Starting subtest: alloc_fence_invalid_timeline
[87.847957] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[87.897826] [024/133] (930s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[88.000211] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[88.004129] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[88.106789] [025/133] (929s left) kms_feature_discovery (display-2x)
[88.203202] Starting subtest: display-2x
[88.206927] Subtest display-2x: SKIP (0.000s)
[88.272532] [026/133] (929s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[88.361478] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[88.363316] Starting dynamic subtest: pipe-A-eDP-1
[88.381589] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[88.389419] Starting dynamic subtest: pipe-B-eDP-1
[88.406669] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[88.413452] Starting dynamic subtest: pipe-C-eDP-1
[88.430639] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[88.437763] Starting dynamic subtest: pipe-D-eDP-1
[88.455055] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[88.458303] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.005s)
[90.587850] [027/133] (927s left) kms_invalid_mode (zero-clock)
[90.683693] Starting subtest: zero-clock
[90.686093] Starting dynamic subtest: pipe-A-eDP-1
[90.971527] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[90.979617] Starting dynamic subtest: pipe-B-eDP-1
[90.981916] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[90.989135] Starting dynamic subtest: pipe-C-eDP-1
[90.991505] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[90.999670] Starting dynamic subtest: pipe-D-eDP-1
[91.002019] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[91.004258] Subtest zero-clock: SUCCESS (0.293s)
[91.807516] [028/133] (926s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[91.908310] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[91.912255] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[92.007179] [029/133] (926s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[92.064768] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[92.069321] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[92.254611] [030/133] (925s left) i915_pm_rps (thresholds-idle-park)
[92.308960] Starting subtest: thresholds-idle-park
[92.313168] Subtest thresholds-idle-park: SKIP (0.001s)
[92.407472] [031/133] (925s left) gen7_exec_parse (cmd-crossing-page)
[92.483250] Subtest cmd-crossing-page: SKIP (0.000s)
[92.552155] [032/133] (925s left) syncobj_wait (single-wait-for-submit-submitted)
[92.613593] Starting subtest: single-wait-for-submit-submitted
[92.722980] Subtest single-wait-for-submit-submitted: SUCCESS (0.107s)
[92.807254] [033/133] (925s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[92.902782] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[97.913069] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (5.014s)
[99.103505] [034/133] (919s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[99.204685] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[106.829884] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.625s)
[106.950949] [035/133] (911s left) gem_ppgtt (blt-vs-render-ctx0)
[107.011042] Starting subtest: blt-vs-render-ctx0
[139.853270] Subtest blt-vs-render-ctx0: SUCCESS (32.839s)
[139.966473] [036/133] (878s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[140.113780] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[144.712869] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.602s)
[145.905339] [037/133] (872s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[145.994238] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[145.998899] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[146.098112] [038/133] (872s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[146.193674] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[153.574916] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.384s)
[153.708759] [039/133] (864s left) kms_frontbuffer_tracking (psr-suspend)
[153.807809] Starting subtest: psr-suspend
[192.393795] Subtest psr-suspend: SUCCESS (8.143s)
[192.530243] [040/133] (826s left) api_intel_bb (misplaced-blitter)
[192.591353] Starting subtest: misplaced-blitter
[192.598572] Subtest misplaced-blitter: SUCCESS (0.008s)
[192.720809] [041/133] (825s left) kms_setmode (basic-clone-single-crtc)
[192.786413] Starting subtest: basic-clone-single-crtc
[192.792854] Subtest basic-clone-single-crtc: SKIP (0.000s)
[192.886373] [042/133] (825s left) kms_pm_rpm (modeset-lpsp-stress)
[194.559502] Starting subtest: modeset-lpsp-stress
[210.534773] Subtest modeset-lpsp-stress: SUCCESS (15.978s)
[210.623795] [043/133] (808s left) gem_exec_whisper (basic-fds-forked-all)
[210.693261] Starting subtest: basic-fds-forked-all
[230.898666] Subtest basic-fds-forked-all: SUCCESS (20.198s)
[231.078150] [044/133] (787s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[231.180063] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[231.184678] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[231.277817] [045/133] (787s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[231.368527] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[231.372971] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[231.473051] [046/133] (787s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[231.563384] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[239.085399] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.523s)
[239.227926] [047/133] (779s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[239.316746] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[239.319224] Starting dynamic subtest: pipe-A-eDP-1
[239.378142] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[239.389774] Starting dynamic subtest: pipe-B-eDP-1
[239.446787] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[239.457596] Starting dynamic subtest: pipe-C-eDP-1
[239.515415] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[239.525904] Starting dynamic subtest: pipe-D-eDP-1
[239.583046] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[239.587466] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.009s)
[241.777142] [048/133] (777s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping)
[241.871860] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping
[241.875934] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[241.944855] [049/133] (776s left) kms_content_protection (atomic-dpms-hdcp14)
[242.086075] Starting subtest: atomic-dpms-hdcp14
[242.090636] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[242.208476] [050/133] (776s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[242.299617] Starting subtest: plane-ctm3x4-lut1d
[242.457028] Starting dynamic subtest: pipe-A-plane-0
[242.823722] Dynamic subtest pipe-A-plane-0: FAIL (0.214s)
[242.834312] Starting dynamic subtest: pipe-A-plane-1
[243.024018] Dynamic subtest pipe-A-plane-1: FAIL (0.181s)
[243.032811] Starting dynamic subtest: pipe-A-plane-2
[243.251540] Dynamic subtest pipe-A-plane-2: FAIL (0.188s)
[244.292245] Starting dynamic subtest: pipe-B-plane-0
[244.740475] Dynamic subtest pipe-B-plane-0: FAIL (0.174s)
[244.751618] Starting dynamic subtest: pipe-B-plane-1
[245.061316] Dynamic subtest pipe-B-plane-1: FAIL (0.177s)
[245.071183] Starting dynamic subtest: pipe-B-plane-2
[245.370727] Dynamic subtest pipe-B-plane-2: FAIL (0.189s)
[246.010098] Starting dynamic subtest: pipe-C-plane-0
[246.531392] Dynamic subtest pipe-C-plane-0: FAIL (0.151s)
[246.541552] Starting dynamic subtest: pipe-C-plane-1
[246.930173] Dynamic subtest pipe-C-plane-1: FAIL (0.615s)
[246.939354] Starting dynamic subtest: pipe-C-plane-2
[247.298840] Dynamic subtest pipe-C-plane-2: FAIL (0.175s)
[248.146297] Starting dynamic subtest: pipe-D-plane-0
[248.736503] Dynamic subtest pipe-D-plane-0: FAIL (0.140s)
[248.747333] Starting dynamic subtest: pipe-D-plane-1
[249.220427] Dynamic subtest pipe-D-plane-1: FAIL (0.624s)
[249.230782] Starting dynamic subtest: pipe-D-plane-2
[249.664969] Dynamic subtest pipe-D-plane-2: FAIL (0.574s)
[249.780662] Subtest plane-ctm3x4-lut1d: FAIL (7.482s)
[250.597598] [051/133] (768s left) gem_lmem_swapping (heavy-random)
[250.654964] Subtest heavy-random: SKIP (0.000s)
[250.701589] [052/133] (768s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[250.811952] Starting subtest: pr-overlay-plane-update-continuous-sf
[250.816473] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[250.878276] [053/133] (768s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[251.000231] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[251.005235] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.001s)
[251.162081] [054/133] (767s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[251.255416] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[251.257669] Starting dynamic subtest: pipe-A
[251.591275] Dynamic subtest pipe-A: SUCCESS (0.338s)
[251.600782] Starting dynamic subtest: pipe-B
[252.986869] Dynamic subtest pipe-B: SUCCESS (1.394s)
[252.996344] Starting dynamic subtest: pipe-C
[254.423746] Dynamic subtest pipe-C: SUCCESS (1.435s)
[254.433647] Starting dynamic subtest: pipe-D
[255.849922] Dynamic subtest pipe-D: SUCCESS (1.425s)
[255.852280] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.596s)
[257.011080] [055/133] (762s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[257.128590] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[257.132839] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[257.218047] [056/133] (761s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[257.307025] Starting subtest: fbc-psr2-sprite-mmap-gtt
[257.309343] Starting dynamic subtest: eDP-1
[257.313763] Dynamic subtest eDP-1: SKIP (0.000s)
[257.318192] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[257.378381] [057/133] (761s left) gem_pxp (protected-raw-src-copy-not-readible)
[257.496150] Starting subtest: protected-raw-src-copy-not-readible
[257.555354] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.060s)
[257.671115] [058/133] (761s left) gem_softpin (allocator-evict)
[257.732277] Starting subtest: allocator-evict
[257.734716] Starting dynamic subtest: rcs0
[280.745462] Dynamic subtest rcs0: SUCCESS (23.015s)
[280.755928] Starting dynamic subtest: bcs0
[304.664182] Dynamic subtest bcs0: SUCCESS (23.916s)
[304.674110] Starting dynamic subtest: vcs0
[328.378210] Dynamic subtest vcs0: SUCCESS (23.712s)
[328.389406] Starting dynamic subtest: vcs1
[352.261721] Dynamic subtest vcs1: SUCCESS (23.882s)
[352.271499] Starting dynamic subtest: vecs0
[376.004736] Dynamic subtest vecs0: SUCCESS (23.741s)
[376.014709] Starting dynamic subtest: ccs0
[400.123677] Dynamic subtest ccs0: SUCCESS (24.117s)
[400.126579] Subtest allocator-evict: SUCCESS (142.389s)
[400.207202] [059/133] (619s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[400.356702] Starting subtest: plane-scaler-unity-scaling-with-rotation
[400.358916] Starting dynamic subtest: pipe-A
[400.582720] Dynamic subtest pipe-A: SUCCESS (0.228s)
[400.594893] Starting dynamic subtest: pipe-B
[401.883045] Dynamic subtest pipe-B: SUCCESS (1.299s)
[401.892800] Starting dynamic subtest: pipe-C
[403.220864] Dynamic subtest pipe-C: SUCCESS (1.337s)
[403.231119] Starting dynamic subtest: pipe-D
[404.564784] Dynamic subtest pipe-D: SUCCESS (1.343s)
[404.567117] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.211s)
[405.743778] [060/133] (613s left) gem_ctx_exec (basic)
[405.798870] Starting subtest: basic
[405.803451] Subtest basic: SUCCESS (0.006s)
[405.918097] [061/133] (613s left) gem_exec_schedule (semaphore-noskip)
[406.005303] Starting subtest: semaphore-noskip
[406.411134] Subtest semaphore-noskip: SUCCESS (0.411s)
[406.723404] [062/133] (612s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[406.830714] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[407.455255] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.626s)
[407.604948] [063/133] (611s left) gem_exec_capture (capture-invisible)
[407.664648] Starting subtest: capture-invisible
[407.666894] Starting dynamic subtest: smem0
[407.671026] Dynamic subtest smem0: SKIP (0.000s)
[407.674952] Subtest capture-invisible: SKIP (0.001s)
[407.758183] [064/133] (611s left) kms_async_flips (async-flip-hang)
[407.843428] Starting subtest: async-flip-hang
[408.218280] Starting dynamic subtest: pipe-A-eDP-1
[423.843591] Dynamic subtest pipe-A-eDP-1: SUCCESS (15.623s)
[424.228274] Starting dynamic subtest: pipe-B-eDP-1
[439.844977] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.620s)
[440.232483] Starting dynamic subtest: pipe-C-eDP-1
[455.837408] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.612s)
[456.226935] Starting dynamic subtest: pipe-D-eDP-1
[471.840055] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.620s)
[471.842565] Subtest async-flip-hang: SUCCESS (63.996s)
[473.007168] [065/133] (546s left) kms_dp_aux_dev
[473.377228] [066/133] (546s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[473.514540] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[473.519128] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[473.622025] [067/133] (546s left) kms_cursor_crc (cursor-offscreen-128x128)
[473.842647] Starting subtest: cursor-offscreen-128x128
[473.844780] Starting dynamic subtest: pipe-A-eDP-1
[475.790208] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.946s)
[475.823880] Starting dynamic subtest: pipe-D-eDP-1
[478.421938] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.608s)
[478.423800] Subtest cursor-offscreen-128x128: SUCCESS (4.580s)
[479.274289] [068/133] (540s left) gem_userptr_blits (sd-probe)
[479.344634] Starting subtest: sd-probe
[479.346960] Subtest sd-probe: SUCCESS (0.000s)
[479.476188] [069/133] (540s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[479.571353] Starting subtest: 2x-flip-vs-rmfb-interruptible
[479.582855] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.011s)
[479.659345] [070/133] (540s left) gem_exec_fence (keep-in-fence)
[479.826818] Starting subtest: keep-in-fence
[479.828932] Starting dynamic subtest: rcs0
[479.879774] Dynamic subtest rcs0: SUCCESS (0.055s)
[479.891552] Starting dynamic subtest: bcs0
[479.932930] Dynamic subtest bcs0: SUCCESS (0.051s)
[479.944196] Starting dynamic subtest: vcs0
[481.349874] Dynamic subtest vcs0: SUCCESS (1.413s)
[481.362476] Starting dynamic subtest: vcs1
[483.333996] Dynamic subtest vcs1: SUCCESS (1.981s)
[483.347103] Starting dynamic subtest: vecs0
[485.317633] Dynamic subtest vecs0: SUCCESS (1.981s)
[485.330843] Starting dynamic subtest: ccs0
[485.558927] Dynamic subtest ccs0: SUCCESS (0.240s)
[485.561326] Subtest keep-in-fence: SUCCESS (5.736s)
[487.449951] [FACT gem_exec_fence (keep-in-fence)] new: kernel.kmod_is_loaded.vgem: true
[487.453355] [071/133] (532s left) kms_big_fb (x-tiled-addfb)
[487.554092] Starting subtest: x-tiled-addfb
[487.556461] Subtest x-tiled-addfb: SUCCESS (0.000s)
[487.659240] [072/133] (532s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[487.780640] Starting subtest: cursorA-vs-flipB-legacy
[487.785288] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[487.931640] [073/133] (531s left) gem_mmap_gtt (pf-nonblock)
[487.997179] Subtest pf-nonblock: SKIP (0.000s)
[488.064173] [074/133] (531s left) kms_psr (pr-primary-mmap-cpu)
[488.163787] Starting subtest: pr-primary-mmap-cpu
[488.167918] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[488.237166] [075/133] (531s left) kms_selftest (drm_damage_helper)
[488.274980] Starting subtest: drm_damage_helper
[488.280087] Starting dynamic subtest: drm_test_damage_iter_no_damage
[488.377876] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.097s)
[488.387270] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[488.465009] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.087s)
[488.474391] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[488.577020] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.112s)
[488.588171] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[488.683011] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.103s)
[488.693803] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[488.775078] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.091s)
[488.785367] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[488.882589] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.106s)
[488.893588] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[488.977055] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.092s)
[488.987618] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[489.062545] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.084s)
[489.083127] Starting dynamic subtest: drm_test_damage_iter_single_damage
[489.161055] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.097s)
[489.182207] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[489.254429] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.091s)
[489.271749] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[489.360289] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.105s)
[489.373748] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[489.456196] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.095s)
[489.465465] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[489.534179] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.078s)
[489.545231] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[489.646539] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.109s)
[489.655837] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[489.746056] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.100s)
[489.756012] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[489.841972] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.095s)
[489.852245] Starting dynamic subtest: drm_test_damage_iter_damage
[489.931092] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.086s)
[489.940179] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[490.025899] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.094s)
[490.034673] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[490.123225] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.096s)
[490.135272] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[490.221789] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.097s)
[490.231248] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[490.331233] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.108s)
[490.332880] Subtest drm_damage_helper: SUCCESS (2.058s)
[490.493498] [076/133] (529s left) syncobj_timeline (wait-zero-handles)
[490.551642] Starting subtest: wait-zero-handles
[490.553669] Subtest wait-zero-handles: SUCCESS (0.000s)
[490.653925] [077/133] (529s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[490.758552] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[497.512565] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.756s)
[497.626781] [078/133] (522s left) kms_lease (lease-invalid-connector)
[497.724509] Starting subtest: lease-invalid-connector
[497.726805] Starting dynamic subtest: pipe-A-eDP-1
[497.728970] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[497.738770] Starting dynamic subtest: pipe-B-eDP-1
[497.741100] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[497.750552] Starting dynamic subtest: pipe-C-eDP-1
[497.752781] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[497.762242] Starting dynamic subtest: pipe-D-eDP-1
[497.764089] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[497.765974] Subtest lease-invalid-connector: SUCCESS (0.004s)
[497.803179] [079/133] (522s left) gem_exec_params (no-blt)
[497.862547] Starting subtest: no-blt
[497.867491] Subtest no-blt: SUCCESS (0.003s)
[498.001943] [080/133] (522s left) i915_pm_rpm (debugfs-forcewake-user)
[499.525133] Starting subtest: debugfs-forcewake-user
[510.921075] Subtest debugfs-forcewake-user: SUCCESS (11.399s)
[511.311303] [081/133] (508s left) kms_big_fb (linear-32bpp-rotate-180)
[511.413067] Starting subtest: linear-32bpp-rotate-180
[512.979868] Subtest linear-32bpp-rotate-180: SUCCESS (1.567s)
[513.125616] [082/133] (507s left) gem_workarounds (reset)
[513.199977] Starting subtest: reset
[513.387730] Subtest reset: SUCCESS (0.187s)
[513.507208] [083/133] (506s left) syncobj_timeline (reset-unsignaled)
[513.569251] Starting subtest: reset-unsignaled
[513.571208] Subtest reset-unsignaled: SUCCESS (0.000s)
[513.672258] [084/133] (506s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[513.777501] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[513.780832] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[513.886122] [085/133] (506s left) prime_self_import (basic-llseek-size)
[513.926286] Starting subtest: basic-llseek-size
[513.956824] Subtest basic-llseek-size: SUCCESS (0.032s)
[514.091586] [086/133] (506s left) gem_exec_schedule (preempt-other)
[514.162631] Starting subtest: preempt-other
[514.164523] Starting dynamic subtest: rcs0
[514.229190] Dynamic subtest rcs0: SUCCESS (0.071s)
[514.239846] Starting dynamic subtest: bcs0
[514.299391] Dynamic subtest bcs0: SUCCESS (0.070s)
[514.312684] Starting dynamic subtest: vcs0
[514.366028] Dynamic subtest vcs0: SUCCESS (0.066s)
[514.377338] Starting dynamic subtest: vcs1
[514.438313] Dynamic subtest vcs1: SUCCESS (0.071s)
[514.451208] Starting dynamic subtest: vecs0
[514.509803] Dynamic subtest vecs0: SUCCESS (0.070s)
[514.522348] Starting dynamic subtest: ccs0
[514.580644] Dynamic subtest ccs0: SUCCESS (0.070s)
[514.582745] Subtest preempt-other: SUCCESS (0.423s)
[515.411762] [087/133] (505s left) gem_pxp (create-protected-buffer)
[515.513120] Starting subtest: create-protected-buffer
[515.515459] Subtest create-protected-buffer: SUCCESS (0.000s)
[515.635292] [088/133] (504s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[515.733302] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[515.737747] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[515.835413] [089/133] (504s left) gem_mmap_wc (set-cache-level)
[515.887312] Subtest set-cache-level: SKIP (0.000s)
[515.946624] [090/133] (504s left) kms_busy (extended-pageflip-hang-oldfb)
[516.048167] Starting subtest: extended-pageflip-hang-oldfb
[516.050530] Starting dynamic subtest: pipe-A
[516.460246] Dynamic subtest pipe-A: SUCCESS (0.412s)
[516.471280] Starting dynamic subtest: pipe-D
[517.627810] Dynamic subtest pipe-D: SUCCESS (1.163s)
[517.630077] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.580s)
[518.464549] [091/133] (502s left) kms_psr (psr-cursor-mmap-gtt)
[518.546006] Starting subtest: psr-cursor-mmap-gtt
[518.548271] Starting dynamic subtest: eDP-1
[520.275488] Dynamic subtest eDP-1: SUCCESS (1.728s)
[520.277941] Subtest psr-cursor-mmap-gtt: SUCCESS (1.729s)
[521.126444] [092/133] (499s left) kms_async_flips (test-time-stamp)
[521.210722] Starting subtest: test-time-stamp
[521.585105] Starting dynamic subtest: pipe-A-eDP-1
[522.437257] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.850s)
[522.834280] Starting dynamic subtest: pipe-B-eDP-1
[523.588929] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.761s)
[523.963341] Starting dynamic subtest: pipe-C-eDP-1
[524.729275] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.773s)
[525.105733] Starting dynamic subtest: pipe-D-eDP-1
[525.858565] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.759s)
[525.861086] Subtest test-time-stamp: SUCCESS (4.648s)
[527.031605] [093/133] (493s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[527.428452] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[528.234392] [094/133] (492s left) gem_close_race (multigpu-basic-threads)
[528.292385] Starting subtest: multigpu-basic-threads
[528.296914] Subtest multigpu-basic-threads: SKIP (0.000s)
[528.537357] [095/133] (492s left) prime_mmap (test_correct_cpu_write)
[528.603060] Starting subtest: test_correct_cpu_write
[528.604968] Starting dynamic subtest: test_correct_cpu_write-smem
[528.606880] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[528.608800] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[528.703986] [096/133] (492s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[528.807411] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[528.809765] Starting dynamic subtest: pipe-A-eDP-1
[528.905934] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[528.923756] Starting dynamic subtest: pipe-B-eDP-1
[530.032344] Dynamic subtest pipe-B-eDP-1: SKIP (1.123s)
[530.036510] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.227s)
[531.223029] [097/133] (489s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[531.277279] Starting subtest: etime-single-wait-for-submit-submitted
[531.385785] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.108s)
[531.465313] [098/133] (489s left) perf (non-zero-reason)
[531.608663] Starting subtest: non-zero-reason
[531.610836] Starting dynamic subtest: 0-rcs0
[536.995759] Dynamic subtest 0-rcs0: SUCCESS (5.386s)
[537.009375] Starting dynamic subtest: 1-vcs1
[540.901066] Dynamic subtest 1-vcs1: SUCCESS (3.903s)
[540.903987] Subtest non-zero-reason: SUCCESS (9.291s)
[540.947701] [099/133] (480s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[541.060874] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[541.072430] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.013s)
[541.155052] [100/133] (479s left) gem_fence_thrash (bo-write-verify-y)
[541.191948] Starting subtest: bo-write-verify-y
[541.215976] Subtest bo-write-verify-y: SKIP (0.024s)
[541.285633] [101/133] (479s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[541.384719] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[541.388857] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[541.487147] [102/133] (479s left) prime_vgem (busy)
[541.558520] Starting subtest: busy
[541.560900] Starting dynamic subtest: rcs0
[541.624430] Dynamic subtest rcs0: SUCCESS (0.066s)
[541.635737] Starting dynamic subtest: bcs0
[541.682100] Dynamic subtest bcs0: SUCCESS (0.057s)
[541.692205] Starting dynamic subtest: vcs0
[541.728058] Dynamic subtest vcs0: SUCCESS (0.045s)
[541.738203] Starting dynamic subtest: vcs1
[541.775471] Dynamic subtest vcs1: SUCCESS (0.046s)
[541.787815] Starting dynamic subtest: vecs0
[541.820423] Dynamic subtest vecs0: SUCCESS (0.044s)
[541.830815] Starting dynamic subtest: ccs0
[541.863893] Dynamic subtest ccs0: SUCCESS (0.042s)
[541.866006] Subtest busy: SUCCESS (0.306s)
[542.010584] [103/133] (479s left) gem_eio (in-flight-suspend)
[542.236521] Starting subtest: in-flight-suspend
[585.141443] Subtest in-flight-suspend: SUCCESS (13.122s)
[585.279015] [104/133] (435s left) kms_vblank (wait-forked-busy)
[585.372976] Starting subtest: wait-forked-busy
[585.375219] Starting dynamic subtest: pipe-A-eDP-1
[587.257864] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.881s)
[587.273354] Starting dynamic subtest: pipe-D-eDP-1
[589.803258] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.537s)
[589.805440] Subtest wait-forked-busy: SUCCESS (4.422s)
[590.602003] [105/133] (430s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[590.694644] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[590.699242] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[590.805623] [106/133] (430s left) gem_exec_reloc (basic-wc-active)
[590.862122] Subtest basic-wc-active: SKIP (0.000s)
[590.935531] [107/133] (430s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[591.026788] Starting subtest: y-tiled-64bpp-rotate-180
[591.030808] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[591.151365] [108/133] (430s left) i915_query (query-topology-known-pci-ids)
[591.221188] Starting subtest: query-topology-known-pci-ids
[591.225656] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[591.365914] [109/133] (430s left) kms_cdclk (plane-scaling)
[591.480069] Starting subtest: plane-scaling
[591.482336] Starting dynamic subtest: pipe-A-eDP-1
[591.785930] Dynamic subtest pipe-A-eDP-1: SKIP (0.302s)
[591.796962] Starting dynamic subtest: pipe-B-eDP-1
[591.801586] Dynamic subtest pipe-B-eDP-1: SKIP (0.003s)
[591.811635] Starting dynamic subtest: pipe-C-eDP-1
[591.816871] Dynamic subtest pipe-C-eDP-1: SKIP (0.003s)
[591.829331] Starting dynamic subtest: pipe-D-eDP-1
[591.833991] Dynamic subtest pipe-D-eDP-1: SKIP (0.004s)
[591.838656] Subtest plane-scaling: SKIP (0.324s)
[592.641694] [110/133] (428s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[592.745395] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[592.749875] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[592.853313] [111/133] (428s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[592.938566] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[592.940893] Starting dynamic subtest: pipe-A-default-mode
[594.098993] Dynamic subtest pipe-A-default-mode: SKIP (1.157s)
[594.103293] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.158s)
[594.247026] [112/133] (427s left) gem_userptr_blits (access-control)
[594.315500] Starting subtest: access-control
[594.320165] Subtest access-control: SKIP (0.000s)
[594.437365] [113/133] (427s left) perf_pmu (busy-idle-no-semaphores)
[594.477164] Starting subtest: busy-idle-no-semaphores
[594.479432] Starting dynamic subtest: rcs0
[595.123434] Dynamic subtest rcs0: SUCCESS (0.645s)
[595.136461] Starting dynamic subtest: bcs0
[595.775663] Dynamic subtest bcs0: SUCCESS (0.649s)
[595.787437] Starting dynamic subtest: vcs0
[596.429401] Dynamic subtest vcs0: SUCCESS (0.651s)
[596.441211] Starting dynamic subtest: vcs1
[597.763057] Dynamic subtest vcs1: SUCCESS (1.330s)
[597.776184] Starting dynamic subtest: vecs0
[599.749457] Dynamic subtest vecs0: SUCCESS (1.982s)
[599.763363] Starting dynamic subtest: ccs0
[601.733043] Dynamic subtest ccs0: SUCCESS (1.979s)
[601.735914] Subtest busy-idle-no-semaphores: SUCCESS (7.252s)
[601.853299] [114/133] (419s left) gem_ctx_freq (sysfs)
[601.935186] Starting subtest: sysfs
[601.937319] Starting dynamic subtest: gt0
[607.441749] Dynamic subtest gt0: SUCCESS (5.508s)
[607.454544] Starting dynamic subtest: gt1
[649.113580] Dynamic subtest gt1: SUCCESS (41.668s)
[649.116378] Subtest sysfs: SUCCESS (47.179s)
[649.241164] [115/133] (372s left) dumb_buffer (create-valid-dumb)
[649.295539] Starting subtest: create-valid-dumb
[649.297654] Subtest create-valid-dumb: SUCCESS (0.000s)
[649.421368] [116/133] (372s left) gem_media_fill (media-fill)
[649.479529] Subtest media-fill: SKIP (0.000s)
[649.595095] [117/133] (372s left) gem_exec_nop (basic-parallel)
[649.672839] Starting subtest: basic-parallel
[666.075949] Subtest basic-parallel: SUCCESS (16.409s)
[666.317410] [118/133] (355s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[666.383752] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[666.386034] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[666.490620] [119/133] (355s left) gem_partial_pwrite_pread (write-snoop)
[666.569345] Subtest write-snoop: SKIP (0.000s)
[666.640043] [120/133] (355s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[666.748560] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[666.752878] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[666.849160] [121/133] (355s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[666.947893] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[667.772863] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.826s)
[667.938459] [122/133] (354s left) gem_render_copy (x-tiled)
[668.000965] Starting subtest: x-tiled
[668.002892] Starting dynamic subtest: smem
[668.040862] Dynamic subtest smem: SUCCESS (0.042s)
[668.043311] Subtest x-tiled: SUCCESS (0.043s)
[668.225010] [123/133] (353s left) gem_exec_reloc (basic-wc-read-active)
[668.280809] Subtest basic-wc-read-active: SKIP (0.000s)
[668.352039] [124/133] (353s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[668.466793] Starting subtest: basic-flip-before-cursor-varying-size
[669.407180] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.941s)
[670.208897] [125/133] (352s left) gem_tiled_wb
[670.340536] [126/133] (351s left) gem_exec_balancer (invalid-bonds)
[670.405588] Starting subtest: invalid-bonds
[670.410229] Subtest invalid-bonds: SKIP (0.000s)
[670.709590] [127/133] (351s left) api_intel_allocator (execbuf-with-allocator)
[670.792675] Starting subtest: execbuf-with-allocator
[670.797721] Subtest execbuf-with-allocator: SUCCESS (0.006s)
[670.931317] [128/133] (351s left) gem_exec_fence (basic-busy-all)
[671.003913] Starting subtest: basic-busy-all
[671.094528] Subtest basic-busy-all: SUCCESS (0.091s)
[673.200921] [129/133] (349s left) gem_exec_reloc (basic-cpu-read-noreloc)
[673.262150] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[673.336322] [130/133] (349s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[673.435413] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[680.123295] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.688s)
[680.242830] [131/133] (342s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[680.346928] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[680.350821] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[680.456490] [132/133] (342s left) i915_pciid
[680.604050] [133/133] (342s left) i915_drm_fdinfo (memory-info-resident)
[680.640519] Starting subtest: memory-info-resident
[680.642845] Starting dynamic subtest: smem0
[683.313245] Dynamic subtest smem0: SUCCESS (2.674s)
[683.315420] Subtest memory-info-resident: SUCCESS (2.675s)
[683.385711] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: syncobj_timeline
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_pm_lpsp
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: kms_cursor_crc
results: parsing output: 7/ for test: kms_psr
results: parsing output: 8/ for test: kms_chamelium_edid
results: parsing output: 9/ for test: kms_flip_scaled_crc
results: parsing output: 10/ for test: kms_plane_alpha_blend
results: parsing output: 11/ for test: syncobj_eventfd
results: parsing output: 12/ for test: gem_ctx_sseu
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: kms_cursor_edge_walk
results: parsing output: 15/ for test: fbdev
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: gem_flink_basic
results: parsing output: 18/ for test: kms_psr
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: gem_exec_reloc
results: parsing output: 21/ for test: gem_ctx_persistence
results: parsing output: 22/ for test: sw_sync
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_feature_discovery
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: kms_invalid_mode
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: gem_render_copy
results: parsing output: 29/ for test: i915_pm_rps
results: parsing output: 30/ for test: gen7_exec_parse
results: parsing output: 31/ for test: syncobj_wait
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_ppgtt
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: api_intel_bb
results: parsing output: 40/ for test: kms_setmode
results: parsing output: 41/ for test: kms_pm_rpm
results: parsing output: 42/ for test: gem_exec_whisper
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: kms_plane
results: parsing output: 48/ for test: kms_content_protection
results: parsing output: 49/ for test: kms_color_pipeline
results: parsing output: 50/ for test: gem_lmem_swapping
results: parsing output: 51/ for test: kms_psr2_sf
results: parsing output: 52/ for test: kms_cursor_legacy
results: parsing output: 53/ for test: kms_plane_scaling
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_psr
results: parsing output: 56/ for test: gem_pxp
results: parsing output: 57/ for test: gem_softpin
results: parsing output: 58/ for test: kms_plane_scaling
results: parsing output: 59/ for test: gem_ctx_exec
results: parsing output: 60/ for test: gem_exec_schedule
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: gem_exec_capture
results: parsing output: 63/ for test: kms_async_flips
results: parsing output: 64/ for test: kms_dp_aux_dev
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_cursor_crc
results: parsing output: 67/ for test: gem_userptr_blits
results: parsing output: 68/ for test: kms_flip
results: parsing output: 69/ for test: gem_exec_fence
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: kms_cursor_legacy
results: parsing output: 72/ for test: gem_mmap_gtt
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: kms_selftest
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_lease
results: parsing output: 78/ for test: gem_exec_params
results: parsing output: 79/ for test: i915_pm_rpm
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: gem_workarounds
results: parsing output: 82/ for test: syncobj_timeline
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: prime_self_import
results: parsing output: 85/ for test: gem_exec_schedule
results: parsing output: 86/ for test: gem_pxp
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_mmap_wc
results: parsing output: 89/ for test: kms_busy
results: parsing output: 90/ for test: kms_psr
results: parsing output: 91/ for test: kms_async_flips
results: parsing output: 92/ for test: kms_chamelium_hpd
results: parsing output: 93/ for test: gem_close_race
results: parsing output: 94/ for test: prime_mmap
results: parsing output: 95/ for test: kms_psr2_sf
results: parsing output: 96/ for test: syncobj_timeline
results: parsing output: 97/ for test: perf
results: parsing output: 98/ for test: kms_flip
results: parsing output: 99/ for test: gem_fence_thrash
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: prime_vgem
results: parsing output: 102/ for test: gem_eio
results: parsing output: 103/ for test: kms_vblank
results: parsing output: 104/ for test: kms_plane
results: parsing output: 105/ for test: gem_exec_reloc
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: i915_query
results: parsing output: 108/ for test: kms_cdclk
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_flip_scaled_crc
results: parsing output: 111/ for test: gem_userptr_blits
results: parsing output: 112/ for test: perf_pmu
results: parsing output: 113/ for test: gem_ctx_freq
results: parsing output: 114/ for test: dumb_buffer
results: parsing output: 115/ for test: gem_media_fill
results: parsing output: 116/ for test: gem_exec_nop
results: parsing output: 117/ for test: syncobj_wait
results: parsing output: 118/ for test: gem_partial_pwrite_pread
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: gem_render_copy
results: parsing output: 122/ for test: gem_exec_reloc
results: parsing output: 123/ for test: kms_cursor_legacy
results: parsing output: 124/ for test: gem_tiled_wb
results: parsing output: 125/ for test: gem_exec_balancer
results: parsing output: 126/ for test: api_intel_allocator
results: parsing output: 127/ for test: gem_exec_fence
results: parsing output: 128/ for test: gem_exec_reloc
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: i915_pciid
results: parsing output: 132/ for test: i915_drm_fdinfo
Done.