[57.412906] Initializing watchdogs
[57.412953]   /dev/watchdog0
[57.426900] [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]
[57.431209] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.433392] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.436966] [001/133] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[57.563819] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[57.568202] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[57.668639] [002/133] (960s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[57.766904] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[57.769326] Starting dynamic subtest: pipe-A-eDP-1
[57.793158] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[57.802798] Starting dynamic subtest: pipe-B-eDP-1
[57.825191] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[57.831187] Starting dynamic subtest: pipe-C-eDP-1
[57.852128] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[57.858297] Starting dynamic subtest: pipe-D-eDP-1
[57.880796] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[57.885198] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.003s)
[60.040828] [003/133] (957s left) syncobj_timeline (wait-all-interrupted)
[60.102774] Starting subtest: wait-all-interrupted
[60.207624] Subtest wait-all-interrupted: SUCCESS (0.102s)
[60.281379] [004/133] (957s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[60.382744] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[63.934749] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.534s)
[65.074709] [005/133] (953s left) kms_pm_lpsp (kms-lpsp)
[66.184366] Starting subtest: kms-lpsp
[66.186550] Starting dynamic subtest: pipe-A-eDP-1
[66.359974] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.179s)
[66.655570] Subtest kms-lpsp: SUCCESS (0.474s)
[67.516316] [006/133] (950s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[67.684027] Starting subtest: yf-tiled-8bpp-rotate-180
[67.688389] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[67.793098] [007/133] (950s left) kms_cursor_crc (cursor-random-512x170)
[68.134933] Starting subtest: cursor-random-512x170
[68.139362] Subtest cursor-random-512x170: SKIP (0.001s)
[68.274246] [008/133] (949s left) kms_psr (fbc-pr-suspend)
[68.369726] Starting subtest: fbc-pr-suspend
[68.373882] Subtest fbc-pr-suspend: SKIP (0.000s)
[68.451318] [009/133] (949s left) kms_chamelium_edid (dp-edid-resolution-list)
[68.828784] Subtest dp-edid-resolution-list: SKIP (0.000s)
[69.610932] [010/133] (948s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[69.705437] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[69.707624] Starting dynamic subtest: pipe-A-default-mode
[70.891726] Dynamic subtest pipe-A-default-mode: SKIP (1.178s)
[70.896216] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.180s)
[71.033717] [011/133] (947s left) kms_plane_alpha_blend (alpha-transparent-fb)
[71.132928] Starting subtest: alpha-transparent-fb
[71.419590] Starting dynamic subtest: pipe-A-eDP-1
[72.056232] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.634s)
[72.064557] Starting dynamic subtest: pipe-D-eDP-1
[73.433844] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.374s)
[73.436159] Subtest alpha-transparent-fb: SUCCESS (2.297s)
[74.237050] [012/133] (944s left) syncobj_eventfd (invalid-bad-flags)
[74.289821] Starting subtest: invalid-bad-flags
[74.292278] Subtest invalid-bad-flags: SUCCESS (0.000s)
[74.386128] [013/133] (944s left) gem_ctx_sseu (invalid-args)
[74.452167] Subtest invalid-args: SKIP (0.000s)
[74.518776] [014/133] (943s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[74.604241] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[74.606485] Starting dynamic subtest: pipe-A-eDP-1
[74.627740] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[74.638452] Starting dynamic subtest: pipe-B-eDP-1
[74.659587] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[74.667287] Starting dynamic subtest: pipe-C-eDP-1
[74.688814] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[74.695505] Starting dynamic subtest: pipe-D-eDP-1
[74.717211] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[74.721577] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[76.904361] [015/133] (941s left) kms_cursor_edge_walk (128x128-left-edge)
[76.995254] Starting subtest: 128x128-left-edge
[76.997638] Starting dynamic subtest: pipe-A-eDP-1
[80.463729] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.466s)
[80.472825] Starting dynamic subtest: pipe-D-eDP-1
[83.628461] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.160s)
[83.630313] Subtest 128x128-left-edge: SUCCESS (6.628s)
[84.494796] [016/133] (934s left) fbdev (eof)
[84.534619] Starting subtest: eof
[84.536926] Subtest eof: SUCCESS (0.000s)
[84.610590] [017/133] (933s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[84.709677] Starting subtest: fbc-pr-cursor-mmap-gtt
[84.713820] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[84.786210] [018/133] (933s left) gem_flink_basic (double-flink)
[84.850985] Starting subtest: double-flink
[84.853222] Subtest double-flink: SUCCESS (0.000s)
[84.937510] [019/133] (933s left) kms_psr (psr-primary-mmap-cpu)
[85.022602] Starting subtest: psr-primary-mmap-cpu
[85.024864] Starting dynamic subtest: eDP-1
[86.790044] Dynamic subtest eDP-1: SUCCESS (1.766s)
[86.792283] Subtest psr-primary-mmap-cpu: SUCCESS (1.767s)
[87.669233] [020/133] (931s left) syncobj_timeline (multi-wait-all-available-signaled)
[87.730832] Starting subtest: multi-wait-all-available-signaled
[87.733193] Subtest multi-wait-all-available-signaled: SUCCESS (0.000s)
[87.821639] [021/133] (930s left) gem_exec_reloc (basic-scanout)
[87.898479] Subtest basic-scanout: SKIP (0.000s)
[87.962900] [022/133] (930s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[88.022444] Starting subtest: saturated-hostile-nopreempt
[88.024751] Starting dynamic subtest: rcs0
[88.060660] Dynamic subtest rcs0: SKIP (0.036s)
[88.069707] Starting dynamic subtest: bcs0
[88.092166] Dynamic subtest bcs0: SKIP (0.031s)
[88.100670] Starting dynamic subtest: vcs0
[88.107059] Dynamic subtest vcs0: SKIP (0.013s)
[88.113294] Starting dynamic subtest: vcs1
[88.119502] Dynamic subtest vcs1: SKIP (0.014s)
[88.125994] Starting dynamic subtest: vecs0
[88.132395] Dynamic subtest vecs0: SKIP (0.011s)
[88.138635] Starting dynamic subtest: ccs0
[88.144966] Dynamic subtest ccs0: SKIP (0.013s)
[88.149286] Subtest saturated-hostile-nopreempt: SKIP (0.119s)
[88.213935] [023/133] (930s left) sw_sync (alloc_fence_invalid_timeline)
[88.254706] Starting subtest: alloc_fence_invalid_timeline
[88.256959] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[88.300676] [024/133] (930s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[88.391684] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[88.395612] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[88.483399] [025/133] (930s left) kms_feature_discovery (display-2x)
[88.582326] Starting subtest: display-2x
[88.586767] Subtest display-2x: SKIP (0.000s)
[88.652348] [026/133] (930s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[88.742907] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[88.744959] Starting dynamic subtest: pipe-A-eDP-1
[88.763020] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[88.769804] Starting dynamic subtest: pipe-B-eDP-1
[88.787854] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[88.794135] Starting dynamic subtest: pipe-C-eDP-1
[88.811086] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[88.817754] Starting dynamic subtest: pipe-D-eDP-1
[88.834947] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[88.838108] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.005s)
[91.033075] [027/133] (927s left) kms_invalid_mode (zero-clock)
[91.122625] Starting subtest: zero-clock
[91.124983] Starting dynamic subtest: pipe-A-eDP-1
[91.409041] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[91.417388] Starting dynamic subtest: pipe-B-eDP-1
[91.419288] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[91.425696] Starting dynamic subtest: pipe-C-eDP-1
[91.427593] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[91.434204] Starting dynamic subtest: pipe-D-eDP-1
[91.436352] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[91.438538] Subtest zero-clock: SUCCESS (0.294s)
[92.277404] [028/133] (926s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[92.367412] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[92.371524] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[92.468201] [029/133] (926s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[92.536524] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[92.541427] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[92.729467] [030/133] (926s left) i915_pm_rps (thresholds-idle-park)
[92.801633] Starting subtest: thresholds-idle-park
[92.806245] Subtest thresholds-idle-park: SKIP (0.001s)
[92.896447] [031/133] (926s left) gen7_exec_parse (cmd-crossing-page)
[92.954575] Subtest cmd-crossing-page: SKIP (0.000s)
[93.027007] [032/133] (926s left) syncobj_wait (single-wait-for-submit-submitted)
[93.086842] Starting subtest: single-wait-for-submit-submitted
[93.193023] Subtest single-wait-for-submit-submitted: SUCCESS (0.104s)
[93.277163] [033/133] (925s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[93.375209] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[98.168357] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.797s)
[99.288309] [034/133] (919s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[99.376875] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[106.811140] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.435s)
[106.933783] [035/133] (912s left) gem_ppgtt (blt-vs-render-ctx0)
[107.013108] Starting subtest: blt-vs-render-ctx0
[139.936035] Subtest blt-vs-render-ctx0: SUCCESS (32.916s)
[140.049538] [036/133] (879s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[140.194697] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[144.797075] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.607s)
[146.012554] [037/133] (873s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[146.110387] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[146.114803] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[146.207748] [038/133] (873s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[146.299655] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[153.597914] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.302s)
[153.729456] [039/133] (865s left) kms_frontbuffer_tracking (psr-suspend)
[153.831444] Starting subtest: psr-suspend
[191.683500] Subtest psr-suspend: SUCCESS (8.098s)
[191.814846] [040/133] (827s left) api_intel_bb (misplaced-blitter)
[191.884558] Starting subtest: misplaced-blitter
[191.891083] Subtest misplaced-blitter: SUCCESS (0.008s)
[192.027772] [041/133] (827s left) kms_setmode (basic-clone-single-crtc)
[192.097165] Starting subtest: basic-clone-single-crtc
[192.103795] Subtest basic-clone-single-crtc: SKIP (0.000s)
[192.192029] [042/133] (827s left) kms_pm_rpm (modeset-lpsp-stress)
[193.751456] Starting subtest: modeset-lpsp-stress
[210.580777] Subtest modeset-lpsp-stress: SUCCESS (16.609s)
[210.667270] [043/133] (808s left) gem_exec_whisper (basic-fds-forked-all)
[210.744209] Starting subtest: basic-fds-forked-all
[230.799005] Subtest basic-fds-forked-all: SUCCESS (20.026s)
[230.996300] [044/133] (788s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[231.104790] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[231.108749] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[231.198339] [045/133] (788s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[231.293122] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[231.297216] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[231.392376] [046/133] (788s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[231.484929] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[238.710010] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.226s)
[238.830016] [047/133] (780s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[238.918600] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[238.920813] Starting dynamic subtest: pipe-A-eDP-1
[238.976504] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[238.985097] Starting dynamic subtest: pipe-B-eDP-1
[239.038822] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[239.047233] Starting dynamic subtest: pipe-C-eDP-1
[239.101535] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[239.110118] Starting dynamic subtest: pipe-D-eDP-1
[239.164504] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[239.169268] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.008s)
[241.160710] [048/133] (778s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping)
[241.268913] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping
[241.273375] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[241.339531] [049/133] (778s left) kms_content_protection (atomic-dpms-hdcp14)
[241.498445] Starting subtest: atomic-dpms-hdcp14
[241.503007] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[241.611610] [050/133] (778s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[241.704791] Starting subtest: plane-ctm3x4-lut1d
[241.841893] Starting dynamic subtest: pipe-A-plane-0
[242.168430] Dynamic subtest pipe-A-plane-0: FAIL (0.169s)
[242.176946] Starting dynamic subtest: pipe-A-plane-1
[242.370730] Dynamic subtest pipe-A-plane-1: FAIL (0.190s)
[242.387928] Starting dynamic subtest: pipe-A-plane-2
[242.599031] Dynamic subtest pipe-A-plane-2: FAIL (0.190s)
[243.574609] Starting dynamic subtest: pipe-B-plane-0
[244.013313] Dynamic subtest pipe-B-plane-0: FAIL (0.152s)
[244.024798] Starting dynamic subtest: pipe-B-plane-1
[244.338839] Dynamic subtest pipe-B-plane-1: FAIL (0.166s)
[244.350114] Starting dynamic subtest: pipe-B-plane-2
[244.658948] Dynamic subtest pipe-B-plane-2: FAIL (0.630s)
[245.710570] Starting dynamic subtest: pipe-C-plane-0
[246.254343] Dynamic subtest pipe-C-plane-0: FAIL (0.174s)
[246.265452] Starting dynamic subtest: pipe-C-plane-1
[246.653202] Dynamic subtest pipe-C-plane-1: FAIL (0.623s)
[246.662167] Starting dynamic subtest: pipe-C-plane-2
[247.011860] Dynamic subtest pipe-C-plane-2: FAIL (0.147s)
[247.833702] Starting dynamic subtest: pipe-D-plane-0
[248.418043] Dynamic subtest pipe-D-plane-0: FAIL (0.140s)
[248.429372] Starting dynamic subtest: pipe-D-plane-1
[248.883803] Dynamic subtest pipe-D-plane-1: FAIL (0.625s)
[248.893908] Starting dynamic subtest: pipe-D-plane-2
[249.322356] Dynamic subtest pipe-D-plane-2: FAIL (0.536s)
[249.426715] Subtest plane-ctm3x4-lut1d: FAIL (7.722s)
[250.300753] [051/133] (769s left) gem_lmem_swapping (heavy-random)
[250.350880] Subtest heavy-random: SKIP (0.000s)
[250.391740] [052/133] (769s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[250.490606] Starting subtest: pr-overlay-plane-update-continuous-sf
[250.494949] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[250.558418] [053/133] (769s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[250.677558] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[250.684951] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.002s)
[250.830942] [054/133] (769s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[250.929740] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[250.931645] Starting dynamic subtest: pipe-A
[251.263344] Dynamic subtest pipe-A: SUCCESS (0.338s)
[251.272217] Starting dynamic subtest: pipe-B
[252.688137] Dynamic subtest pipe-B: SUCCESS (1.423s)
[252.696823] Starting dynamic subtest: pipe-C
[254.121737] Dynamic subtest pipe-C: SUCCESS (1.432s)
[254.130848] Starting dynamic subtest: pipe-D
[255.544119] Dynamic subtest pipe-D: SUCCESS (1.421s)
[255.546452] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.618s)
[256.718003] [055/133] (763s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[256.819810] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[256.824121] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[256.921507] [056/133] (763s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[257.014733] Starting subtest: fbc-psr2-sprite-mmap-gtt
[257.016874] Starting dynamic subtest: eDP-1
[257.020736] Dynamic subtest eDP-1: SKIP (0.000s)
[257.024495] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[257.087238] [057/133] (763s left) gem_pxp (protected-raw-src-copy-not-readible)
[257.209538] Starting subtest: protected-raw-src-copy-not-readible
[257.267234] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.059s)
[257.390458] [058/133] (762s left) gem_softpin (allocator-evict)
[257.450059] Starting subtest: allocator-evict
[257.452371] Starting dynamic subtest: rcs0
[280.612563] Dynamic subtest rcs0: SUCCESS (23.152s)
[280.624573] Starting dynamic subtest: bcs0
[304.299169] Dynamic subtest bcs0: SUCCESS (23.688s)
[304.311396] Starting dynamic subtest: vcs0
[327.927475] Dynamic subtest vcs0: SUCCESS (23.627s)
[327.939395] Starting dynamic subtest: vcs1
[351.678106] Dynamic subtest vcs1: SUCCESS (23.745s)
[351.690243] Starting dynamic subtest: vecs0
[375.325705] Dynamic subtest vecs0: SUCCESS (23.640s)
[375.339905] Starting dynamic subtest: ccs0
[399.285514] Dynamic subtest ccs0: SUCCESS (23.949s)
[399.288304] Subtest allocator-evict: SUCCESS (141.811s)
[399.372063] [059/133] (620s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[399.509718] Starting subtest: plane-scaler-unity-scaling-with-rotation
[399.512083] Starting dynamic subtest: pipe-A
[399.736126] Dynamic subtest pipe-A: SUCCESS (0.228s)
[399.746175] Starting dynamic subtest: pipe-B
[401.214535] Dynamic subtest pipe-B: SUCCESS (1.478s)
[401.224364] Starting dynamic subtest: pipe-C
[402.544535] Dynamic subtest pipe-C: SUCCESS (1.328s)
[402.556237] Starting dynamic subtest: pipe-D
[403.899063] Dynamic subtest pipe-D: SUCCESS (1.354s)
[403.901461] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.391s)
[405.065543] [060/133] (615s left) gem_ctx_exec (basic)
[405.131230] Starting subtest: basic
[405.136362] Subtest basic: SUCCESS (0.006s)
[405.252232] [061/133] (615s left) gem_exec_schedule (semaphore-noskip)
[405.340730] Starting subtest: semaphore-noskip
[405.755061] Subtest semaphore-noskip: SUCCESS (0.414s)
[406.101116] [062/133] (614s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[406.207632] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[406.853632] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.648s)
[407.016552] [063/133] (613s left) gem_exec_capture (capture-invisible)
[407.076788] Starting subtest: capture-invisible
[407.079184] Starting dynamic subtest: smem0
[407.083301] Dynamic subtest smem0: SKIP (0.000s)
[407.087357] Subtest capture-invisible: SKIP (0.001s)
[407.196823] [064/133] (613s left) kms_async_flips (async-flip-hang)
[407.290787] Starting subtest: async-flip-hang
[407.665968] Starting dynamic subtest: pipe-A-eDP-1
[435.105995] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.442s)
[435.481614] Starting dynamic subtest: pipe-B-eDP-1
[451.045713] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.570s)
[451.428402] Starting dynamic subtest: pipe-C-eDP-1
[467.105531] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.684s)
[467.488102] Starting dynamic subtest: pipe-D-eDP-1
[483.103333] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.618s)
[483.105953] Subtest async-flip-hang: SUCCESS (75.817s)
[484.275918] [065/133] (536s left) kms_dp_aux_dev
[484.637950] [066/133] (535s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[484.737293] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[484.741585] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[484.836295] [067/133] (535s left) kms_cursor_crc (cursor-offscreen-128x128)
[485.044469] Starting subtest: cursor-offscreen-128x128
[485.049193] Starting dynamic subtest: pipe-A-eDP-1
[486.991710] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.943s)
[487.025475] Starting dynamic subtest: pipe-D-eDP-1
[489.574594] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.559s)
[489.577068] Subtest cursor-offscreen-128x128: SUCCESS (4.528s)
[490.436723] [068/133] (530s left) gem_userptr_blits (sd-probe)
[490.512718] Starting subtest: sd-probe
[490.515400] Subtest sd-probe: SUCCESS (0.000s)
[490.629102] [069/133] (530s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[490.722432] Starting subtest: 2x-flip-vs-rmfb-interruptible
[490.734584] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.011s)
[490.810004] [070/133] (529s left) gem_exec_fence (keep-in-fence)
[490.992352] Starting subtest: keep-in-fence
[490.994869] Starting dynamic subtest: rcs0
[491.055346] Dynamic subtest rcs0: SUCCESS (0.063s)
[491.066967] Starting dynamic subtest: bcs0
[491.109382] Dynamic subtest bcs0: SUCCESS (0.052s)
[491.123448] Starting dynamic subtest: vcs0
[492.616461] Dynamic subtest vcs0: SUCCESS (1.504s)
[492.629117] Starting dynamic subtest: vcs1
[494.600687] Dynamic subtest vcs1: SUCCESS (1.981s)
[494.613004] Starting dynamic subtest: vecs0
[496.584941] Dynamic subtest vecs0: SUCCESS (1.981s)
[496.596166] Starting dynamic subtest: ccs0
[496.820787] Dynamic subtest ccs0: SUCCESS (0.233s)
[496.823469] Subtest keep-in-fence: SUCCESS (5.830s)
[498.669389] [FACT gem_exec_fence (keep-in-fence)] new: kernel.kmod_is_loaded.vgem: true
[498.672495] [071/133] (522s left) kms_big_fb (x-tiled-addfb)
[498.776381] Starting subtest: x-tiled-addfb
[498.778698] Subtest x-tiled-addfb: SUCCESS (0.000s)
[498.875713] [072/133] (521s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[499.010858] Starting subtest: cursorA-vs-flipB-legacy
[499.015381] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[499.179322] [073/133] (521s left) gem_mmap_gtt (pf-nonblock)
[499.236036] Subtest pf-nonblock: SKIP (0.000s)
[499.295444] [074/133] (521s left) kms_psr (pr-primary-mmap-cpu)
[499.392746] Starting subtest: pr-primary-mmap-cpu
[499.397156] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[499.476082] [075/133] (521s left) kms_selftest (drm_damage_helper)
[499.515607] Starting subtest: drm_damage_helper
[499.523850] Starting dynamic subtest: drm_test_damage_iter_no_damage
[499.611408] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.088s)
[499.627054] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[499.717433] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.105s)
[499.728747] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[499.805674] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.088s)
[499.814141] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[499.910198] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.104s)
[499.918698] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[499.990465] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.079s)
[499.998933] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[500.089143] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.097s)
[500.099201] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[500.181315] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.091s)
[500.191766] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[500.275381] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.093s)
[500.285341] Starting dynamic subtest: drm_test_damage_iter_single_damage
[500.370490] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.094s)
[500.386454] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[500.457300] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.086s)
[500.466148] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[500.560150] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.102s)
[500.568435] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[500.650910] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.091s)
[500.660397] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[500.753165] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.100s)
[500.761699] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[500.860348] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.108s)
[500.870192] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[500.952233] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.089s)
[500.961526] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[501.040346] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.087s)
[501.050352] Starting dynamic subtest: drm_test_damage_iter_damage
[501.142266] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.101s)
[501.152433] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[501.234306] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.092s)
[501.244369] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[501.326095] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.091s)
[501.336493] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[501.440099] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.112s)
[501.451605] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[501.541562] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.103s)
[501.543792] Subtest drm_damage_helper: SUCCESS (2.030s)
[501.694405] [076/133] (519s left) syncobj_timeline (wait-zero-handles)
[501.746710] Starting subtest: wait-zero-handles
[501.748955] Subtest wait-zero-handles: SUCCESS (0.000s)
[501.837237] [077/133] (519s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[501.928438] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[508.657599] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.731s)
[508.791354] [078/133] (512s left) kms_lease (lease-invalid-connector)
[508.888727] Starting subtest: lease-invalid-connector
[508.891042] Starting dynamic subtest: pipe-A-eDP-1
[508.893301] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[508.902677] Starting dynamic subtest: pipe-B-eDP-1
[508.904970] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[508.913902] Starting dynamic subtest: pipe-C-eDP-1
[508.916102] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[508.924604] Starting dynamic subtest: pipe-D-eDP-1
[508.926533] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[508.928450] Subtest lease-invalid-connector: SUCCESS (0.004s)
[508.965388] [079/133] (512s left) gem_exec_params (no-blt)
[509.017510] Starting subtest: no-blt
[509.019748] Subtest no-blt: SUCCESS (0.002s)
[509.123250] [080/133] (511s left) i915_pm_rpm (debugfs-forcewake-user)
[510.748113] Starting subtest: debugfs-forcewake-user
[522.130392] Subtest debugfs-forcewake-user: SUCCESS (11.381s)
[522.523199] [081/133] (498s left) kms_big_fb (linear-32bpp-rotate-180)
[522.617186] Starting subtest: linear-32bpp-rotate-180
[524.095764] Subtest linear-32bpp-rotate-180: SUCCESS (1.478s)
[524.230502] [082/133] (496s left) gem_workarounds (reset)
[524.290111] Starting subtest: reset
[524.466916] Subtest reset: SUCCESS (0.177s)
[524.586803] [083/133] (496s left) syncobj_timeline (reset-unsignaled)
[524.644320] Starting subtest: reset-unsignaled
[524.646187] Subtest reset-unsignaled: SUCCESS (0.000s)
[524.741838] [084/133] (496s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[524.834404] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[524.837678] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[524.935019] [085/133] (496s left) prime_self_import (basic-llseek-size)
[524.975482] Starting subtest: basic-llseek-size
[524.993848] Subtest basic-llseek-size: SUCCESS (0.020s)
[525.091156] [086/133] (496s left) gem_exec_schedule (preempt-other)
[525.153585] Starting subtest: preempt-other
[525.155398] Starting dynamic subtest: rcs0
[525.217991] Dynamic subtest rcs0: SUCCESS (0.069s)
[525.230424] Starting dynamic subtest: bcs0
[525.285239] Dynamic subtest bcs0: SUCCESS (0.067s)
[525.298695] Starting dynamic subtest: vcs0
[525.351539] Dynamic subtest vcs0: SUCCESS (0.066s)
[525.365020] Starting dynamic subtest: vcs1
[525.419857] Dynamic subtest vcs1: SUCCESS (0.067s)
[525.431999] Starting dynamic subtest: vecs0
[525.489546] Dynamic subtest vecs0: SUCCESS (0.069s)
[525.503062] Starting dynamic subtest: ccs0
[525.556095] Dynamic subtest ccs0: SUCCESS (0.066s)
[525.558343] Subtest preempt-other: SUCCESS (0.408s)
[526.699985] [087/133] (494s left) gem_pxp (create-protected-buffer)
[526.805346] Starting subtest: create-protected-buffer
[526.807755] Subtest create-protected-buffer: SUCCESS (0.000s)
[526.911365] [088/133] (494s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[526.994929] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[526.998805] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[527.099283] [089/133] (494s left) gem_mmap_wc (set-cache-level)
[527.157170] Subtest set-cache-level: SKIP (0.000s)
[527.211438] [090/133] (494s left) kms_busy (extended-pageflip-hang-oldfb)
[527.312680] Starting subtest: extended-pageflip-hang-oldfb
[527.314554] Starting dynamic subtest: pipe-A
[527.706371] Dynamic subtest pipe-A: SUCCESS (0.393s)
[527.718790] Starting dynamic subtest: pipe-D
[528.806491] Dynamic subtest pipe-D: SUCCESS (1.093s)
[528.808791] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.495s)
[529.676675] [091/133] (491s left) kms_psr (psr-cursor-mmap-gtt)
[529.759831] Starting subtest: psr-cursor-mmap-gtt
[529.762113] Starting dynamic subtest: eDP-1
[531.450196] Dynamic subtest eDP-1: SUCCESS (1.689s)
[531.452745] Subtest psr-cursor-mmap-gtt: SUCCESS (1.690s)
[532.335129] [092/133] (489s left) kms_async_flips (test-time-stamp)
[532.423685] Starting subtest: test-time-stamp
[532.811021] Starting dynamic subtest: pipe-A-eDP-1
[533.629361] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.817s)
[534.013569] Starting dynamic subtest: pipe-B-eDP-1
[534.767892] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.759s)
[535.146595] Starting dynamic subtest: pipe-C-eDP-1
[535.897785] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.758s)
[536.260395] Starting dynamic subtest: pipe-D-eDP-1
[537.034527] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.779s)
[537.037028] Subtest test-time-stamp: SUCCESS (4.610s)
[538.197673] [093/133] (483s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[538.596441] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[539.413160] [094/133] (482s left) gem_close_race (multigpu-basic-threads)
[539.468697] Starting subtest: multigpu-basic-threads
[539.473161] Subtest multigpu-basic-threads: SKIP (0.000s)
[539.687612] [095/133] (482s left) prime_mmap (test_correct_cpu_write)
[539.745299] Starting subtest: test_correct_cpu_write
[539.747729] Starting dynamic subtest: test_correct_cpu_write-smem
[539.750065] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[539.752084] Subtest test_correct_cpu_write: SUCCESS (0.003s)
[539.854611] [096/133] (481s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[539.946532] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[539.948774] Starting dynamic subtest: pipe-A-eDP-1
[540.032067] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[540.044219] Starting dynamic subtest: pipe-B-eDP-1
[541.196179] Dynamic subtest pipe-B-eDP-1: SKIP (1.161s)
[541.200732] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.253s)
[542.379220] [097/133] (479s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[542.436148] Starting subtest: etime-single-wait-for-submit-submitted
[542.541279] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.103s)
[542.618233] [098/133] (479s left) perf (non-zero-reason)
[542.750995] Starting subtest: non-zero-reason
[542.752881] Starting dynamic subtest: 0-rcs0
[548.015715] Dynamic subtest 0-rcs0: SUCCESS (5.263s)
[548.027742] Starting dynamic subtest: 1-vcs0
[551.867415] Dynamic subtest 1-vcs0: SUCCESS (3.850s)
[551.870594] Subtest non-zero-reason: SUCCESS (9.115s)
[551.915614] [099/133] (469s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[552.024747] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[552.033971] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.011s)
[552.113041] [100/133] (469s left) gem_fence_thrash (bo-write-verify-y)
[552.154728] Starting subtest: bo-write-verify-y
[552.173447] Subtest bo-write-verify-y: SKIP (0.017s)
[552.238729] [101/133] (469s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[552.334855] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[552.338790] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[552.428977] [102/133] (469s left) prime_vgem (busy)
[552.498922] Starting subtest: busy
[552.500835] Starting dynamic subtest: rcs0
[552.554400] Dynamic subtest rcs0: SUCCESS (0.058s)
[552.564671] Starting dynamic subtest: bcs0
[552.619677] Dynamic subtest bcs0: SUCCESS (0.064s)
[552.629062] Starting dynamic subtest: vcs0
[552.663409] Dynamic subtest vcs0: SUCCESS (0.043s)
[552.672881] Starting dynamic subtest: vcs1
[552.711767] Dynamic subtest vcs1: SUCCESS (0.047s)
[552.720987] Starting dynamic subtest: vecs0
[552.759799] Dynamic subtest vecs0: SUCCESS (0.047s)
[552.768911] Starting dynamic subtest: ccs0
[552.805716] Dynamic subtest ccs0: SUCCESS (0.045s)
[552.807918] Subtest busy: SUCCESS (0.310s)
[552.917476] [103/133] (469s left) gem_eio (in-flight-suspend)
[553.128547] Starting subtest: in-flight-suspend
[595.381288] Subtest in-flight-suspend: SUCCESS (13.490s)
[595.516939] [104/133] (426s left) kms_vblank (wait-forked-busy)
[595.621445] Starting subtest: wait-forked-busy
[595.623522] Starting dynamic subtest: pipe-A-eDP-1
[597.574809] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s)
[597.591006] Starting dynamic subtest: pipe-D-eDP-1
[600.193157] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.536s)
[600.195574] Subtest wait-forked-busy: SUCCESS (4.414s)
[601.034735] [105/133] (421s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[601.132228] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[601.136610] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[601.212431] [106/133] (420s left) gem_exec_reloc (basic-wc-active)
[601.278230] Subtest basic-wc-active: SKIP (0.000s)
[601.353945] [107/133] (420s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[601.455623] Starting subtest: y-tiled-64bpp-rotate-180
[601.460103] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[601.580207] [108/133] (420s left) i915_query (query-topology-known-pci-ids)
[601.636548] Starting subtest: query-topology-known-pci-ids
[601.640664] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[601.733477] [109/133] (420s left) kms_cdclk (plane-scaling)
[601.827153] Starting subtest: plane-scaling
[601.829289] Starting dynamic subtest: pipe-A-eDP-1
[602.121655] Dynamic subtest pipe-A-eDP-1: SKIP (0.286s)
[602.132520] Starting dynamic subtest: pipe-B-eDP-1
[602.136955] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[602.146645] Starting dynamic subtest: pipe-C-eDP-1
[602.151380] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[602.160896] Starting dynamic subtest: pipe-D-eDP-1
[602.165323] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[602.169712] Subtest plane-scaling: SKIP (0.293s)
[603.001226] [110/133] (419s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[603.118212] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[603.123013] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[603.222056] [111/133] (419s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[603.328830] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[603.331140] Starting dynamic subtest: pipe-A-default-mode
[604.483342] Dynamic subtest pipe-A-default-mode: SKIP (1.132s)
[604.487487] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.134s)
[604.653413] [112/133] (417s left) gem_userptr_blits (access-control)
[604.726167] Starting subtest: access-control
[604.730715] Subtest access-control: SKIP (0.000s)
[604.854899] [113/133] (417s left) perf_pmu (busy-idle-no-semaphores)
[604.908697] Starting subtest: busy-idle-no-semaphores
[604.911031] Starting dynamic subtest: rcs0
[605.569321] Dynamic subtest rcs0: SUCCESS (0.652s)
[605.581074] Starting dynamic subtest: bcs0
[606.229328] Dynamic subtest bcs0: SUCCESS (0.649s)
[606.240967] Starting dynamic subtest: vcs0
[606.888842] Dynamic subtest vcs0: SUCCESS (0.649s)
[606.901696] Starting dynamic subtest: vcs1
[607.948229] Dynamic subtest vcs1: SUCCESS (1.047s)
[607.961282] Starting dynamic subtest: vecs0
[609.994990] Dynamic subtest vecs0: SUCCESS (2.027s)
[610.009036] Starting dynamic subtest: ccs0
[611.979789] Dynamic subtest ccs0: SUCCESS (1.969s)
[611.982980] Subtest busy-idle-no-semaphores: SUCCESS (7.008s)
[612.098646] [114/133] (410s left) gem_ctx_freq (sysfs)
[612.171556] Starting subtest: sysfs
[612.174125] Starting dynamic subtest: gt0
[617.690768] Dynamic subtest gt0: SUCCESS (5.500s)
[617.703793] Starting dynamic subtest: gt1
[659.358536] Dynamic subtest gt1: SUCCESS (41.638s)
[659.361094] Subtest sysfs: SUCCESS (47.142s)
[659.491946] [115/133] (363s left) dumb_buffer (create-valid-dumb)
[659.536847] Starting subtest: create-valid-dumb
[659.538717] Subtest create-valid-dumb: SUCCESS (0.000s)
[659.623073] [116/133] (363s left) gem_media_fill (media-fill)
[659.693410] Subtest media-fill: SKIP (0.000s)
[659.803675] [117/133] (362s left) gem_exec_nop (basic-parallel)
[659.870550] Starting subtest: basic-parallel
[676.319366] Subtest basic-parallel: SUCCESS (16.450s)
[676.561258] [118/133] (346s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[676.621391] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[676.623647] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[676.719859] [119/133] (346s left) gem_partial_pwrite_pread (write-snoop)
[676.789250] Subtest write-snoop: SKIP (0.000s)
[676.866216] [120/133] (345s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[676.960378] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[676.964508] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[677.059517] [121/133] (345s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[677.157799] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[677.982062] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.825s)
[678.164425] [122/133] (344s left) gem_render_copy (x-tiled)
[678.228137] Starting subtest: x-tiled
[678.230441] Starting dynamic subtest: smem
[678.268875] Dynamic subtest smem: SUCCESS (0.040s)
[678.271517] Subtest x-tiled: SUCCESS (0.041s)
[678.496899] [123/133] (344s left) gem_exec_reloc (basic-wc-read-active)
[678.557707] Subtest basic-wc-read-active: SKIP (0.000s)
[678.647604] [124/133] (344s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[678.778273] Starting subtest: basic-flip-before-cursor-varying-size
[679.708850] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.930s)
[680.506395] [125/133] (342s left) gem_tiled_wb
[680.611365] [126/133] (342s left) gem_exec_balancer (invalid-bonds)
[680.671435] Starting subtest: invalid-bonds
[680.675596] Subtest invalid-bonds: SKIP (0.000s)
[680.963022] [127/133] (342s left) api_intel_allocator (execbuf-with-allocator)
[681.020583] Starting subtest: execbuf-with-allocator
[681.026189] Subtest execbuf-with-allocator: SUCCESS (0.006s)
[681.149071] [128/133] (341s left) gem_exec_fence (basic-busy-all)
[681.215418] Starting subtest: basic-busy-all
[681.315762] Subtest basic-busy-all: SUCCESS (0.101s)
[683.420165] [129/133] (339s left) gem_exec_reloc (basic-cpu-read-noreloc)
[683.485063] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[683.565702] [130/133] (339s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[683.674560] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[690.396467] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.722s)
[690.511462] [131/133] (332s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[690.604811] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[690.609259] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[690.713223] [132/133] (332s left) i915_pciid
[690.890554] [133/133] (332s left) i915_drm_fdinfo (memory-info-resident)
[690.929085] Starting subtest: memory-info-resident
[690.931087] Starting dynamic subtest: smem0
[693.361515] Dynamic subtest smem0: SUCCESS (2.437s)
[693.363692] Subtest memory-info-resident: SUCCESS (2.438s)
[693.439139] 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.