[57.318206] Initializing watchdogs
[57.318281]   /dev/watchdog0
[57.333258] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[57.337475] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.340343] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.343717] [001/133] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[57.448298] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[57.452560] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[57.551216] [002/133] (960s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[57.621735] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[57.624083] Starting dynamic subtest: pipe-A-eDP-1
[57.647411] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[57.657258] Starting dynamic subtest: pipe-B-eDP-1
[57.679078] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[57.686061] Starting dynamic subtest: pipe-C-eDP-1
[57.707295] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[57.714107] Starting dynamic subtest: pipe-D-eDP-1
[57.736729] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[57.740905] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.003s)
[59.940722] [003/133] (957s left) syncobj_timeline (wait-all-interrupted)
[59.994748] Starting subtest: wait-all-interrupted
[60.099950] Subtest wait-all-interrupted: SUCCESS (0.103s)
[60.183466] [004/133] (957s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[60.262238] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[63.872309] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.594s)
[65.071642] [005/133] (952s left) kms_pm_lpsp (kms-lpsp)
[66.154978] Starting subtest: kms-lpsp
[66.157367] Starting dynamic subtest: pipe-A-eDP-1
[66.330442] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.177s)
[66.624532] Subtest kms-lpsp: SUCCESS (0.468s)
[67.504465] [006/133] (950s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[67.612365] Starting subtest: yf-tiled-8bpp-rotate-180
[67.616882] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[67.724923] [007/133] (950s left) kms_cursor_crc (cursor-random-512x170)
[68.092711] Starting subtest: cursor-random-512x170
[68.097198] Subtest cursor-random-512x170: SKIP (0.001s)
[68.229586] [008/133] (949s left) kms_psr (fbc-pr-suspend)
[68.306289] Starting subtest: fbc-pr-suspend
[68.310104] Subtest fbc-pr-suspend: SKIP (0.000s)
[68.371209] [009/133] (949s left) kms_chamelium_edid (dp-edid-resolution-list)
[68.733414] Subtest dp-edid-resolution-list: SKIP (0.000s)
[69.508335] [010/133] (948s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[69.590608] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[69.592905] Starting dynamic subtest: pipe-A-default-mode
[70.706300] Dynamic subtest pipe-A-default-mode: SKIP (1.114s)
[70.710425] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.115s)
[70.847192] [011/133] (947s left) kms_plane_alpha_blend (alpha-transparent-fb)
[70.924063] Starting subtest: alpha-transparent-fb
[71.210594] Starting dynamic subtest: pipe-A-eDP-1
[71.836791] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.626s)
[71.845742] Starting dynamic subtest: pipe-D-eDP-1
[73.247233] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.409s)
[73.249734] Subtest alpha-transparent-fb: SUCCESS (2.322s)
[74.046074] [012/133] (944s left) syncobj_eventfd (invalid-bad-flags)
[74.104722] Starting subtest: invalid-bad-flags
[74.106989] Subtest invalid-bad-flags: SUCCESS (0.000s)
[74.214590] [013/133] (944s left) gem_ctx_sseu (invalid-args)
[74.274337] Subtest invalid-args: SKIP (0.000s)
[74.340832] [014/133] (944s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[74.406939] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[74.409316] Starting dynamic subtest: pipe-A-eDP-1
[74.433284] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[74.440530] Starting dynamic subtest: pipe-B-eDP-1
[74.462235] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[74.469273] Starting dynamic subtest: pipe-C-eDP-1
[74.490912] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[74.497366] Starting dynamic subtest: pipe-D-eDP-1
[74.518830] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[74.523171] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[76.628939] [015/133] (941s left) kms_cursor_edge_walk (128x128-left-edge)
[76.709502] Starting subtest: 128x128-left-edge
[76.711919] Starting dynamic subtest: pipe-A-eDP-1
[80.201878] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.489s)
[80.211224] Starting dynamic subtest: pipe-D-eDP-1
[83.384335] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.178s)
[83.386904] Subtest 128x128-left-edge: SUCCESS (6.668s)
[84.251647] [016/133] (934s left) fbdev (eof)
[84.294980] Starting subtest: eof
[84.297505] Subtest eof: SUCCESS (0.000s)
[84.379837] [017/133] (934s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[84.459056] Starting subtest: fbc-pr-cursor-mmap-gtt
[84.463587] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[84.524285] [018/133] (933s left) gem_flink_basic (double-flink)
[84.589084] Starting subtest: double-flink
[84.591527] Subtest double-flink: SUCCESS (0.000s)
[84.690759] [019/133] (933s left) kms_psr (psr-primary-mmap-cpu)
[84.765662] Starting subtest: psr-primary-mmap-cpu
[84.767817] Starting dynamic subtest: eDP-1
[86.552686] Dynamic subtest eDP-1: SUCCESS (1.785s)
[86.554856] Subtest psr-primary-mmap-cpu: SUCCESS (1.785s)
[87.418466] [020/133] (931s left) syncobj_timeline (multi-wait-all-available-signaled)
[87.478900] Starting subtest: multi-wait-all-available-signaled
[87.481275] Subtest multi-wait-all-available-signaled: SUCCESS (0.000s)
[87.571585] [021/133] (931s left) gem_exec_reloc (basic-scanout)
[87.630267] Subtest basic-scanout: SKIP (0.000s)
[87.692679] [022/133] (930s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[87.750414] Starting subtest: saturated-hostile-nopreempt
[87.752981] Starting dynamic subtest: rcs0
[87.837835] Dynamic subtest rcs0: SKIP (0.084s)
[87.845506] Starting dynamic subtest: bcs0
[87.852293] Dynamic subtest bcs0: SKIP (0.013s)
[87.859090] Starting dynamic subtest: vcs0
[87.866136] Dynamic subtest vcs0: SKIP (0.013s)
[87.875273] Starting dynamic subtest: vcs1
[87.891528] Dynamic subtest vcs1: SKIP (0.026s)
[87.898930] Starting dynamic subtest: vecs0
[87.908674] Dynamic subtest vecs0: SKIP (0.016s)
[87.915210] Starting dynamic subtest: ccs0
[87.921919] Dynamic subtest ccs0: SKIP (0.013s)
[87.926462] Subtest saturated-hostile-nopreempt: SKIP (0.170s)
[87.992666] [023/133] (930s left) sw_sync (alloc_fence_invalid_timeline)
[88.024618] Starting subtest: alloc_fence_invalid_timeline
[88.026809] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[88.083438] [024/133] (930s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[88.164162] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[88.168568] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[88.264158] [025/133] (930s left) kms_feature_discovery (display-2x)
[88.345084] Starting subtest: display-2x
[88.349138] Subtest display-2x: SKIP (0.000s)
[88.408145] [026/133] (930s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[88.483292] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[88.485222] Starting dynamic subtest: pipe-A-eDP-1
[88.505063] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[88.514327] Starting dynamic subtest: pipe-B-eDP-1
[88.531701] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[88.538839] Starting dynamic subtest: pipe-C-eDP-1
[88.555922] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[88.562506] Starting dynamic subtest: pipe-D-eDP-1
[88.580320] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[88.583737] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.004s)
[90.789309] [027/133] (928s left) kms_invalid_mode (zero-clock)
[90.872606] Starting subtest: zero-clock
[90.875019] Starting dynamic subtest: pipe-A-eDP-1
[91.156390] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[91.165431] Starting dynamic subtest: pipe-B-eDP-1
[91.167408] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[91.174361] Starting dynamic subtest: pipe-C-eDP-1
[91.177149] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[91.184374] Starting dynamic subtest: pipe-D-eDP-1
[91.186444] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[91.188410] Subtest zero-clock: SUCCESS (0.290s)
[92.015465] [028/133] (926s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[92.096070] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[92.100705] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[92.180990] [029/133] (926s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[92.237462] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[92.242467] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[92.429507] [030/133] (926s left) i915_pm_rps (thresholds-idle-park)
[92.484298] Starting subtest: thresholds-idle-park
[92.488703] Subtest thresholds-idle-park: SKIP (0.001s)
[92.613189] [031/133] (926s left) gen7_exec_parse (cmd-crossing-page)
[92.676162] Subtest cmd-crossing-page: SKIP (0.000s)
[92.737217] [032/133] (926s left) syncobj_wait (single-wait-for-submit-submitted)
[92.794012] Starting subtest: single-wait-for-submit-submitted
[92.901540] Subtest single-wait-for-submit-submitted: SUCCESS (0.106s)
[92.984589] [033/133] (926s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[93.061549] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[97.932895] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.875s)
[99.138119] [034/133] (919s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[99.212778] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[106.643228] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.431s)
[106.791680] [035/133] (912s left) gem_ppgtt (blt-vs-render-ctx0)
[106.853625] Starting subtest: blt-vs-render-ctx0
[139.763741] Subtest blt-vs-render-ctx0: SUCCESS (32.902s)
[139.901182] [036/133] (879s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[140.021897] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[144.649573] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.631s)
[145.844817] [037/133] (873s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[145.919350] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[145.923480] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[146.019233] [038/133] (873s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[146.099425] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[153.291150] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.194s)
[153.423050] [039/133] (865s left) kms_frontbuffer_tracking (psr-suspend)
[153.508446] Starting subtest: psr-suspend
[191.542549] Subtest psr-suspend: SUCCESS (8.935s)
[191.676598] [040/133] (827s left) api_intel_bb (misplaced-blitter)
[191.747807] Starting subtest: misplaced-blitter
[191.755857] Subtest misplaced-blitter: SUCCESS (0.009s)
[191.880871] [041/133] (827s left) kms_setmode (basic-clone-single-crtc)
[191.940241] Starting subtest: basic-clone-single-crtc
[191.946924] Subtest basic-clone-single-crtc: SKIP (0.000s)
[192.090239] [042/133] (827s left) kms_pm_rpm (modeset-lpsp-stress)
[193.960431] Starting subtest: modeset-lpsp-stress
[208.547408] Subtest modeset-lpsp-stress: SUCCESS (14.392s)
[208.648286] [043/133] (810s left) gem_exec_whisper (basic-fds-forked-all)
[208.712565] Starting subtest: basic-fds-forked-all
[231.100488] Subtest basic-fds-forked-all: SUCCESS (22.353s)
[231.280720] [044/133] (788s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[231.366193] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[231.370366] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[231.458407] [045/133] (788s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[231.529159] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[231.533342] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[231.607119] [046/133] (788s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[231.684888] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[239.024992] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.342s)
[239.152325] [047/133] (780s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[239.225377] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[239.227671] Starting dynamic subtest: pipe-A-eDP-1
[239.287605] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[239.298747] Starting dynamic subtest: pipe-B-eDP-1
[239.357351] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[239.368062] Starting dynamic subtest: pipe-C-eDP-1
[239.424796] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[239.435193] Starting dynamic subtest: pipe-D-eDP-1
[239.491719] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[239.495824] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.008s)
[241.498629] [048/133] (778s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping)
[241.565687] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping
[241.569920] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[241.636336] [049/133] (778s left) kms_content_protection (atomic-dpms-hdcp14)
[241.771607] Starting subtest: atomic-dpms-hdcp14
[241.776073] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[241.873180] [050/133] (777s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[241.946096] Starting subtest: plane-ctm3x4-lut1d
[242.130702] Starting dynamic subtest: pipe-A-plane-0
[242.488112] Dynamic subtest pipe-A-plane-0: FAIL (0.192s)
[242.499024] Starting dynamic subtest: pipe-A-plane-1
[242.685482] Dynamic subtest pipe-A-plane-1: FAIL (0.172s)
[242.696857] Starting dynamic subtest: pipe-A-plane-2
[242.905931] Dynamic subtest pipe-A-plane-2: FAIL (0.174s)
[243.892195] Starting dynamic subtest: pipe-B-plane-0
[244.309977] Dynamic subtest pipe-B-plane-0: FAIL (0.153s)
[244.320225] Starting dynamic subtest: pipe-B-plane-1
[244.628879] Dynamic subtest pipe-B-plane-1: FAIL (0.176s)
[244.639201] Starting dynamic subtest: pipe-B-plane-2
[244.941294] Dynamic subtest pipe-B-plane-2: FAIL (0.166s)
[245.634137] Starting dynamic subtest: pipe-C-plane-0
[246.161285] Dynamic subtest pipe-C-plane-0: FAIL (0.162s)
[246.170924] Starting dynamic subtest: pipe-C-plane-1
[246.561329] Dynamic subtest pipe-C-plane-1: FAIL (0.610s)
[246.572904] Starting dynamic subtest: pipe-C-plane-2
[246.933254] Dynamic subtest pipe-C-plane-2: FAIL (0.162s)
[247.751358] Starting dynamic subtest: pipe-D-plane-0
[248.361116] Dynamic subtest pipe-D-plane-0: FAIL (0.151s)
[248.375727] Starting dynamic subtest: pipe-D-plane-1
[248.824039] Dynamic subtest pipe-D-plane-1: FAIL (0.612s)
[248.835053] Starting dynamic subtest: pipe-D-plane-2
[249.272781] Dynamic subtest pipe-D-plane-2: FAIL (0.558s)
[249.376078] Subtest plane-ctm3x4-lut1d: FAIL (7.427s)
[250.211414] [051/133] (769s left) gem_lmem_swapping (heavy-random)
[250.267019] Subtest heavy-random: SKIP (0.000s)
[250.313844] [052/133] (769s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[250.392993] Starting subtest: pr-overlay-plane-update-continuous-sf
[250.397153] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[250.457988] [053/133] (769s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[250.557331] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[250.561912] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.001s)
[250.703071] [054/133] (769s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[250.777367] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[250.779705] Starting dynamic subtest: pipe-A
[251.114289] Dynamic subtest pipe-A: SUCCESS (0.338s)
[251.125135] Starting dynamic subtest: pipe-B
[252.498332] Dynamic subtest pipe-B: SUCCESS (1.383s)
[252.509735] Starting dynamic subtest: pipe-C
[253.926602] Dynamic subtest pipe-C: SUCCESS (1.427s)
[253.937219] Starting dynamic subtest: pipe-D
[255.363157] Dynamic subtest pipe-D: SUCCESS (1.435s)
[255.365518] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.587s)
[256.534989] [055/133] (763s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[256.618533] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[256.623250] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[256.733295] [056/133] (763s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[256.812393] Starting subtest: fbc-psr2-sprite-mmap-gtt
[256.814527] Starting dynamic subtest: eDP-1
[256.818876] Dynamic subtest eDP-1: SKIP (0.000s)
[256.823136] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[256.885409] [057/133] (763s left) gem_pxp (protected-raw-src-copy-not-readible)
[257.004346] Starting subtest: protected-raw-src-copy-not-readible
[257.063733] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.062s)
[257.183868] [058/133] (762s left) gem_softpin (allocator-evict)
[257.248422] Starting subtest: allocator-evict
[257.250802] Starting dynamic subtest: rcs0
[280.134960] Dynamic subtest rcs0: SUCCESS (22.877s)
[280.147459] Starting dynamic subtest: bcs0
[304.044187] Dynamic subtest bcs0: SUCCESS (23.909s)
[304.054184] Starting dynamic subtest: vcs0
[328.895061] Dynamic subtest vcs0: SUCCESS (24.846s)
[328.907095] Starting dynamic subtest: vcs1
[352.402682] Dynamic subtest vcs1: SUCCESS (23.502s)
[352.412610] Starting dynamic subtest: vecs0
[376.049044] Dynamic subtest vecs0: SUCCESS (23.639s)
[376.061347] Starting dynamic subtest: ccs0
[399.681122] Dynamic subtest ccs0: SUCCESS (23.624s)
[399.686001] Subtest allocator-evict: SUCCESS (142.407s)
[399.767258] [059/133] (620s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[399.899050] Starting subtest: plane-scaler-unity-scaling-with-rotation
[399.901331] Starting dynamic subtest: pipe-A
[400.125889] Dynamic subtest pipe-A: SUCCESS (0.228s)
[400.137665] Starting dynamic subtest: pipe-B
[401.435414] Dynamic subtest pipe-B: SUCCESS (1.309s)
[401.445759] Starting dynamic subtest: pipe-C
[402.780964] Dynamic subtest pipe-C: SUCCESS (1.344s)
[402.790562] Starting dynamic subtest: pipe-D
[404.101890] Dynamic subtest pipe-D: SUCCESS (1.319s)
[404.104165] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.204s)
[405.288291] [060/133] (614s left) gem_ctx_exec (basic)
[405.344093] Starting subtest: basic
[405.349053] Subtest basic: SUCCESS (0.007s)
[405.460963] [061/133] (614s left) gem_exec_schedule (semaphore-noskip)
[405.532818] Starting subtest: semaphore-noskip
[405.957575] Subtest semaphore-noskip: SUCCESS (0.424s)
[406.298490] [062/133] (613s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[406.386045] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[407.009790] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.625s)
[407.163731] [063/133] (613s left) gem_exec_capture (capture-invisible)
[407.234203] Starting subtest: capture-invisible
[407.236160] Starting dynamic subtest: smem0
[407.240343] Dynamic subtest smem0: SKIP (0.000s)
[407.244558] Subtest capture-invisible: SKIP (0.001s)
[407.332638] [064/133] (613s left) kms_async_flips (async-flip-hang)
[407.411283] Starting subtest: async-flip-hang
[407.786051] Starting dynamic subtest: pipe-A-eDP-1
[423.378344] Dynamic subtest pipe-A-eDP-1: SUCCESS (15.593s)
[423.778459] Starting dynamic subtest: pipe-B-eDP-1
[439.326520] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.555s)
[439.718045] Starting dynamic subtest: pipe-C-eDP-1
[455.383386] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.672s)
[455.779951] Starting dynamic subtest: pipe-D-eDP-1
[471.386586] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.612s)
[471.388881] Subtest async-flip-hang: SUCCESS (63.980s)
[472.549716] [065/133] (547s left) kms_dp_aux_dev
[472.919505] [066/133] (547s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[472.994695] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[472.998686] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[473.100456] [067/133] (547s left) kms_cursor_crc (cursor-offscreen-128x128)
[473.279155] Starting subtest: cursor-offscreen-128x128
[473.284093] Starting dynamic subtest: pipe-A-eDP-1
[475.218071] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.933s)
[475.246007] Starting dynamic subtest: pipe-D-eDP-1
[477.850601] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.610s)
[477.852946] Subtest cursor-offscreen-128x128: SUCCESS (4.569s)
[478.723892] [068/133] (541s left) gem_userptr_blits (sd-probe)
[478.791710] Starting subtest: sd-probe
[478.793650] Subtest sd-probe: SUCCESS (0.000s)
[478.928478] [069/133] (541s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[479.007904] Starting subtest: 2x-flip-vs-rmfb-interruptible
[479.017587] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.007s)
[479.120733] [070/133] (541s left) gem_exec_fence (keep-in-fence)
[479.308221] Starting subtest: keep-in-fence
[479.310658] Starting dynamic subtest: rcs0
[479.360607] Dynamic subtest rcs0: SUCCESS (0.056s)
[479.372490] Starting dynamic subtest: bcs0
[479.414236] Dynamic subtest bcs0: SUCCESS (0.051s)
[479.429174] Starting dynamic subtest: vcs0
[480.896037] Dynamic subtest vcs0: SUCCESS (1.478s)
[480.908519] Starting dynamic subtest: vcs1
[482.880017] Dynamic subtest vcs1: SUCCESS (1.981s)
[482.892726] Starting dynamic subtest: vecs0
[484.862948] Dynamic subtest vecs0: SUCCESS (1.981s)
[484.876086] Starting dynamic subtest: ccs0
[485.107815] Dynamic subtest ccs0: SUCCESS (0.243s)
[485.110577] Subtest keep-in-fence: SUCCESS (5.804s)
[486.973695] [FACT gem_exec_fence (keep-in-fence)] new: kernel.kmod_is_loaded.vgem: true
[486.977552] [071/133] (533s left) kms_big_fb (x-tiled-addfb)
[487.078851] Starting subtest: x-tiled-addfb
[487.080716] Subtest x-tiled-addfb: SUCCESS (0.000s)
[487.174150] [072/133] (533s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[487.279243] Starting subtest: cursorA-vs-flipB-legacy
[487.283758] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[487.424633] [073/133] (533s left) gem_mmap_gtt (pf-nonblock)
[487.485842] Subtest pf-nonblock: SKIP (0.000s)
[487.560991] [074/133] (533s left) kms_psr (pr-primary-mmap-cpu)
[487.637750] Starting subtest: pr-primary-mmap-cpu
[487.641743] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[487.713498] [075/133] (533s left) kms_selftest (drm_damage_helper)
[487.753764] Starting subtest: drm_damage_helper
[487.763291] Starting dynamic subtest: drm_test_damage_iter_no_damage
[487.860764] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.097s)
[487.872821] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[487.960107] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.100s)
[487.969644] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[488.049264] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.089s)
[488.058061] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[488.129767] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.080s)
[488.138761] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[488.234965] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.102s)
[488.245219] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[488.331261] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.095s)
[488.341481] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[488.421901] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.091s)
[488.431681] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[488.521891] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.099s)
[488.532083] Starting dynamic subtest: drm_test_damage_iter_single_damage
[488.617761] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.095s)
[488.627643] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[488.724900] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.106s)
[488.735250] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[488.812735] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.087s)
[488.822321] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[488.898336] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.084s)
[488.908449] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[488.993909] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.094s)
[489.004226] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[489.085006] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.091s)
[489.095305] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[489.185907] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.100s)
[489.196408] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[489.279039] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.090s)
[489.289665] Starting dynamic subtest: drm_test_damage_iter_damage
[489.370878] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.090s)
[489.379361] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[489.452768] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.081s)
[489.462382] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[489.536417] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.083s)
[489.544914] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[489.633044] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.095s)
[489.643012] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[489.720530] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.088s)
[489.722520] Subtest drm_damage_helper: SUCCESS (1.968s)
[489.888585] [076/133] (530s left) syncobj_timeline (wait-zero-handles)
[489.945012] Starting subtest: wait-zero-handles
[489.947001] Subtest wait-zero-handles: SUCCESS (0.000s)
[490.042652] [077/133] (530s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[490.109746] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[496.824311] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.715s)
[496.924845] [078/133] (524s left) kms_lease (lease-invalid-connector)
[497.007061] Starting subtest: lease-invalid-connector
[497.009468] Starting dynamic subtest: pipe-A-eDP-1
[497.012131] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[497.025455] Starting dynamic subtest: pipe-B-eDP-1
[497.027429] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[497.037184] Starting dynamic subtest: pipe-C-eDP-1
[497.039432] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[497.049029] Starting dynamic subtest: pipe-D-eDP-1
[497.051273] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[497.053506] Subtest lease-invalid-connector: SUCCESS (0.004s)
[497.091090] [079/133] (523s left) gem_exec_params (no-blt)
[497.148977] Starting subtest: no-blt
[497.153875] Subtest no-blt: SUCCESS (0.004s)
[497.264551] [080/133] (523s left) i915_pm_rpm (debugfs-forcewake-user)
[499.072220] Starting subtest: debugfs-forcewake-user
[510.461356] Subtest debugfs-forcewake-user: SUCCESS (11.392s)
[510.832624] [081/133] (510s left) kms_big_fb (linear-32bpp-rotate-180)
[510.915516] Starting subtest: linear-32bpp-rotate-180
[512.360235] Subtest linear-32bpp-rotate-180: SUCCESS (1.445s)
[512.496186] [082/133] (508s left) gem_workarounds (reset)
[512.562234] Starting subtest: reset
[512.738924] Subtest reset: SUCCESS (0.177s)
[512.876641] [083/133] (508s left) syncobj_timeline (reset-unsignaled)
[512.928720] Starting subtest: reset-unsignaled
[512.930610] Subtest reset-unsignaled: SUCCESS (0.000s)
[513.024230] [084/133] (508s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[513.101682] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[513.105364] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[513.202202] [085/133] (508s left) prime_self_import (basic-llseek-size)
[513.234963] Starting subtest: basic-llseek-size
[513.261691] Subtest basic-llseek-size: SUCCESS (0.030s)
[513.372473] [086/133] (507s left) gem_exec_schedule (preempt-other)
[513.449059] Starting subtest: preempt-other
[513.450966] Starting dynamic subtest: rcs0
[513.517304] Dynamic subtest rcs0: SUCCESS (0.072s)
[513.530631] Starting dynamic subtest: bcs0
[513.582194] Dynamic subtest bcs0: SUCCESS (0.064s)
[513.595025] Starting dynamic subtest: vcs0
[513.649024] Dynamic subtest vcs0: SUCCESS (0.066s)
[513.662416] Starting dynamic subtest: vcs1
[513.713973] Dynamic subtest vcs1: SUCCESS (0.064s)
[513.725011] Starting dynamic subtest: vecs0
[513.778363] Dynamic subtest vecs0: SUCCESS (0.064s)
[513.789340] Starting dynamic subtest: ccs0
[513.846265] Dynamic subtest ccs0: SUCCESS (0.067s)
[513.848435] Subtest preempt-other: SUCCESS (0.402s)
[514.965415] [087/133] (506s left) gem_pxp (create-protected-buffer)
[515.077239] Starting subtest: create-protected-buffer
[515.079684] Subtest create-protected-buffer: SUCCESS (0.000s)
[515.200140] [088/133] (506s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[515.273303] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[515.277707] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[515.373385] [089/133] (506s left) gem_mmap_wc (set-cache-level)
[515.428769] Subtest set-cache-level: SKIP (0.000s)
[515.489381] [090/133] (505s left) kms_busy (extended-pageflip-hang-oldfb)
[515.557636] Starting subtest: extended-pageflip-hang-oldfb
[515.559801] Starting dynamic subtest: pipe-A
[515.954273] Dynamic subtest pipe-A: SUCCESS (0.396s)
[515.965131] Starting dynamic subtest: pipe-D
[517.062803] Dynamic subtest pipe-D: SUCCESS (1.105s)
[517.065065] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.505s)
[517.909769] [091/133] (503s left) kms_psr (psr-cursor-mmap-gtt)
[517.989337] Starting subtest: psr-cursor-mmap-gtt
[517.991569] Starting dynamic subtest: eDP-1
[519.702402] Dynamic subtest eDP-1: SUCCESS (1.711s)
[519.704666] Subtest psr-cursor-mmap-gtt: SUCCESS (1.712s)
[520.565053] [092/133] (500s left) kms_async_flips (test-time-stamp)
[520.644593] Starting subtest: test-time-stamp
[521.027258] Starting dynamic subtest: pipe-A-eDP-1
[521.789377] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.761s)
[522.175507] Starting dynamic subtest: pipe-B-eDP-1
[522.923399] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.753s)
[523.307737] Starting dynamic subtest: pipe-C-eDP-1
[524.063047] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.761s)
[524.435909] Starting dynamic subtest: pipe-D-eDP-1
[525.195223] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.766s)
[525.197667] Subtest test-time-stamp: SUCCESS (4.549s)
[526.360281] [093/133] (495s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[526.723521] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[527.564576] [094/133] (494s left) gem_close_race (multigpu-basic-threads)
[527.628007] Starting subtest: multigpu-basic-threads
[527.632398] Subtest multigpu-basic-threads: SKIP (0.000s)
[527.851355] [095/133] (493s left) prime_mmap (test_correct_cpu_write)
[527.913621] Starting subtest: test_correct_cpu_write
[527.915789] Starting dynamic subtest: test_correct_cpu_write-smem
[527.917655] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[527.919577] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[528.014833] [096/133] (493s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[528.094741] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[528.097128] Starting dynamic subtest: pipe-A-eDP-1
[528.174176] Dynamic subtest pipe-A-eDP-1: SKIP (0.080s)
[528.185505] Starting dynamic subtest: pipe-B-eDP-1
[529.258468] Dynamic subtest pipe-B-eDP-1: SKIP (1.081s)
[529.262604] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.164s)
[530.452468] [097/133] (491s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[530.511890] Starting subtest: etime-single-wait-for-submit-submitted
[530.619567] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.108s)
[530.700739] [098/133] (491s left) perf (non-zero-reason)
[530.859799] Starting subtest: non-zero-reason
[530.862073] Starting dynamic subtest: 0-rcs0
[536.189091] Dynamic subtest 0-rcs0: SUCCESS (5.328s)
[536.203295] Starting dynamic subtest: 1-vcs1
[540.064445] Dynamic subtest 1-vcs1: SUCCESS (3.873s)
[540.067516] Subtest non-zero-reason: SUCCESS (9.204s)
[540.116023] [099/133] (481s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[540.202508] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[540.210062] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.008s)
[540.323512] [100/133] (481s left) gem_fence_thrash (bo-write-verify-y)
[540.355713] Starting subtest: bo-write-verify-y
[540.373150] Subtest bo-write-verify-y: SKIP (0.016s)
[540.433753] [101/133] (481s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[540.522955] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[540.527042] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[540.624461] [102/133] (481s left) prime_vgem (busy)
[540.702495] Starting subtest: busy
[540.704610] Starting dynamic subtest: rcs0
[540.772165] Dynamic subtest rcs0: SUCCESS (0.072s)
[540.783055] Starting dynamic subtest: bcs0
[540.829183] Dynamic subtest bcs0: SUCCESS (0.056s)
[540.839260] Starting dynamic subtest: vcs0
[540.879006] Dynamic subtest vcs0: SUCCESS (0.049s)
[540.889207] Starting dynamic subtest: vcs1
[540.924871] Dynamic subtest vcs1: SUCCESS (0.045s)
[540.935132] Starting dynamic subtest: vecs0
[540.968806] Dynamic subtest vecs0: SUCCESS (0.043s)
[540.979070] Starting dynamic subtest: ccs0
[541.017379] Dynamic subtest ccs0: SUCCESS (0.048s)
[541.019570] Subtest busy: SUCCESS (0.318s)
[541.156849] [103/133] (480s left) gem_eio (in-flight-suspend)
[541.387682] Starting subtest: in-flight-suspend
[584.260312] Subtest in-flight-suspend: SUCCESS (13.564s)
[584.390372] [104/133] (437s left) kms_vblank (wait-forked-busy)
[584.489038] Starting subtest: wait-forked-busy
[584.491507] Starting dynamic subtest: pipe-A-eDP-1
[586.447972] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.878s)
[586.464013] Starting dynamic subtest: pipe-D-eDP-1
[589.039837] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.514s)
[589.042208] Subtest wait-forked-busy: SUCCESS (4.396s)
[589.857931] [105/133] (432s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[589.934019] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[589.938614] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[590.008226] [106/133] (432s left) gem_exec_reloc (basic-wc-active)
[590.065300] Subtest basic-wc-active: SKIP (0.000s)
[590.151181] [107/133] (431s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[590.246199] Starting subtest: y-tiled-64bpp-rotate-180
[590.250588] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[590.365221] [108/133] (431s left) i915_query (query-topology-known-pci-ids)
[590.407040] Starting subtest: query-topology-known-pci-ids
[590.411565] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[590.510522] [109/133] (431s left) kms_cdclk (plane-scaling)
[590.576858] Starting subtest: plane-scaling
[590.579117] Starting dynamic subtest: pipe-A-eDP-1
[590.870728] Dynamic subtest pipe-A-eDP-1: SKIP (0.287s)
[590.882087] Starting dynamic subtest: pipe-B-eDP-1
[590.886559] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[590.896217] Starting dynamic subtest: pipe-C-eDP-1
[590.900710] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[590.910536] Starting dynamic subtest: pipe-D-eDP-1
[590.914949] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[590.919258] Subtest plane-scaling: SKIP (0.295s)
[591.733388] [110/133] (430s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[591.826218] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[591.830670] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[591.927450] [111/133] (430s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[592.011135] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[592.013435] Starting dynamic subtest: pipe-A-default-mode
[593.220432] Dynamic subtest pipe-A-default-mode: SKIP (1.186s)
[593.224915] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.188s)
[593.385657] [112/133] (428s left) gem_userptr_blits (access-control)
[593.478782] Starting subtest: access-control
[593.483388] Subtest access-control: SKIP (0.000s)
[593.595737] [113/133] (428s left) perf_pmu (busy-idle-no-semaphores)
[593.637903] Starting subtest: busy-idle-no-semaphores
[593.640525] Starting dynamic subtest: rcs0
[594.301065] Dynamic subtest rcs0: SUCCESS (0.652s)
[594.314349] Starting dynamic subtest: bcs0
[594.961041] Dynamic subtest bcs0: SUCCESS (0.649s)
[594.973866] Starting dynamic subtest: vcs0
[595.623058] Dynamic subtest vcs0: SUCCESS (0.652s)
[595.635852] Starting dynamic subtest: vcs1
[596.773317] Dynamic subtest vcs1: SUCCESS (1.136s)
[596.786368] Starting dynamic subtest: vecs0
[598.822465] Dynamic subtest vecs0: SUCCESS (2.029s)
[598.836053] Starting dynamic subtest: ccs0
[600.804372] Dynamic subtest ccs0: SUCCESS (1.966s)
[600.806990] Subtest busy-idle-no-semaphores: SUCCESS (7.101s)
[600.923445] [114/133] (421s left) gem_ctx_freq (sysfs)
[600.989029] Starting subtest: sysfs
[600.991410] Starting dynamic subtest: gt0
[606.528154] Dynamic subtest gt0: SUCCESS (5.515s)
[606.541574] Starting dynamic subtest: gt1
[648.183202] Dynamic subtest gt1: SUCCESS (41.625s)
[648.186512] Subtest sysfs: SUCCESS (47.143s)
[648.323449] [115/133] (374s left) dumb_buffer (create-valid-dumb)
[648.386620] Starting subtest: create-valid-dumb
[648.388750] Subtest create-valid-dumb: SUCCESS (0.000s)
[648.508933] [116/133] (374s left) gem_media_fill (media-fill)
[648.571426] Subtest media-fill: SKIP (0.000s)
[648.714045] [117/133] (373s left) gem_exec_nop (basic-parallel)
[648.795656] Starting subtest: basic-parallel
[665.144126] Subtest basic-parallel: SUCCESS (16.350s)
[665.376950] [118/133] (357s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[665.434626] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[665.436802] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[665.532139] [119/133] (357s left) gem_partial_pwrite_pread (write-snoop)
[665.597063] Subtest write-snoop: SKIP (0.000s)
[665.667093] [120/133] (357s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[665.739475] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[665.743543] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[665.838691] [121/133] (356s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[665.910571] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[666.769047] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.859s)
[666.936316] [122/133] (355s left) gem_render_copy (x-tiled)
[666.989265] Starting subtest: x-tiled
[666.991543] Starting dynamic subtest: smem
[667.035986] Dynamic subtest smem: SUCCESS (0.046s)
[667.038552] Subtest x-tiled: SUCCESS (0.047s)
[667.278179] [123/133] (355s left) gem_exec_reloc (basic-wc-read-active)
[667.342169] Subtest basic-wc-read-active: SKIP (0.000s)
[667.432511] [124/133] (355s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[667.531076] Starting subtest: basic-flip-before-cursor-varying-size
[668.476957] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.947s)
[669.354691] [125/133] (353s left) gem_tiled_wb
[669.480561] [126/133] (353s left) gem_exec_balancer (invalid-bonds)
[669.544037] Starting subtest: invalid-bonds
[669.548492] Subtest invalid-bonds: SKIP (0.000s)
[669.844187] [127/133] (353s left) api_intel_allocator (execbuf-with-allocator)
[669.904801] Starting subtest: execbuf-with-allocator
[669.910112] Subtest execbuf-with-allocator: SUCCESS (0.006s)
[670.054695] [128/133] (353s left) gem_exec_fence (basic-busy-all)
[670.106929] Starting subtest: basic-busy-all
[670.191630] Subtest basic-busy-all: SUCCESS (0.085s)
[672.262244] [129/133] (350s left) gem_exec_reloc (basic-cpu-read-noreloc)
[672.313179] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[672.377219] [130/133] (350s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[672.460337] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[679.131094] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.672s)
[679.264817] [131/133] (343s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[679.355950] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[679.360468] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[679.453181] [132/133] (343s left) i915_pciid
[679.623375] [133/133] (343s left) i915_drm_fdinfo (memory-info-resident)
[679.666491] Starting subtest: memory-info-resident
[679.668430] Starting dynamic subtest: smem0
[682.171488] Dynamic subtest smem0: SUCCESS (2.508s)
[682.173535] Subtest memory-info-resident: SUCCESS (2.510s)
[682.249244] 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.