[62.597269] Initializing watchdogs
[62.597313]   /dev/watchdog0
[62.612200] [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]
[62.616662] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[62.618947] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.621070] [001/133] (960s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[62.722087] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[62.723797] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[62.784906] [002/133] (960s left) kms_psr (fbc-pr-cursor-render)
[62.869103] Starting subtest: fbc-pr-cursor-render
[62.871066] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[62.937921] [003/133] (960s left) gem_ccs (block-copy-compressed)
[62.991648] Starting subtest: block-copy-compressed
[62.993345] Subtest block-copy-compressed: SKIP (0.000s)
[63.098233] [004/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[63.186250] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[63.187947] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[63.273463] [005/133] (959s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[63.363594] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[64.200286] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.836s)
[64.371952] [006/133] (958s left) kms_joiner (basic-ultra-joiner)
[64.467872] Starting subtest: basic-ultra-joiner
[64.469743] Subtest basic-ultra-joiner: SKIP (0.000s)
[64.538386] [007/133] (958s left) kms_dsc (dsc-with-output-formats-with-bpc)
[64.631454] Starting subtest: dsc-with-output-formats-with-bpc
[64.654599] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s)
[64.694048] [008/133] (958s left) kms_chamelium_frames (dp-crc-single)
[65.079293] Subtest dp-crc-single: SKIP (0.000s)
[65.930151] [009/133] (957s left) kms_content_protection (dp-mst-type-1-suspend-resume)
[66.066250] Starting subtest: dp-mst-type-1-suspend-resume
[66.068049] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s)
[66.183926] [010/133] (957s left) kms_addfb_basic (basic)
[66.239011] Starting subtest: basic
[66.239870] Subtest basic: SUCCESS (0.000s)
[66.362255] [011/133] (957s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[66.465655] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[71.076068] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (4.610s)
[72.192573] [012/133] (951s left) gem_exec_fence (submit)
[72.375853] Starting subtest: submit
[72.377713] Subtest submit: SKIP (0.000s)
[74.017260] [FACT gem_exec_fence (submit)] new: kernel.kmod_is_loaded.vgem: true
[74.019171] [013/133] (949s left) gem_unfence_active_buffers
[74.154228] [014/133] (949s left) kms_cursor_edge_walk (256x256-right-edge)
[74.247330] Starting subtest: 256x256-right-edge
[74.248261] Starting dynamic subtest: pipe-A-eDP-1
[77.750472] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.502s)
[77.757412] Starting dynamic subtest: pipe-D-eDP-1
[80.875269] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.123s)
[80.876086] Subtest 256x256-right-edge: SUCCESS (6.627s)
[81.673034] [015/133] (941s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[81.779357] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[81.781113] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[81.872211] [016/133] (941s left) perf (gen12-invalid-class-instance)
[82.001478] Starting subtest: gen12-invalid-class-instance
[82.012092] Subtest gen12-invalid-class-instance: SUCCESS (0.010s)
[82.045530] [017/133] (941s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[82.137207] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[82.138953] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[82.226532] [018/133] (941s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[82.317079] Starting subtest: psr-rgb565-draw-mmap-gtt
[82.318909] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[82.398270] [019/133] (941s left) gem_flink_race (flink_name)
[82.436350] Starting subtest: flink_name
[87.878477] Subtest flink_name: SUCCESS (5.394s)
[87.956149] [020/133] (935s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[88.065194] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[88.066945] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[88.148162] [021/133] (935s left) gem_exec_balancer (parallel)
[88.413549] Starting subtest: parallel
[89.427602] Subtest parallel: SUCCESS (1.014s)
[89.913170] [022/133] (933s left) gem_ctx_param (invalid-size-get)
[89.964407] Starting subtest: invalid-size-get
[89.965387] Subtest invalid-size-get: SUCCESS (0.001s)
[90.054173] [023/133] (933s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[90.151246] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[96.983428] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.832s)
[97.101643] [024/133] (926s left) api_intel_allocator (reopen-fork)
[97.161772] Starting subtest: reopen-fork
[100.430714] Subtest reopen-fork: SUCCESS (3.260s)
[100.488823] [025/133] (923s left) kms_psr (psr-cursor-plane-onoff)
[100.589947] Starting subtest: psr-cursor-plane-onoff
[100.590869] Starting dynamic subtest: eDP-1
[102.300189] Dynamic subtest eDP-1: SUCCESS (1.710s)
[102.300969] Subtest psr-cursor-plane-onoff: SUCCESS (1.710s)
[103.173422] [026/133] (920s left) kms_addfb_basic (size-max)
[103.266112] Starting subtest: size-max
[103.267077] Subtest size-max: SUCCESS (0.000s)
[103.375962] [027/133] (920s left) gem_userptr_blits (dmabuf-sync)
[103.437414] Starting subtest: dmabuf-sync
[103.440238] Subtest dmabuf-sync: SKIP (0.002s)
[103.590626] [028/133] (920s left) syncobj_eventfd (invalid-bad-flags)
[103.639371] Starting subtest: invalid-bad-flags
[103.640888] Subtest invalid-bad-flags: SUCCESS (0.000s)
[103.732429] [029/133] (920s left) kms_plane_scaling (planes-downscale-factor-0-5)
[103.811132] Starting subtest: planes-downscale-factor-0-5
[103.812130] Starting dynamic subtest: pipe-A
[103.839436] Dynamic subtest pipe-A: SKIP (0.019s)
[103.847396] Starting dynamic subtest: pipe-B
[103.869604] Dynamic subtest pipe-B: SKIP (0.037s)
[103.876334] Starting dynamic subtest: pipe-C
[103.906310] Dynamic subtest pipe-C: SKIP (0.037s)
[103.915762] Starting dynamic subtest: pipe-D
[103.939226] Dynamic subtest pipe-D: SKIP (0.033s)
[103.940916] Subtest planes-downscale-factor-0-5: SKIP (0.128s)
[104.023915] [030/133] (920s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[104.112607] Starting subtest: fbc-psr-cursor-mmap-gtt
[104.113546] Starting dynamic subtest: eDP-1
[104.115444] Dynamic subtest eDP-1: SKIP (0.000s)
[104.117207] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[104.190938] [031/133] (919s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[104.250512] Starting subtest: y-tiled-to-vebox-x-tiled
[104.252247] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[104.428107] [032/133] (919s left) gem_exec_schedule (out-order)
[104.491224] Starting subtest: out-order
[104.492140] Starting dynamic subtest: rcs0
[104.603399] Dynamic subtest rcs0: SUCCESS (0.111s)
[104.611689] Starting dynamic subtest: vcs0
[104.697824] Dynamic subtest vcs0: SUCCESS (0.094s)
[104.707771] Starting dynamic subtest: vcs1
[104.786391] Dynamic subtest vcs1: SUCCESS (0.088s)
[104.795748] Starting dynamic subtest: vecs0
[104.862567] Dynamic subtest vecs0: SUCCESS (0.076s)
[104.872107] Starting dynamic subtest: ccs0
[104.948610] Dynamic subtest ccs0: SUCCESS (0.085s)
[104.949813] Subtest out-order: SUCCESS (0.457s)
[105.999590] [033/133] (918s left) vgem_basic (dmabuf-mmap)
[106.041080] Starting subtest: dmabuf-mmap
[106.050992] Subtest dmabuf-mmap: SUCCESS (0.011s)
[106.106669] [034/133] (918s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[106.197118] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[106.198827] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[106.281239] [035/133] (917s left) kms_hdr (static-swap)
[106.373138] Starting subtest: static-swap
[106.375721] Subtest static-swap: SKIP (0.000s)
[106.438594] [036/133] (917s left) gem_create (create-massive)
[106.494082] Starting subtest: create-massive
[106.494997] Subtest create-massive: SUCCESS (0.000s)
[106.675710] [037/133] (917s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[106.774669] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[106.776330] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[106.885529] [038/133] (917s left) kms_psr (fbc-psr2-primary-render)
[106.979541] Starting subtest: fbc-psr2-primary-render
[106.980483] Starting dynamic subtest: eDP-1
[106.982199] Dynamic subtest eDP-1: SKIP (0.000s)
[106.983890] Subtest fbc-psr2-primary-render: SKIP (0.000s)
[107.046136] [039/133] (917s left) kms_chamelium_hpd (hdmi-hpd-fast)
[107.430136] Subtest hdmi-hpd-fast: SKIP (0.000s)
[108.264840] [040/133] (916s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[108.314603] Starting subtest: multi-wait-all-for-submit-signaled
[108.315591] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[108.399090] [041/133] (915s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[108.485348] Starting subtest: pr-overlay-plane-move-continuous-sf
[108.487121] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[108.576977] [042/133] (915s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[108.670701] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[108.672697] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[108.771919] [043/133] (915s left) kms_cursor_crc (cursor-alpha-opaque)
[108.863938] Starting subtest: cursor-alpha-opaque
[108.864907] Starting dynamic subtest: pipe-A-eDP-1
[109.496255] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.631s)
[109.503852] Starting dynamic subtest: pipe-D-eDP-1
[110.773133] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.276s)
[110.773927] Subtest cursor-alpha-opaque: SUCCESS (1.910s)
[111.570046] [044/133] (912s left) kms_plane_multiple (2x-tiling-y)
[111.666657] Starting subtest: 2x-tiling-y
[111.668457] Subtest 2x-tiling-y: SKIP (0.000s)
[111.734736] [045/133] (912s left) gem_exec_params (invalid-bsd1-flag-on-render)
[111.792988] Starting subtest: invalid-bsd1-flag-on-render
[111.794030] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[111.878856] [046/133] (912s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[111.983407] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[111.985240] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[112.070580] [047/133] (912s left) gem_ctx_persistence (engines-cleanup)
[112.125136] Starting subtest: engines-cleanup
[112.126050] Starting dynamic subtest: rcs0
[112.188221] Dynamic subtest rcs0: SUCCESS (0.063s)
[112.196086] Starting dynamic subtest: bcs0
[112.204121] Dynamic subtest bcs0: SUCCESS (0.015s)
[112.210347] Starting dynamic subtest: vcs0
[112.256253] Dynamic subtest vcs0: SUCCESS (0.052s)
[112.265282] Starting dynamic subtest: vcs1
[112.301161] Dynamic subtest vcs1: SUCCESS (0.044s)
[112.309873] Starting dynamic subtest: vecs0
[112.344164] Dynamic subtest vecs0: SUCCESS (0.042s)
[112.353376] Starting dynamic subtest: ccs0
[112.391451] Dynamic subtest ccs0: SUCCESS (0.046s)
[112.392781] Subtest engines-cleanup: SUCCESS (0.267s)
[112.480083] [048/133] (912s left) drm_read (short-buffer-block)
[112.635417] Starting subtest: short-buffer-block
[112.636430] Subtest short-buffer-block: SUCCESS (0.000s)
[112.755485] [049/133] (911s left) kms_psr (pr-cursor-blt)
[112.856378] Starting subtest: pr-cursor-blt
[112.858203] Subtest pr-cursor-blt: SKIP (0.000s)
[112.923285] [050/133] (911s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[113.020335] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[113.033301] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.013s)
[113.108469] [051/133] (911s left) kms_vblank (query-busy-hang)
[113.193660] Starting subtest: query-busy-hang
[113.194670] Starting dynamic subtest: pipe-A-eDP-1
[139.675818] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.479s)
[139.684988] Starting dynamic subtest: pipe-D-eDP-1
[154.647154] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.968s)
[154.648119] Subtest query-busy-hang: SUCCESS (41.450s)
[155.496089] [052/133] (869s left) gem_exec_store (pages)
[155.553214] Starting subtest: pages
[155.554119] Starting dynamic subtest: rcs0
[155.632234] Dynamic subtest rcs0: SUCCESS (0.078s)
[155.641215] Starting dynamic subtest: bcs0
[155.709036] Dynamic subtest bcs0: SUCCESS (0.076s)
[155.717995] Starting dynamic subtest: vcs0
[155.791163] Dynamic subtest vcs0: SUCCESS (0.082s)
[155.798563] Starting dynamic subtest: vcs1
[155.856235] Dynamic subtest vcs1: SUCCESS (0.064s)
[155.863710] Starting dynamic subtest: vecs0
[155.921252] Dynamic subtest vecs0: SUCCESS (0.064s)
[155.929915] Starting dynamic subtest: ccs0
[155.987411] Dynamic subtest ccs0: SUCCESS (0.066s)
[155.988603] Subtest pages: SUCCESS (0.434s)
[156.169399] [053/133] (868s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[156.256127] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[156.257366] Starting dynamic subtest: pipe-A-eDP-1
[156.265732] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[156.272172] Starting dynamic subtest: pipe-B-eDP-1
[156.282398] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[156.289026] Starting dynamic subtest: pipe-C-eDP-1
[156.299333] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[156.305520] Starting dynamic subtest: pipe-D-eDP-1
[156.313546] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[156.315315] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[158.504492] [054/133] (866s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[158.602106] Starting subtest: compare-crc-sanitycheck-xr24
[158.603051] Starting dynamic subtest: pipe-A-eDP-1
[159.251353] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.648s)
[159.258314] Starting dynamic subtest: pipe-B-eDP-1
[160.516436] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.264s)
[160.523582] Starting dynamic subtest: pipe-C-eDP-1
[161.780999] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.263s)
[161.787837] Starting dynamic subtest: pipe-D-eDP-1
[163.006691] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.225s)
[163.007514] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.405s)
[163.839135] [055/133] (861s left) kms_atomic_transition (plane-toggle-modeset-transition)
[163.941298] Starting subtest: plane-toggle-modeset-transition
[163.942185] Starting dynamic subtest: pipe-A-eDP-1
[176.687292] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.745s)
[176.697290] Starting dynamic subtest: pipe-B-eDP-1
[189.116070] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.425s)
[189.117710] Subtest plane-toggle-modeset-transition: SUCCESS (25.176s)
[189.927382] [056/133] (835s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[189.977270] Starting subtest: single-wait-for-submit-available-signaled
[189.978280] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[190.065794] [057/133] (834s left) gem_spin_batch (resubmit)
[190.122680] Starting subtest: resubmit
[190.123700] Starting dynamic subtest: rcs0
[190.129271] Dynamic subtest rcs0: SUCCESS (0.006s)
[190.137572] Starting dynamic subtest: bcs0
[190.138469] Dynamic subtest bcs0: SUCCESS (0.002s)
[190.144827] Starting dynamic subtest: vcs0
[190.145707] Dynamic subtest vcs0: SUCCESS (0.002s)
[190.151794] Starting dynamic subtest: vcs1
[190.152672] Dynamic subtest vcs1: SUCCESS (0.002s)
[190.159065] Starting dynamic subtest: vecs0
[190.159905] Dynamic subtest vecs0: SUCCESS (0.003s)
[190.165914] Starting dynamic subtest: ccs0
[190.166773] Dynamic subtest ccs0: SUCCESS (0.003s)
[190.167687] Subtest resubmit: SUCCESS (0.021s)
[190.365421] [058/133] (834s left) gem_userptr_blits (map-fixed-invalidate-busy)
[190.431348] Starting subtest: map-fixed-invalidate-busy
[190.433161] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[190.541167] [059/133] (834s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[190.636981] Starting subtest: 4-tiled-32bpp-rotate-90
[190.656962] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.019s)
[190.753291] [060/133] (834s left) kms_psr (psr-primary-mmap-cpu)
[190.843424] Starting subtest: psr-primary-mmap-cpu
[190.844436] Starting dynamic subtest: eDP-1
[192.529111] Dynamic subtest eDP-1: SUCCESS (1.684s)
[192.529950] Subtest psr-primary-mmap-cpu: SUCCESS (1.685s)
[193.391484] [061/133] (831s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[193.457137] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[193.560483] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.103s)
[193.636112] [062/133] (831s left) perf_pmu (render-node-busy)
[193.708579] Starting subtest: render-node-busy
[193.709409] Starting dynamic subtest: rcs0
[194.297691] Dynamic subtest rcs0: SUCCESS (0.588s)
[194.308557] Starting dynamic subtest: bcs0
[194.853474] Dynamic subtest bcs0: SUCCESS (0.554s)
[194.864279] Starting dynamic subtest: vcs0
[196.893050] Dynamic subtest vcs0: SUCCESS (2.029s)
[196.901455] Starting dynamic subtest: vcs1
[198.876861] Dynamic subtest vcs1: SUCCESS (1.982s)
[198.886674] Starting dynamic subtest: vecs0
[200.924934] Dynamic subtest vecs0: SUCCESS (2.046s)
[200.934671] Starting dynamic subtest: ccs0
[201.477652] Dynamic subtest ccs0: SUCCESS (0.559s)
[201.478999] Subtest render-node-busy: SUCCESS (7.769s)
[201.548102] [063/133] (823s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[201.641193] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[201.642102] Starting dynamic subtest: pipe-A-eDP-1
[201.665224] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[201.672854] Starting dynamic subtest: pipe-B-eDP-1
[201.694566] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[201.702192] Starting dynamic subtest: pipe-C-eDP-1
[201.722096] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[201.729666] Starting dynamic subtest: pipe-D-eDP-1
[201.750577] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[201.752203] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.008s)
[203.954483] [064/133] (821s left) kms_async_flips (crc-atomic)
[204.054289] Starting subtest: crc-atomic
[204.427940] Starting dynamic subtest: pipe-A-eDP-1
[207.371583] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.943s)
[207.745126] Starting dynamic subtest: pipe-B-eDP-1
[210.701459] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.963s)
[211.077978] Starting dynamic subtest: pipe-C-eDP-1
[214.018650] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.947s)
[214.390421] Starting dynamic subtest: pipe-D-eDP-1
[217.252487] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.867s)
[217.253633] Subtest crc-atomic: SUCCESS (13.197s)
[218.405902] [065/133] (806s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[218.463383] Starting subtest: single-wait-for-submit-unsubmitted
[218.560741] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.104s)
[218.632067] [066/133] (806s left) syncobj_wait (signal)
[218.680608] Starting subtest: signal
[218.681511] Subtest signal: SUCCESS (0.000s)
[218.775074] [067/133] (806s left) i915_drm_fdinfo (idle)
[218.815434] Starting subtest: idle
[218.816354] Starting dynamic subtest: rcs0
[219.373677] Dynamic subtest rcs0: SUCCESS (0.557s)
[219.383200] Starting dynamic subtest: bcs0
[219.888099] Dynamic subtest bcs0: SUCCESS (0.503s)
[219.895248] Starting dynamic subtest: vcs0
[220.394079] Dynamic subtest vcs0: SUCCESS (0.504s)
[220.401534] Starting dynamic subtest: vcs1
[220.898982] Dynamic subtest vcs1: SUCCESS (0.503s)
[220.908498] Starting dynamic subtest: vecs0
[221.405108] Dynamic subtest vecs0: SUCCESS (0.503s)
[221.419720] Starting dynamic subtest: ccs0
[221.909930] Dynamic subtest ccs0: SUCCESS (0.504s)
[221.911259] Subtest idle: SUCCESS (3.086s)
[221.973346] [068/133] (803s left) kms_chamelium_audio (dp-audio)
[222.350870] Subtest dp-audio: SKIP (0.000s)
[223.121126] [069/133] (802s left) gem_userptr_blits (invalid-null-pointer)
[223.174873] Starting subtest: invalid-null-pointer
[223.175817] Subtest invalid-null-pointer: SUCCESS (0.001s)
[223.304121] [070/133] (802s left) kms_cursor_crc (cursor-random-128x128)
[223.511199] Starting subtest: cursor-random-128x128
[223.514418] Starting dynamic subtest: pipe-A-eDP-1
[226.840321] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.325s)
[226.869876] Starting dynamic subtest: pipe-D-eDP-1
[230.876419] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.013s)
[230.877380] Subtest cursor-random-128x128: SUCCESS (7.365s)
[231.722293] [071/133] (793s left) gem_exec_fence (basic-await)
[231.898953] Starting subtest: basic-await
[231.900471] Starting dynamic subtest: rcs0
[231.969201] Dynamic subtest rcs0: SUCCESS (0.077s)
[231.980674] Starting dynamic subtest: bcs0
[232.041775] Dynamic subtest bcs0: SUCCESS (0.071s)
[232.051594] Starting dynamic subtest: vcs0
[232.115434] Dynamic subtest vcs0: SUCCESS (0.072s)
[232.125878] Starting dynamic subtest: vcs1
[232.187764] Dynamic subtest vcs1: SUCCESS (0.071s)
[232.198599] Starting dynamic subtest: vecs0
[232.260762] Dynamic subtest vecs0: SUCCESS (0.072s)
[232.270769] Starting dynamic subtest: ccs0
[232.333682] Dynamic subtest ccs0: SUCCESS (0.072s)
[232.334888] Subtest basic-await: SUCCESS (0.443s)
[233.971876] [072/133] (791s left) i915_selftest (perf)
[237.226138] Starting subtest: perf
[237.227374] Starting dynamic subtest: engine_cs
[239.961240] Dynamic subtest engine_cs: SUCCESS (2.735s)
[239.968930] Starting dynamic subtest: request
[247.252901] Dynamic subtest request: SUCCESS (7.291s)
[247.261223] Starting dynamic subtest: migrate
[251.555543] Dynamic subtest migrate: SUCCESS (4.300s)
[251.564137] Starting dynamic subtest: region
[255.911065] Dynamic subtest region: SUCCESS (4.354s)
[255.912224] Subtest perf: SUCCESS (18.685s)
[255.932513] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[255.933244] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[255.934861] [073/133] (769s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[257.519918] Starting subtest: x-tiled-8bpp-rotate-270
[257.560334] Subtest x-tiled-8bpp-rotate-270: SKIP (0.040s)
[257.696770] [FACT kms_big_fb (x-tiled-8bpp-rotate-270)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[257.698195] [FACT kms_big_fb (x-tiled-8bpp-rotate-270)] new: kernel.kmod_is_loaded.i915: true
[257.700842] [074/133] (767s left) gem_exec_reloc (basic-write-gtt)
[257.761057] Subtest basic-write-gtt: SKIP (0.000s)
[257.813185] [075/133] (767s left) gem_exec_parallel (userptr)
[257.869406] Starting subtest: userptr
[257.870322] Starting dynamic subtest: rcs0
[259.306389] Dynamic subtest rcs0: SUCCESS (1.438s)
[259.315520] Starting dynamic subtest: bcs0
[260.772903] Dynamic subtest bcs0: SUCCESS (1.465s)
[260.781759] Starting dynamic subtest: vcs0
[262.878685] Dynamic subtest vcs0: SUCCESS (2.095s)
[262.888744] Starting dynamic subtest: vcs1
[264.861831] Dynamic subtest vcs1: SUCCESS (1.981s)
[264.870824] Starting dynamic subtest: vecs0
[266.910025] Dynamic subtest vecs0: SUCCESS (2.045s)
[266.918877] Starting dynamic subtest: ccs0
[268.386587] Dynamic subtest ccs0: SUCCESS (1.483s)
[268.389608] Subtest userptr: SUCCESS (10.519s)
[268.571968] [076/133] (757s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[268.660093] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[268.688920] Starting dynamic subtest: pipe-A-plane-0
[268.977687] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[268.984483] Starting dynamic subtest: pipe-A-plane-3
[269.210867] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[269.218114] Starting dynamic subtest: pipe-A-plane-5
[269.219791] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[270.329905] Starting dynamic subtest: pipe-B-plane-0
[270.623129] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[270.629825] Starting dynamic subtest: pipe-B-plane-3
[270.867667] Dynamic subtest pipe-B-plane-3: SUCCESS (0.244s)
[270.874632] Starting dynamic subtest: pipe-B-plane-5
[270.876364] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[271.193118] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.532s)
[272.004787] [077/133] (753s left) kms_flip (plain-flip-interruptible)
[272.094823] Starting subtest: plain-flip-interruptible
[272.096281] Starting dynamic subtest: A-eDP1
[273.716720] Dynamic subtest A-eDP1: SUCCESS (1.620s)
[273.726126] Starting dynamic subtest: B-eDP1
[275.343108] Dynamic subtest B-eDP1: SUCCESS (1.624s)
[275.353350] Starting dynamic subtest: C-eDP1
[276.957685] Dynamic subtest C-eDP1: SUCCESS (1.610s)
[276.964754] Starting dynamic subtest: D-eDP1
[278.586220] Dynamic subtest D-eDP1: SUCCESS (1.626s)
[278.589107] Subtest plain-flip-interruptible: SUCCESS (6.493s)
[279.756483] [078/133] (745s left) gen7_exec_parse (load-register-reg)
[279.802679] Subtest load-register-reg: SKIP (0.000s)
[279.864743] [079/133] (745s left) sw_sync (sync_merge_same)
[279.900206] Starting subtest: sync_merge_same
[279.901091] Subtest sync_merge_same: SUCCESS (0.000s)
[279.969484] [080/133] (745s left) i915_query (query-topology-unsupported)
[280.018805] Starting subtest: query-topology-unsupported
[280.020614] Subtest query-topology-unsupported: SKIP (0.000s)
[280.114735] [081/133] (745s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[280.204769] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[287.233223] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.028s)
[287.363481] [082/133] (738s left) perf (non-system-wide-paranoid)
[287.487643] Starting subtest: non-system-wide-paranoid
[287.513827] Subtest non-system-wide-paranoid: SUCCESS (0.027s)
[287.556393] [083/133] (738s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[287.646762] Starting subtest: fbc-rgb565-draw-mmap-gtt
[287.648493] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[287.730540] [084/133] (738s left) gem_pipe_control_store_loop (fresh-buffer)
[287.784203] Starting subtest: fresh-buffer
[289.945569] Subtest fresh-buffer: SUCCESS (2.152s)
[290.044397] [085/133] (735s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[290.132350] Starting subtest: bad-pixel-format-y-tiled-ccs
[290.133266] Starting dynamic subtest: pipe-A-eDP-1
[290.141623] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[290.149294] Starting dynamic subtest: pipe-B-eDP-1
[290.157678] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[290.164815] Starting dynamic subtest: pipe-C-eDP-1
[290.172599] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[290.178837] Starting dynamic subtest: pipe-D-eDP-1
[290.187055] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[290.188776] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.005s)
[292.468858] [086/133] (733s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[292.583987] Starting subtest: basic-flip-before-cursor-legacy
[293.498591] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.914s)
[294.312396] [087/133] (731s left) gem_lmem_swapping (basic)
[294.356549] Subtest basic: SKIP (0.000s)
[294.410946] [088/133] (731s left) gem_caching (reads)
[294.470259] Subtest reads: SKIP (0.000s)
[294.534474] [089/133] (731s left) kms_big_fb (y-tiled-addfb-size-overflow)
[294.626692] Starting subtest: y-tiled-addfb-size-overflow
[294.628390] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[294.715292] [090/133] (731s left) gem_flink_basic (bad-flink)
[294.770167] Starting subtest: bad-flink
[294.771104] Subtest bad-flink: SUCCESS (0.000s)
[294.878406] [091/133] (731s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[294.994265] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[302.324013] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.330s)
[302.468986] [092/133] (723s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[302.562338] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[302.564245] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[302.653680] [093/133] (723s left) kms_flip (2x-dpms-vs-vblank-race)
[302.734126] Starting subtest: 2x-dpms-vs-vblank-race
[302.744720] Subtest 2x-dpms-vs-vblank-race: SKIP (0.011s)
[302.819497] [094/133] (723s left) gem_mmap_gtt (ptrace)
[302.860984] Subtest ptrace: SKIP (0.000s)
[302.916009] [095/133] (723s left) i915_drm_fdinfo (virtual-busy-idle)
[302.951229] Starting subtest: virtual-busy-idle
[302.953638] Subtest virtual-busy-idle: SKIP (0.000s)
[303.008203] [096/133] (723s left) kms_prop_blob (invalid-set-prop)
[303.056030] Starting subtest: invalid-set-prop
[303.056865] Subtest invalid-set-prop: SUCCESS (0.000s)
[303.159062] [097/133] (723s left) gem_ctx_persistence (userptr)
[303.218276] Starting subtest: userptr
[303.402205] Subtest userptr: SUCCESS (0.184s)
[303.477457] [098/133] (722s left) syncobj_eventfd (binary-wait)
[303.529328] Starting subtest: binary-wait
[303.539889] Subtest binary-wait: SUCCESS (0.011s)
[303.633357] [099/133] (722s left) gem_pxp (create-valid-protected-context)
[303.755607] Starting subtest: create-valid-protected-context
[303.756674] Subtest create-valid-protected-context: SUCCESS (0.002s)
[303.870514] [100/133] (722s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[303.922272] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[303.993864] [101/133] (722s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[304.087035] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[304.088696] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[304.183264] [102/133] (722s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[304.267483] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[304.268368] Starting dynamic subtest: pipe-A-default-mode
[306.990345] Dynamic subtest pipe-A-default-mode: SUCCESS (2.721s)
[306.991249] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.723s)
[307.813960] [103/133] (718s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[307.901355] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[314.727766] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.827s)
[314.835883] [104/133] (711s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[314.927997] Starting subtest: yf-tiled-32bpp-rotate-0
[314.929991] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[315.015345] [105/133] (711s left) kms_cursor_legacy (single-move)
[315.130699] Starting subtest: single-move
[315.131632] Starting dynamic subtest: pipe-A
[320.559052] Dynamic subtest pipe-A: SUCCESS (5.380s)
[320.568886] Starting dynamic subtest: pipe-B
[325.941920] Dynamic subtest pipe-B: SUCCESS (5.380s)
[325.951421] Starting dynamic subtest: pipe-C
[331.279324] Dynamic subtest pipe-C: SUCCESS (5.379s)
[331.288915] Starting dynamic subtest: pipe-D
[336.694239] Dynamic subtest pipe-D: SUCCESS (5.379s)
[336.703301] Starting dynamic subtest: all-pipes
[342.094776] Dynamic subtest all-pipes: SUCCESS (5.386s)
[342.095915] Subtest single-move: SUCCESS (26.918s)
[342.189674] [106/133] (684s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[342.280096] Starting subtest: addfb25-y-tiled-legacy
[342.280889] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[342.371627] [107/133] (684s left) dmabuf_sync_file (import-multiple-read-write)
[342.418168] Starting subtest: import-multiple-read-write
[342.421249] Subtest import-multiple-read-write: SUCCESS (0.003s)
[342.472382] [108/133] (684s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[342.526367] Starting subtest: multi-wait-all-available-submitted-signaled
[342.527327] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s)
[342.646965] [109/133] (684s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[342.726401] Starting subtest: primary-x-tiled-reflect-x-180
[349.773919] Subtest primary-x-tiled-reflect-x-180: SUCCESS (7.049s)
[351.000738] [110/133] (675s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[351.113612] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[351.115207] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[351.212254] [111/133] (675s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[351.301917] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[356.338435] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (5.037s)
[357.508709] [112/133] (669s left) kms_lease (lease-unleased-crtc)
[357.603654] Starting subtest: lease-unleased-crtc
[357.604585] Starting dynamic subtest: pipe-A-eDP-1
[357.901747] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.297s)
[357.913712] Starting dynamic subtest: pipe-B-eDP-1
[358.652201] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.748s)
[358.661091] Starting dynamic subtest: pipe-C-eDP-1
[358.661848] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[358.668861] Starting dynamic subtest: pipe-D-eDP-1
[358.669735] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[358.670476] Subtest lease-unleased-crtc: SUCCESS (1.060s)
[359.011364] [113/133] (667s left) i915_pm_rpm (reg-read-ioctl)
[361.038384] Starting subtest: reg-read-ioctl
[363.329845] Subtest reg-read-ioctl: SUCCESS (2.293s)
[363.703800] [114/133] (663s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[363.801600] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[363.802754] Starting dynamic subtest: pipe-A-eDP-1
[380.170259] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.918s)
[380.179039] Starting dynamic subtest: pipe-B-eDP-1
[398.144879] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.817s)
[398.155061] Starting dynamic subtest: pipe-C-eDP-1
[416.098959] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.789s)
[416.108189] Starting dynamic subtest: pipe-D-eDP-1
[434.074103] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.708s)
[434.074952] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (10.238s)
[441.299400] [115/133] (591s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[441.422032] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[448.569922] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.128s)
[448.671883] [116/133] (584s left) kms_pm_dc (dc6-psr)
[449.760247] Starting subtest: dc6-psr
[452.746474] Subtest dc6-psr: SUCCESS (2.981s)
[453.541119] [117/133] (579s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[453.628682] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[453.629646] Starting dynamic subtest: pipe-A-default-mode
[454.808990] Dynamic subtest pipe-A-default-mode: SKIP (1.177s)
[454.810868] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.178s)
[454.949048] [118/133] (578s left) kms_prime (basic-crc-hybrid)
[455.037267] Subtest basic-crc-hybrid: SKIP (0.000s)
[455.140650] [119/133] (577s left) gem_wait (await)
[455.201720] Starting subtest: await
[455.202840] Starting dynamic subtest: all-engines
[456.302377] Dynamic subtest all-engines: SUCCESS (1.099s)
[456.312538] Starting dynamic subtest: rcs0
[457.364255] Dynamic subtest rcs0: SUCCESS (1.059s)
[457.381800] Starting dynamic subtest: bcs0
[458.425405] Dynamic subtest bcs0: SUCCESS (1.058s)
[458.443673] Starting dynamic subtest: vcs0
[459.482852] Dynamic subtest vcs0: SUCCESS (1.054s)
[459.501188] Starting dynamic subtest: vcs1
[460.536992] Dynamic subtest vcs1: SUCCESS (1.052s)
[460.553439] Starting dynamic subtest: vecs0
[461.592195] Dynamic subtest vecs0: SUCCESS (1.052s)
[461.609731] Starting dynamic subtest: ccs0
[462.651289] Dynamic subtest ccs0: SUCCESS (1.056s)
[462.654404] Subtest await: SUCCESS (7.444s)
[462.848303] [120/133] (570s left) gem_exec_alignment (many)
[462.904435] Starting subtest: many
[488.009925] Subtest many: SUCCESS (25.091s)
[489.840151] [121/133] (543s left) sysfs_heartbeat_interval (invalid)
[489.948155] Starting subtest: invalid
[489.949174] Starting dynamic subtest: vecs0
[489.950134] Dynamic subtest vecs0: SUCCESS (0.000s)
[489.959362] Starting dynamic subtest: ccs0
[489.960182] Dynamic subtest ccs0: SUCCESS (0.000s)
[489.967821] Starting dynamic subtest: vcs0
[489.968688] Dynamic subtest vcs0: SUCCESS (0.000s)
[489.976599] Starting dynamic subtest: bcs0
[489.977488] Dynamic subtest bcs0: SUCCESS (0.000s)
[489.985709] Starting dynamic subtest: rcs0
[489.986568] Dynamic subtest rcs0: SUCCESS (0.000s)
[489.994098] Starting dynamic subtest: vcs1
[489.995091] Dynamic subtest vcs1: SUCCESS (0.000s)
[489.996150] Subtest invalid: SUCCESS (0.005s)
[490.050462] [122/133] (543s left) gem_media_fill (media-fill)
[490.110107] Subtest media-fill: SKIP (0.000s)
[490.213292] [123/133] (543s left) gem_exec_fence (basic-wait-all)
[490.270528] Starting subtest: basic-wait-all
[490.358383] Subtest basic-wait-all: SUCCESS (0.087s)
[492.008296] [124/133] (541s left) gem_softpin (softpin)
[492.059097] Starting subtest: softpin
[524.446795] Subtest softpin: SUCCESS (32.368s)
[524.557092] [125/133] (508s left) api_intel_bb (intel-bb-blit-y)
[524.604837] Starting subtest: intel-bb-blit-y
[528.178039] Subtest intel-bb-blit-y: SUCCESS (3.563s)
[528.275864] [126/133] (505s left) kms_color (ctm-0-50)
[528.369511] Starting subtest: ctm-0-50
[528.370349] Starting dynamic subtest: pipe-A-eDP-1
[531.910521] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.540s)
[531.919041] Starting dynamic subtest: pipe-B-eDP-1
[536.112180] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.200s)
[536.120309] Starting dynamic subtest: pipe-C-eDP-1
[540.182733] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.071s)
[540.191201] Starting dynamic subtest: pipe-D-eDP-1
[544.152009] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.969s)
[544.152884] Subtest ctm-0-50: SUCCESS (15.783s)
[544.983426] [127/133] (488s left) gem_render_copy (yf-tiled)
[545.044333] Starting subtest: yf-tiled
[545.046127] Subtest yf-tiled: SKIP (0.000s)
[545.232353] [128/133] (488s left) gem_mmap_gtt (medium-copy-odd)
[545.293085] Subtest medium-copy-odd: SKIP (0.000s)
[545.351167] [129/133] (488s left) gem_ctx_param (set-priority-range)
[545.403769] Starting subtest: set-priority-range
[545.418947] Subtest set-priority-range: SUCCESS (0.015s)
[545.521896] [130/133] (487s left) gem_exec_schedule (u-fairslice-all)
[545.592124] Starting subtest: u-fairslice-all
[547.653419] Subtest u-fairslice-all: SUCCESS (2.059s)
[548.966499] [131/133] (484s left) i915_query (query-topology-coherent-slice-mask)
[549.034146] Starting subtest: query-topology-coherent-slice-mask
[549.036216] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[549.126366] [132/133] (484s left) kms_flip (2x-blocking-absolute-wf_vblank)
[549.229229] Starting subtest: 2x-blocking-absolute-wf_vblank
[549.240379] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.011s)
[549.315625] [133/133] (484s left) kms_vblank (wait-forked-busy)
[549.398503] Starting subtest: wait-forked-busy
[549.399400] Starting dynamic subtest: pipe-A-eDP-1
[551.293004] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.894s)
[551.304152] Starting dynamic subtest: pipe-D-eDP-1
[553.842171] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.545s)
[553.843339] Subtest wait-forked-busy: SUCCESS (4.445s)
[554.633348] Closing watchdogs
results: parsing output: 0/ for test: kms_plane
results: parsing output: 1/ for test: kms_psr
results: parsing output: 2/ for test: gem_ccs
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: kms_joiner
results: parsing output: 6/ for test: kms_dsc
results: parsing output: 7/ for test: kms_chamelium_frames
results: parsing output: 8/ for test: kms_content_protection
results: parsing output: 9/ for test: kms_addfb_basic
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_exec_fence
results: parsing output: 12/ for test: gem_unfence_active_buffers
results: parsing output: 13/ for test: kms_cursor_edge_walk
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: perf
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: gem_flink_race
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: gem_exec_balancer
results: parsing output: 21/ for test: gem_ctx_param
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: api_intel_allocator
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: kms_addfb_basic
results: parsing output: 26/ for test: gem_userptr_blits
results: parsing output: 27/ for test: syncobj_eventfd
results: parsing output: 28/ for test: kms_plane_scaling
results: parsing output: 29/ for test: kms_psr
results: parsing output: 30/ for test: gem_render_copy
results: parsing output: 31/ for test: gem_exec_schedule
results: parsing output: 32/ for test: vgem_basic
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_hdr
results: parsing output: 35/ for test: gem_create
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_psr
results: parsing output: 38/ for test: kms_chamelium_hpd
results: parsing output: 39/ for test: syncobj_timeline
results: parsing output: 40/ for test: kms_psr2_sf
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_cursor_crc
results: parsing output: 43/ for test: kms_plane_multiple
results: parsing output: 44/ for test: gem_exec_params
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: gem_ctx_persistence
results: parsing output: 47/ for test: drm_read
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: kms_flip
results: parsing output: 50/ for test: kms_vblank
results: parsing output: 51/ for test: gem_exec_store
results: parsing output: 52/ for test: kms_ccs
results: parsing output: 53/ for test: kms_pipe_crc_basic
results: parsing output: 54/ for test: kms_atomic_transition
results: parsing output: 55/ for test: syncobj_timeline
results: parsing output: 56/ for test: gem_spin_batch
results: parsing output: 57/ for test: gem_userptr_blits
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: perf_pmu
results: parsing output: 62/ for test: kms_ccs
results: parsing output: 63/ for test: kms_async_flips
results: parsing output: 64/ for test: syncobj_wait
results: parsing output: 65/ for test: syncobj_wait
results: parsing output: 66/ for test: i915_drm_fdinfo
results: parsing output: 67/ for test: kms_chamelium_audio
results: parsing output: 68/ for test: gem_userptr_blits
results: parsing output: 69/ for test: kms_cursor_crc
results: parsing output: 70/ for test: gem_exec_fence
results: parsing output: 71/ for test: i915_selftest
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: gem_exec_reloc
results: parsing output: 74/ for test: gem_exec_parallel
results: parsing output: 75/ for test: kms_plane
results: parsing output: 76/ for test: kms_flip
results: parsing output: 77/ for test: gen7_exec_parse
results: parsing output: 78/ for test: sw_sync
results: parsing output: 79/ for test: i915_query
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: perf
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: gem_pipe_control_store_loop
results: parsing output: 84/ for test: kms_ccs
results: parsing output: 85/ for test: kms_cursor_legacy
results: parsing output: 86/ for test: gem_lmem_swapping
results: parsing output: 87/ for test: gem_caching
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: gem_flink_basic
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: kms_flip
results: parsing output: 93/ for test: gem_mmap_gtt
results: parsing output: 94/ for test: i915_drm_fdinfo
results: parsing output: 95/ for test: kms_prop_blob
results: parsing output: 96/ for test: gem_ctx_persistence
results: parsing output: 97/ for test: syncobj_eventfd
results: parsing output: 98/ for test: gem_pxp
results: parsing output: 99/ for test: gem_exec_reloc
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_flip_scaled_crc
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: kms_cursor_legacy
results: parsing output: 105/ for test: kms_addfb_basic
results: parsing output: 106/ for test: dmabuf_sync_file
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: kms_rotation_crc
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_lease
results: parsing output: 112/ for test: i915_pm_rpm
results: parsing output: 113/ for test: kms_ccs
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_pm_dc
results: parsing output: 116/ for test: kms_flip_scaled_crc
results: parsing output: 117/ for test: kms_prime
results: parsing output: 118/ for test: gem_wait
results: parsing output: 119/ for test: gem_exec_alignment
results: parsing output: 120/ for test: sysfs_heartbeat_interval
results: parsing output: 121/ for test: gem_media_fill
results: parsing output: 122/ for test: gem_exec_fence
results: parsing output: 123/ for test: gem_softpin
results: parsing output: 124/ for test: api_intel_bb
results: parsing output: 125/ for test: kms_color
results: parsing output: 126/ for test: gem_render_copy
results: parsing output: 127/ for test: gem_mmap_gtt
results: parsing output: 128/ for test: gem_ctx_param
results: parsing output: 129/ for test: gem_exec_schedule
results: parsing output: 130/ for test: i915_query
results: parsing output: 131/ for test: kms_flip
results: parsing output: 132/ for test: kms_vblank
Done.