[61.894200] Initializing watchdogs
[61.894245]   /dev/watchdog0
[61.918616] [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]
[61.922816] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.925161] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.928458] [001/133] (960s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[62.073611] Starting subtest: flip-vs-cursor-atomic
[69.146454] Subtest flip-vs-cursor-atomic: SUCCESS (7.096s)
[70.006389] [002/133] (952s left) gem_pwrite (basic-self)
[70.066764] Subtest basic-self: SKIP (0.000s)
[70.125881] [003/133] (952s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[70.228389] Starting subtest: fbc-pr-sprite-mmap-gtt
[70.232855] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[70.308486] [004/133] (952s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[70.406278] Starting subtest: psr-rgb101010-draw-render
[77.718498] Subtest psr-rgb101010-draw-render: SUCCESS (7.324s)
[77.858197] [005/133] (944s left) i915_pm_rc6_residency (rc6-accuracy)
[77.914721] Starting subtest: rc6-accuracy
[77.917052] Starting dynamic subtest: gt0
[81.088323] Dynamic subtest gt0: SUCCESS (3.168s)
[81.097721] Starting dynamic subtest: gt1
[84.259803] Dynamic subtest gt1: SUCCESS (3.169s)
[84.262916] Subtest rc6-accuracy: SUCCESS (6.341s)
[84.347648] [006/133] (938s left) gem_userptr_blits (forbidden-operations)
[84.420435] Starting subtest: forbidden-operations
[84.424569] Subtest forbidden-operations: SKIP (0.000s)
[84.574606] [007/133] (938s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[84.682637] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[84.686886] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[84.792835] [008/133] (937s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[84.884793] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[89.172606] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.290s)
[90.326072] [009/133] (932s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[90.388948] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[90.491304] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.102s)
[90.572308] [010/133] (932s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[90.689302] Starting subtest: cursorA-vs-flipA-atomic
[101.809619] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.120s)
[102.647565] [011/133] (920s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[102.758319] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[102.760638] Starting dynamic subtest: pipe-A-eDP-1
[102.786210] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[102.794925] Starting dynamic subtest: pipe-B-eDP-1
[102.818305] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[102.825361] Starting dynamic subtest: pipe-C-eDP-1
[102.848819] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[102.855832] Starting dynamic subtest: pipe-D-eDP-1
[102.879521] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[102.883871] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[104.923325] [012/133] (917s left) kms_flip (2x-flip-vs-wf_vblank)
[105.027960] Starting subtest: 2x-flip-vs-wf_vblank
[105.036972] Subtest 2x-flip-vs-wf_vblank: SKIP (0.011s)
[105.124145] [013/133] (917s left) kms_addfb_basic (small-bo)
[105.213048] Starting subtest: small-bo
[105.215233] Subtest small-bo: SUCCESS (0.000s)
[105.319854] [014/133] (917s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[105.423824] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[105.426098] Starting dynamic subtest: pipe-A-default-mode
[108.121112] Dynamic subtest pipe-A-default-mode: SUCCESS (2.696s)
[108.123504] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.697s)
[108.991391] [015/133] (913s left) gem_madvise (dontneed-before-mmap)
[109.026403] Starting subtest: dontneed-before-mmap
[109.060581] Subtest dontneed-before-mmap: SUCCESS (0.036s)
[109.188880] [016/133] (913s left) kms_atomic (plane-primary-legacy)
[109.282905] Starting subtest: plane-primary-legacy
[109.285091] Starting dynamic subtest: pipe-A-eDP-1
[109.734517] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.451s)
[109.736990] Subtest plane-primary-legacy: SUCCESS (0.452s)
[110.536455] [017/133] (912s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[110.647799] Starting subtest: blocking-absolute-wf_vblank-interruptible
[110.650183] Starting dynamic subtest: A-eDP1
[119.392065] Dynamic subtest A-eDP1: SUCCESS (8.743s)
[119.401348] Starting dynamic subtest: B-eDP1
[128.105279] Dynamic subtest B-eDP1: SUCCESS (8.711s)
[128.116604] Starting dynamic subtest: C-eDP1
[136.834330] Dynamic subtest C-eDP1: SUCCESS (8.727s)
[136.842926] Starting dynamic subtest: D-eDP1
[145.560444] Dynamic subtest D-eDP1: SUCCESS (8.726s)
[145.565743] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.918s)
[146.784904] [018/133] (876s left) kms_cursor_edge_walk (64x64-top-bottom)
[146.882412] Starting subtest: 64x64-top-bottom
[146.884750] Starting dynamic subtest: pipe-A-eDP-1
[150.342281] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.458s)
[150.350934] Starting dynamic subtest: pipe-D-eDP-1
[153.462193] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.117s)
[153.464105] Subtest 64x64-top-bottom: SUCCESS (6.577s)
[154.292770] [019/133] (868s left) kms_addfb_basic (invalid-get-prop-any)
[154.350280] Starting subtest: invalid-get-prop-any
[154.352116] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[154.515908] [020/133] (868s left) gem_mmap_gtt (fault-concurrent-y)
[154.590592] Subtest fault-concurrent-Y: SKIP (0.000s)
[154.660359] [021/133] (868s left) gem_busy (semaphore)
[154.864672] Subtest semaphore: SKIP (0.000s)
[155.117876] [022/133] (868s left) kms_vblank (query-forked-busy-hang)
[155.213985] Starting subtest: query-forked-busy-hang
[155.215872] Starting dynamic subtest: pipe-A-eDP-1
[181.671402] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.455s)
[181.684721] Starting dynamic subtest: pipe-D-eDP-1
[206.746609] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.074s)
[206.748763] Subtest query-forked-busy-hang: SUCCESS (51.533s)
[207.552410] [023/133] (815s left) kms_prop_blob (invalid-set-prop)
[207.616191] Starting subtest: invalid-set-prop
[207.618585] Subtest invalid-set-prop: SUCCESS (0.000s)
[207.724640] [024/133] (815s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[207.829522] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[207.842077] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[207.911356] [025/133] (815s left) kms_lease (multimaster-lease)
[208.007924] Starting subtest: multimaster-lease
[208.010395] Subtest multimaster-lease: SUCCESS (0.003s)
[208.144995] [026/133] (815s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[208.189809] Starting subtest: invalid-smem-bo-on-discrete
[208.193950] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s)
[208.343726] [027/133] (815s left) gem_userptr_blits (dmabuf-unsync)
[208.413081] Subtest dmabuf-unsync: SKIP (0.000s)
[208.540395] [028/133] (814s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[208.641819] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[209.621618] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (0.979s)
[209.755705] [029/133] (813s left) gem_ringfill (legacy-basic)
[215.897677] Starting subtest: legacy-basic
[215.900238] Starting dynamic subtest: default
[215.977931] Dynamic subtest default: SUCCESS (0.080s)
[215.988781] Starting dynamic subtest: render
[216.018840] Dynamic subtest render: SUCCESS (0.040s)
[216.026442] Starting dynamic subtest: bsd
[216.062038] Dynamic subtest bsd: SUCCESS (0.041s)
[216.071153] Starting dynamic subtest: bsd1
[216.102219] Dynamic subtest bsd1: SUCCESS (0.039s)
[216.110977] Starting dynamic subtest: bsd2
[216.145572] Dynamic subtest bsd2: SUCCESS (0.041s)
[216.155094] Starting dynamic subtest: blt
[216.190894] Dynamic subtest blt: SUCCESS (0.044s)
[216.200597] Starting dynamic subtest: vebox
[216.232738] Dynamic subtest vebox: SUCCESS (0.040s)
[216.235135] Subtest legacy-basic: SUCCESS (0.337s)
[216.333101] [FACT gem_ringfill (legacy-basic)] new: kernel.kmod_is_loaded.vgem: true
[216.336697] [030/133] (807s left) gem_vm_create (invalid-create)
[216.392161] Starting subtest: invalid-create
[216.394417] Subtest invalid-create: SUCCESS (0.002s)
[216.506101] [031/133] (807s left) gen9_exec_parse (batch-invalid-length)
[216.574578] Subtest batch-invalid-length: SKIP (0.000s)
[216.655470] [032/133] (806s left) gem_exec_schedule (submit-early-slice)
[216.723319] Starting subtest: submit-early-slice
[216.726694] Starting dynamic subtest: rcs0
[216.776749] Dynamic subtest rcs0: SUCCESS (0.060s)
[216.786585] Starting dynamic subtest: bcs0
[216.829865] Dynamic subtest bcs0: SUCCESS (0.052s)
[216.839608] Starting dynamic subtest: vcs0
[216.889045] Dynamic subtest vcs0: SUCCESS (0.059s)
[216.898644] Starting dynamic subtest: vcs1
[216.944595] Dynamic subtest vcs1: SUCCESS (0.056s)
[216.955359] Starting dynamic subtest: vecs0
[216.999865] Dynamic subtest vecs0: SUCCESS (0.054s)
[217.011018] Starting dynamic subtest: ccs0
[217.050666] Dynamic subtest ccs0: SUCCESS (0.051s)
[217.052737] Subtest submit-early-slice: SUCCESS (0.335s)
[217.984806] [033/133] (805s left) gem_lmem_swapping (massive-random)
[218.027075] Subtest massive-random: SKIP (0.000s)
[218.069161] [034/133] (805s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[218.173420] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[218.177800] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[218.272590] [035/133] (805s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[218.372612] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[219.319664] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.947s)
[219.495142] [036/133] (804s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[219.606165] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[219.608477] Starting dynamic subtest: pipe-A
[219.966375] Dynamic subtest pipe-A: SUCCESS (0.363s)
[219.973062] Starting dynamic subtest: pipe-B
[221.330141] Dynamic subtest pipe-B: SUCCESS (1.363s)
[221.342943] Starting dynamic subtest: pipe-C
[222.785319] Dynamic subtest pipe-C: SUCCESS (1.454s)
[222.794249] Starting dynamic subtest: pipe-D
[224.196900] Dynamic subtest pipe-D: SUCCESS (1.411s)
[224.199064] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.593s)
[225.367109] [037/133] (798s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[225.429424] Starting subtest: saturated-hostile-nopreempt
[225.431801] Starting dynamic subtest: rcs0
[225.531502] Dynamic subtest rcs0: SKIP (0.099s)
[225.541767] Starting dynamic subtest: bcs0
[225.555639] Dynamic subtest bcs0: SKIP (0.023s)
[225.563236] Starting dynamic subtest: vcs0
[225.582435] Dynamic subtest vcs0: SKIP (0.026s)
[225.589957] Starting dynamic subtest: vcs1
[225.607588] Dynamic subtest vcs1: SKIP (0.024s)
[225.614953] Starting dynamic subtest: vecs0
[225.632664] Dynamic subtest vecs0: SKIP (0.024s)
[225.640045] Starting dynamic subtest: ccs0
[225.658589] Dynamic subtest ccs0: SKIP (0.025s)
[225.662762] Subtest saturated-hostile-nopreempt: SKIP (0.228s)
[225.742882] [038/133] (798s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[225.852975] Starting subtest: sprite-rotation-90-pos-100-0
[225.857337] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[225.950392] [039/133] (797s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[226.056408] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[226.060660] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[226.171335] [040/133] (797s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[226.267160] Starting subtest: compare-crc-sanitycheck-xr24
[226.269423] Starting dynamic subtest: pipe-A-eDP-1
[226.871424] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.604s)
[226.880731] Starting dynamic subtest: pipe-B-eDP-1
[228.137587] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.267s)
[228.147119] Starting dynamic subtest: pipe-C-eDP-1
[229.304049] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.162s)
[229.313072] Starting dynamic subtest: pipe-D-eDP-1
[230.531497] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.229s)
[230.533919] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.267s)
[231.419863] [041/133] (792s left) kms_tv_load_detect (load-detect)
[231.490323] Subtest load-detect: SKIP (0.000s)
[231.560855] [042/133] (792s left) gem_softpin (safe-alignment)
[231.628598] Starting subtest: safe-alignment
[231.652196] Subtest safe-alignment: SUCCESS (0.023s)
[232.968373] [043/133] (791s left) gem_ctx_sseu (invalid-args)
[233.023279] Subtest invalid-args: SKIP (0.000s)
[233.104178] [044/133] (790s left) gem_exec_reloc (basic-wc-noreloc)
[233.169382] Subtest basic-wc-noreloc: SKIP (0.000s)
[233.238553] [045/133] (790s left) gem_exec_balancer (individual)
[233.303441] Starting subtest: individual
[234.940304] Subtest individual: SUCCESS (1.638s)
[235.302933] [046/133] (788s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[235.411645] Starting subtest: fb-8bpc-vs-panel-8bpc
[235.413726] Starting dynamic subtest: pipe-A-eDP-1
[236.759629] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.345s)
[236.763681] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.347s)
[237.568498] [047/133] (786s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[237.640448] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[237.716866] [048/133] (786s left) kms_fence_pin_leak
[237.885084] [049/133] (786s left) i915_pm_rps (thresholds-idle)
[237.932478] Starting subtest: thresholds-idle
[237.936961] Subtest thresholds-idle: SKIP (0.000s)
[238.065510] [050/133] (786s left) core_setmaster (master-drop-set-root)
[238.134227] Starting subtest: master-drop-set-root
[238.150870] Subtest master-drop-set-root: SUCCESS (0.014s)
[238.193198] [051/133] (786s left) gem_exec_store (pages)
[238.250190] Starting subtest: pages
[238.252511] Starting dynamic subtest: rcs0
[238.376044] Dynamic subtest rcs0: SUCCESS (0.128s)
[238.386934] Starting dynamic subtest: bcs0
[238.457794] Dynamic subtest bcs0: SUCCESS (0.080s)
[238.468073] Starting dynamic subtest: vcs0
[238.531603] Dynamic subtest vcs0: SUCCESS (0.074s)
[238.542238] Starting dynamic subtest: vcs1
[238.598680] Dynamic subtest vcs1: SUCCESS (0.066s)
[238.607601] Starting dynamic subtest: vecs0
[238.671544] Dynamic subtest vecs0: SUCCESS (0.072s)
[238.681555] Starting dynamic subtest: ccs0
[238.749080] Dynamic subtest ccs0: SUCCESS (0.077s)
[238.751150] Subtest pages: SUCCESS (0.503s)
[238.944079] [052/133] (785s left) kms_flip (2x-plain-flip)
[239.033931] Starting subtest: 2x-plain-flip
[239.044563] Subtest 2x-plain-flip: SKIP (0.010s)
[239.176918] [053/133] (785s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[239.282489] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[239.286205] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[239.424958] [054/133] (785s left) syncobj_timeline (invalid-query-illegal-handle)
[239.479311] Starting subtest: invalid-query-illegal-handle
[239.481296] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[239.587712] [055/133] (784s left) kms_psr (pr-primary-page-flip)
[239.679616] Starting subtest: pr-primary-page-flip
[239.683275] Subtest pr-primary-page-flip: SKIP (0.000s)
[239.761986] [056/133] (784s left) kms_fb_coherency (memset-crc)
[239.853641] Starting subtest: memset-crc
[239.855348] Starting dynamic subtest: mmap-offset-wc
[240.218646] Dynamic subtest mmap-offset-wc: SUCCESS (0.365s)
[240.509696] Starting dynamic subtest: mmap-offset-uc
[246.534519] Dynamic subtest mmap-offset-uc: SUCCESS (6.033s)
[246.834846] Subtest memset-crc: SUCCESS (6.981s)
[247.656097] [057/133] (776s left) api_intel_bb (reset-flags)
[247.722290] Starting subtest: reset-flags
[247.729981] Subtest reset-flags: SUCCESS (0.009s)
[247.866272] [058/133] (776s left) gem_ctx_isolation (preservation-reset)
[248.042879] Starting subtest: preservation-reset
[248.045505] Starting dynamic subtest: rcs0
[248.316608] Dynamic subtest rcs0: SUCCESS (0.274s)
[248.325227] Starting dynamic subtest: bcs0
[248.653452] Dynamic subtest bcs0: SUCCESS (0.336s)
[248.663676] Starting dynamic subtest: vcs0
[248.975764] Dynamic subtest vcs0: SUCCESS (0.322s)
[248.986243] Starting dynamic subtest: vcs1
[250.266443] Dynamic subtest vcs1: SUCCESS (1.289s)
[250.276682] Starting dynamic subtest: vecs0
[252.237650] Dynamic subtest vecs0: SUCCESS (1.971s)
[252.251870] Starting dynamic subtest: ccs0
[254.241354] Dynamic subtest ccs0: SUCCESS (2.002s)
[254.243823] Subtest preservation-reset: SUCCESS (6.200s)
[254.391080] [059/133] (770s left) sw_sync (timeline_closed)
[254.432036] Starting subtest: timeline_closed
[254.434373] Subtest timeline_closed: SUCCESS (0.000s)
[254.509363] [060/133] (770s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[254.643363] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[254.647584] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.002s)
[254.821149] [061/133] (769s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[254.920575] Starting subtest: fbcpsr-rgb565-draw-pwrite
[261.852833] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (6.936s)
[261.986343] [062/133] (762s left) gem_mmap_gtt (basic-small-copy-xy)
[262.041376] Subtest basic-small-copy-XY: SKIP (0.000s)
[262.111351] [063/133] (762s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[262.226531] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[262.228461] Starting dynamic subtest: pipe-A-eDP-1
[262.285272] Dynamic subtest pipe-A-eDP-1: SKIP (0.003s)
[262.292806] Starting dynamic subtest: pipe-B-eDP-1
[262.347667] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[262.356230] Starting dynamic subtest: pipe-C-eDP-1
[262.411664] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[262.419981] Starting dynamic subtest: pipe-D-eDP-1
[262.474761] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[262.479457] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.013s)
[264.423214] [064/133] (760s left) kms_psr (psr-cursor-mmap-gtt)
[264.519880] Starting subtest: psr-cursor-mmap-gtt
[264.522023] Starting dynamic subtest: eDP-1
[266.210131] Dynamic subtest eDP-1: SUCCESS (1.694s)
[266.212465] Subtest psr-cursor-mmap-gtt: SUCCESS (1.695s)
[267.095062] [065/133] (757s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[267.196703] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[267.200816] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[267.332534] [066/133] (757s left) gem_exec_schedule (preempt-queue-chain)
[267.415318] Subtest preempt-queue-chain: SKIP (0.000s)
[267.707890] [067/133] (757s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[267.768936] Starting subtest: invalid-bsd2-flag-on-blt
[267.771459] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[267.889993] [068/133] (757s left) gem_lmem_swapping (random)
[267.931214] Subtest random: SKIP (0.000s)
[267.974806] [069/133] (757s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[268.087275] Starting subtest: y-tiled-64bpp-rotate-90
[268.091706] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[268.209037] [070/133] (756s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[268.306380] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[275.163037] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (6.859s)
[275.331533] [071/133] (749s left) gem_tiled_blits (normal)
[275.402193] Subtest normal: SKIP (0.000s)
[275.467581] [072/133] (749s left) vgem_basic (create)
[275.504971] Starting subtest: create
[275.506870] Subtest create: SUCCESS (0.000s)
[275.573856] [073/133] (749s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[275.674868] Starting subtest: 4-tiled-64bpp-rotate-0
[277.287319] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.612s)
[277.493225] [074/133] (747s left) sysfs_preempt_timeout (invalid)
[277.559504] Starting subtest: invalid
[277.561763] Starting dynamic subtest: vecs0
[277.564238] Dynamic subtest vecs0: SUCCESS (0.000s)
[277.575086] Starting dynamic subtest: ccs0
[277.576972] Dynamic subtest ccs0: SUCCESS (0.000s)
[277.584374] Starting dynamic subtest: vcs0
[277.586226] Dynamic subtest vcs0: SUCCESS (0.000s)
[277.593677] Starting dynamic subtest: bcs0
[277.595597] Dynamic subtest bcs0: SUCCESS (0.000s)
[277.603068] Starting dynamic subtest: rcs0
[277.604932] Dynamic subtest rcs0: SUCCESS (0.000s)
[277.612377] Starting dynamic subtest: vcs1
[277.614256] Dynamic subtest vcs1: SUCCESS (0.000s)
[277.616105] Subtest invalid: SUCCESS (0.005s)
[277.706353] [075/133] (747s left) kms_scaling_modes (scaling-mode-full-aspect)
[277.800982] Starting subtest: scaling-mode-full-aspect
[277.802851] Starting dynamic subtest: pipe-A-eDP-1
[277.894111] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.094s)
[277.904637] Starting dynamic subtest: pipe-B-eDP-1
[279.032853] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.137s)
[279.044263] Starting dynamic subtest: pipe-C-eDP-1
[280.233407] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.199s)
[280.241893] Starting dynamic subtest: pipe-D-eDP-1
[281.366981] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.132s)
[281.369210] Subtest scaling-mode-full-aspect: SUCCESS (3.569s)
[282.565607] [076/133] (742s left) gem_create (create-ext-cpu-access-sanity-check)
[282.738524] Starting subtest: create-ext-cpu-access-sanity-check
[282.744141] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[282.824973] [077/133] (742s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[282.918018] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[282.922207] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[283.042460] [078/133] (742s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[283.136982] Starting subtest: bad-pixel-format-yf-tiled-ccs
[283.139286] Starting dynamic subtest: pipe-A-eDP-1
[283.162163] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[283.172058] Starting dynamic subtest: pipe-B-eDP-1
[283.192831] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[283.201028] Starting dynamic subtest: pipe-C-eDP-1
[283.222427] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[283.231071] Starting dynamic subtest: pipe-D-eDP-1
[283.253372] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[283.257720] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.004s)
[285.412765] [079/133] (740s left) gem_exec_parallel (userptr)
[285.482893] Starting subtest: userptr
[285.485255] Starting dynamic subtest: rcs0
[286.935082] Dynamic subtest rcs0: SUCCESS (1.451s)
[286.946395] Starting dynamic subtest: bcs0
[288.410085] Dynamic subtest bcs0: SUCCESS (1.473s)
[288.418264] Starting dynamic subtest: vcs0
[289.920822] Dynamic subtest vcs0: SUCCESS (1.507s)
[289.931936] Starting dynamic subtest: vcs1
[291.862485] Dynamic subtest vcs1: SUCCESS (1.939s)
[291.874215] Starting dynamic subtest: vecs0
[293.910430] Dynamic subtest vecs0: SUCCESS (2.045s)
[293.921901] Starting dynamic subtest: ccs0
[295.396931] Dynamic subtest ccs0: SUCCESS (1.486s)
[295.399456] Subtest userptr: SUCCESS (9.915s)
[295.605588] [080/133] (729s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[295.709713] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[295.712012] Starting dynamic subtest: pipe-A-eDP-1
[295.830738] Dynamic subtest pipe-A-eDP-1: SKIP (0.122s)
[295.842236] Starting dynamic subtest: pipe-B-eDP-1
[296.971740] Dynamic subtest pipe-B-eDP-1: SKIP (1.138s)
[296.976364] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.264s)
[298.169254] [081/133] (727s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[298.267346] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[298.269519] Starting dynamic subtest: pipe-A
[298.333849] Dynamic subtest pipe-A: SUCCESS (0.068s)
[298.342591] Starting dynamic subtest: pipe-B
[299.487158] Dynamic subtest pipe-B: SUCCESS (1.151s)
[299.500384] Starting dynamic subtest: pipe-C
[300.585366] Dynamic subtest pipe-C: SUCCESS (1.097s)
[300.593653] Starting dynamic subtest: pipe-D
[301.721905] Dynamic subtest pipe-D: SUCCESS (1.136s)
[301.724316] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.457s)
[302.883388] [082/133] (722s left) kms_chamelium_frames (hdmi-crc-single)
[303.278379] Subtest hdmi-crc-single: SKIP (0.000s)
[304.088145] [083/133] (721s left) gem_exec_fence (syncobj-channel)
[304.535091] Starting subtest: syncobj-channel
[305.552483] Subtest syncobj-channel: SUCCESS (1.014s)
[305.977111] [084/133] (719s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[306.061951] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[306.066266] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[307.162835] [085/133] (718s left) syncobj_timeline (multi-wait-available-submitted)
[307.224235] Starting subtest: multi-wait-available-submitted
[307.226638] Subtest multi-wait-available-submitted: SUCCESS (0.000s)
[307.347310] [086/133] (718s left) gem_exec_flush (basic-wb-rw-before-default)
[307.401196] Starting subtest: basic-wb-rw-before-default
[312.871151] Subtest basic-wb-rw-before-default: SUCCESS (5.471s)
[313.070157] [087/133] (712s left) i915_drm_fdinfo (most-busy-idle-check-all)
[313.114866] Starting subtest: most-busy-idle-check-all
[313.117593] Starting dynamic subtest: rcs0
[313.124338] Dynamic subtest rcs0: SKIP (0.006s)
[313.132691] Starting dynamic subtest: bcs0
[313.136603] Dynamic subtest bcs0: SKIP (0.000s)
[313.144405] Starting dynamic subtest: vcs0
[313.148617] Dynamic subtest vcs0: SKIP (0.000s)
[313.156316] Starting dynamic subtest: vcs1
[313.160138] Dynamic subtest vcs1: SKIP (0.000s)
[313.168022] Starting dynamic subtest: vecs0
[313.172076] Dynamic subtest vecs0: SKIP (0.000s)
[313.179894] Starting dynamic subtest: ccs0
[313.184123] Dynamic subtest ccs0: SKIP (0.000s)
[313.188112] Subtest most-busy-idle-check-all: SKIP (0.011s)
[313.225540] [088/133] (712s left) kms_pm_rpm (system-suspend-modeset)
[315.051464] Starting subtest: system-suspend-modeset
[334.549600] Subtest system-suspend-modeset: SUCCESS (4.594s)
[334.934333] [089/133] (690s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[335.018134] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[335.022361] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[335.208236] [090/133] (690s left) kms_sequence (get-busy)
[335.300345] Starting subtest: get-busy
[335.302676] Starting dynamic subtest: pipe-A-eDP-1
[337.192813] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.933s)
[337.202470] Starting dynamic subtest: pipe-B-eDP-1
[339.729784] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.573s)
[339.740441] Starting dynamic subtest: pipe-C-eDP-1
[342.329694] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.631s)
[342.340919] Starting dynamic subtest: pipe-D-eDP-1
[344.919748] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.609s)
[344.921615] Subtest get-busy: SUCCESS (9.751s)
[345.717388] [091/133] (680s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[345.810455] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[345.814472] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[345.940237] [092/133] (679s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[346.043678] Starting subtest: fbc-psr-cursor-mmap-cpu
[346.045926] Starting dynamic subtest: eDP-1
[346.050234] Dynamic subtest eDP-1: SKIP (0.000s)
[346.054494] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.001s)
[346.132230] [093/133] (679s left) kms_rotation_crc (exhaust-fences)
[346.230419] Starting subtest: exhaust-fences
[346.234645] Subtest exhaust-fences: SKIP (0.000s)
[346.313680] [094/133] (679s left) kms_flip (absolute-wf_vblank)
[346.408116] Starting subtest: absolute-wf_vblank
[346.410445] Starting dynamic subtest: A-eDP1
[355.122519] Dynamic subtest A-eDP1: SUCCESS (8.748s)
[355.134688] Starting dynamic subtest: B-eDP1
[363.842188] Dynamic subtest B-eDP1: SUCCESS (8.730s)
[363.852906] Starting dynamic subtest: C-eDP1
[372.559323] Dynamic subtest C-eDP1: SUCCESS (8.716s)
[372.568754] Starting dynamic subtest: D-eDP1
[381.284756] Dynamic subtest D-eDP1: SUCCESS (8.724s)
[381.286844] Subtest absolute-wf_vblank: SUCCESS (34.926s)
[382.504404] [095/133] (643s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[382.604738] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[390.004933] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.405s)
[390.195276] [096/133] (635s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[390.510486] Starting subtest: cursor-rapid-movement-max-size
[390.517114] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[390.648872] [097/133] (635s left) kms_properties (crtc-properties-atomic)
[390.753418] Starting subtest: crtc-properties-atomic
[390.755620] Starting dynamic subtest: pipe-A-eDP-1
[391.194722] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.443s)
[391.214044] Starting dynamic subtest: pipe-B-eDP-1
[392.385639] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.190s)
[392.395835] Starting dynamic subtest: pipe-C-eDP-1
[393.508827] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.121s)
[393.519616] Starting dynamic subtest: pipe-D-eDP-1
[394.637771] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.126s)
[394.640030] Subtest crtc-properties-atomic: SUCCESS (3.887s)
[395.455098] [098/133] (630s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[395.550090] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[395.552368] Starting dynamic subtest: pipe-A-default-mode
[396.701272] Dynamic subtest pipe-A-default-mode: SKIP (1.147s)
[396.705287] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.149s)
[396.882787] [099/133] (629s left) api_intel_allocator (simple-allocator)
[396.955586] Starting subtest: simple-allocator
[396.957977] Starting dynamic subtest: basic
[396.960469] Dynamic subtest basic: SUCCESS (0.003s)
[396.972513] Starting dynamic subtest: parallel-one
[397.143102] Dynamic subtest parallel-one: SUCCESS (0.183s)
[397.155069] Starting dynamic subtest: print
[397.157463] Dynamic subtest print: SUCCESS (0.000s)
[397.166487] Starting dynamic subtest: reuse
[397.168763] Dynamic subtest reuse: SUCCESS (0.000s)
[397.177692] Starting dynamic subtest: reserve
[397.180057] Dynamic subtest reserve: SUCCESS (0.000s)
[397.188912] Starting dynamic subtest: fork-reopen-allocator
[397.191154] Dynamic subtest fork-reopen-allocator: SUCCESS (0.011s)
[397.193373] Subtest simple-allocator: SUCCESS (0.203s)
[397.278356] [100/133] (628s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier)
[397.367474] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier
[397.381109] Subtest pixel-format-4-tiled-bmg-ccs-modifier: SKIP (0.000s)
[397.465138] [101/133] (628s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[397.577672] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[397.582385] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[397.700310] [102/133] (628s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[397.797113] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[397.801736] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[397.921220] [103/133] (628s left) drm_read (empty-block)
[398.061930] Starting subtest: empty-block
[399.063463] Subtest empty-block: SUCCESS (1.000s)
[399.221702] [104/133] (627s left) gem_mmap_gtt (basic-write-read-distinct)
[399.280255] Subtest basic-write-read-distinct: SKIP (0.000s)
[399.352596] [105/133] (627s left) kms_setmode (invalid-clone-single-crtc)
[399.408665] Starting subtest: invalid-clone-single-crtc
[399.415258] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[399.541778] [106/133] (626s left) gem_exec_capture (capture-invisible)
[399.600393] Starting subtest: capture-invisible
[399.602769] Starting dynamic subtest: smem0
[399.607282] Dynamic subtest smem0: SKIP (0.000s)
[399.611788] Subtest capture-invisible: SKIP (0.001s)
[399.728939] [107/133] (626s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[399.787130] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[399.789452] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[399.918194] [108/133] (626s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[400.022465] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[401.123709] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.100s)
[401.260916] [109/133] (625s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[401.366087] Starting subtest: fbc-rgb565-draw-mmap-cpu
[405.408694] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (4.047s)
[406.582888] [110/133] (620s left) i915_pm_freq_api (freq-suspend)
[406.656127] Starting subtest: freq-suspend
[406.658323] Starting dynamic subtest: gt0
[423.427990] Dynamic subtest gt0: SUCCESS (1.447s)
[423.438656] Starting dynamic subtest: gt1
[439.239398] Dynamic subtest gt1: SUCCESS (1.241s)
[439.242088] Subtest freq-suspend: SUCCESS (2.693s)
[439.344101] [111/133] (587s left) kms_cursor_crc (cursor-offscreen-64x64)
[439.536398] Starting subtest: cursor-offscreen-64x64
[439.539236] Starting dynamic subtest: pipe-A-eDP-1
[441.437436] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.955s)
[441.464966] Starting dynamic subtest: pipe-D-eDP-1
[444.015140] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.618s)
[444.017486] Subtest cursor-offscreen-64x64: SUCCESS (4.597s)
[444.818696] [112/133] (581s left) kms_color (ctm-0-25)
[444.922424] Starting subtest: ctm-0-25
[444.924691] Starting dynamic subtest: pipe-A-eDP-1
[448.384974] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.512s)
[448.395374] Starting dynamic subtest: pipe-B-eDP-1
[452.552135] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.207s)
[452.561903] Starting dynamic subtest: pipe-C-eDP-1
[456.534441] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.003s)
[456.545133] Starting dynamic subtest: pipe-D-eDP-1
[460.487341] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.962s)
[460.489948] Subtest ctm-0-25: SUCCESS (15.686s)
[461.315705] [113/133] (565s left) drm_read (fault-buffer)
[461.473314] Starting subtest: fault-buffer
[461.476144] Subtest fault-buffer: SUCCESS (0.001s)
[461.630839] [114/133] (565s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[461.737110] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[461.739471] Starting dynamic subtest: pipe-A-eDP-1
[461.764597] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[461.775191] Starting dynamic subtest: pipe-B-eDP-1
[461.800357] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[461.809254] Starting dynamic subtest: pipe-C-eDP-1
[461.834782] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[461.843916] Starting dynamic subtest: pipe-D-eDP-1
[461.869484] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[461.874280] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.005s)
[463.913701] [115/133] (562s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[464.026177] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[470.835833] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.822s)
[471.001981] [116/133] (555s left) kms_chamelium_hpd (common-hpd-after-suspend)
[471.377203] Subtest common-hpd-after-suspend: SKIP (0.000s)
[472.224087] [117/133] (554s left) kms_content_protection (uevent)
[472.375454] Starting subtest: uevent
[472.381199] Subtest uevent: SKIP (0.000s)
[472.541116] [118/133] (554s left) kms_pm_lpsp (kms-lpsp)
[473.654092] Starting subtest: kms-lpsp
[473.656193] Starting dynamic subtest: pipe-A-eDP-1
[473.791082] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.141s)
[474.093244] Subtest kms-lpsp: SUCCESS (0.443s)
[474.986544] [119/133] (552s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[475.090017] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[475.095147] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[475.211728] [120/133] (551s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[475.330311] Starting subtest: flip-vs-cursor-varying-size
[483.759320] Subtest flip-vs-cursor-varying-size: SUCCESS (8.425s)
[484.622100] [121/133] (542s left) perf_pmu (busy-accuracy-50)
[484.669083] Starting subtest: busy-accuracy-50
[484.671187] Starting dynamic subtest: rcs0
[486.203965] Dynamic subtest rcs0: SUCCESS (1.534s)
[486.213464] Starting dynamic subtest: bcs0
[487.745711] Dynamic subtest bcs0: SUCCESS (1.539s)
[487.755501] Starting dynamic subtest: vcs0
[489.290245] Dynamic subtest vcs0: SUCCESS (1.541s)
[489.300492] Starting dynamic subtest: vcs1
[490.833858] Dynamic subtest vcs1: SUCCESS (1.541s)
[490.845528] Starting dynamic subtest: vecs0
[492.376274] Dynamic subtest vecs0: SUCCESS (1.539s)
[492.387746] Starting dynamic subtest: ccs0
[493.918955] Dynamic subtest ccs0: SUCCESS (1.541s)
[493.921927] Subtest busy-accuracy-50: SUCCESS (9.248s)
[494.044740] [122/133] (533s left) prime_vgem (wait)
[494.142335] Starting subtest: wait
[494.144645] Starting dynamic subtest: rcs0
[494.198295] Dynamic subtest rcs0: SUCCESS (0.055s)
[494.207831] Starting dynamic subtest: bcs0
[494.283373] Dynamic subtest bcs0: SUCCESS (0.086s)
[494.293217] Starting dynamic subtest: vcs0
[494.326269] Dynamic subtest vcs0: SUCCESS (0.042s)
[494.335968] Starting dynamic subtest: vcs1
[494.373724] Dynamic subtest vcs1: SUCCESS (0.047s)
[494.383501] Starting dynamic subtest: vecs0
[494.422351] Dynamic subtest vecs0: SUCCESS (0.048s)
[494.431491] Starting dynamic subtest: ccs0
[494.472148] Dynamic subtest ccs0: SUCCESS (0.049s)
[494.474985] Subtest wait: SUCCESS (0.332s)
[494.627030] [123/133] (532s left) kms_psr (fbc-pr-basic)
[494.740361] Starting subtest: fbc-pr-basic
[494.746315] Subtest fbc-pr-basic: SKIP (0.000s)
[494.825883] [124/133] (532s left) gem_userptr_blits (sync-overlap)
[494.909641] Starting subtest: sync-overlap
[494.912356] Subtest sync-overlap: SUCCESS (0.000s)
[495.054865] [125/133] (532s left) perf (oa-exponents)
[495.184025] Starting subtest: oa-exponents
[495.186158] Starting dynamic subtest: 0-rcs0
[496.954932] Dynamic subtest 0-rcs0: SUCCESS (1.772s)
[496.965727] Starting dynamic subtest: 1-vecs0
[498.783351] Dynamic subtest 1-vecs0: SUCCESS (1.827s)
[498.786456] Subtest oa-exponents: SUCCESS (3.600s)
[498.836446] [126/133] (528s left) vgem_basic (dmabuf-export)
[498.878523] Starting subtest: dmabuf-export
[498.921402] Subtest dmabuf-export: SUCCESS (0.046s)
[499.039804] [127/133] (528s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[499.138478] Starting subtest: yf-tiled-64bpp-rotate-90
[499.143515] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[499.255186] [128/133] (528s left) kms_hdr (invalid-metadata-sizes)
[499.338494] Starting subtest: invalid-metadata-sizes
[499.346495] Subtest invalid-metadata-sizes: SKIP (0.000s)
[499.423537] [129/133] (528s left) kms_joiner (invalid-modeset-ultra-joiner)
[499.513501] Starting subtest: invalid-modeset-ultra-joiner
[499.517760] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[499.593005] [130/133] (527s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[499.641893] Starting subtest: rel-constants-invalid-rel-gen5
[499.644405] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[499.764482] [131/133] (527s left) perf_pmu (busy-start)
[499.806522] Starting subtest: busy-start
[499.808890] Starting dynamic subtest: rcs0
[502.353328] Dynamic subtest rcs0: SUCCESS (2.550s)
[502.364457] Starting dynamic subtest: bcs0
[504.902908] Dynamic subtest bcs0: SUCCESS (2.547s)
[504.914643] Starting dynamic subtest: vcs0
[508.735951] Dynamic subtest vcs0: SUCCESS (3.830s)
[508.748443] Starting dynamic subtest: vcs1
[512.767483] Dynamic subtest vcs1: SUCCESS (4.030s)
[512.779354] Starting dynamic subtest: vecs0
[516.735525] Dynamic subtest vecs0: SUCCESS (3.966s)
[516.747518] Starting dynamic subtest: ccs0
[519.286495] Dynamic subtest ccs0: SUCCESS (2.550s)
[519.289310] Subtest busy-start: SUCCESS (19.488s)
[519.418902] [132/133] (508s left) syncobj_timeline (wait-all-delayed-signal)
[519.468373] Starting subtest: wait-all-delayed-signal
[519.570586] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[519.663062] [133/133] (508s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[519.762069] Starting subtest: psr-2p-primscrn-cur-indfb-move
[519.767393] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[519.889365] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_legacy
results: parsing output: 1/ for test: gem_pwrite
results: parsing output: 2/ for test: kms_psr
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: i915_pm_rc6_residency
results: parsing output: 5/ for test: gem_userptr_blits
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: syncobj_timeline
results: parsing output: 9/ for test: kms_cursor_legacy
results: parsing output: 10/ for test: kms_ccs
results: parsing output: 11/ for test: kms_flip
results: parsing output: 12/ for test: kms_addfb_basic
results: parsing output: 13/ for test: kms_flip_scaled_crc
results: parsing output: 14/ for test: gem_madvise
results: parsing output: 15/ for test: kms_atomic
results: parsing output: 16/ for test: kms_flip
results: parsing output: 17/ for test: kms_cursor_edge_walk
results: parsing output: 18/ for test: kms_addfb_basic
results: parsing output: 19/ for test: gem_mmap_gtt
results: parsing output: 20/ for test: gem_busy
results: parsing output: 21/ for test: kms_vblank
results: parsing output: 22/ for test: kms_prop_blob
results: parsing output: 23/ for test: kms_plane
results: parsing output: 24/ for test: kms_lease
results: parsing output: 25/ for test: kms_addfb_basic
results: parsing output: 26/ for test: gem_userptr_blits
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: gem_ringfill
results: parsing output: 29/ for test: gem_vm_create
results: parsing output: 30/ for test: gen9_exec_parse
results: parsing output: 31/ for test: gem_exec_schedule
results: parsing output: 32/ for test: gem_lmem_swapping
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: kms_plane_scaling
results: parsing output: 36/ for test: gem_ctx_persistence
results: parsing output: 37/ for test: kms_rotation_crc
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: kms_pipe_crc_basic
results: parsing output: 40/ for test: kms_tv_load_detect
results: parsing output: 41/ for test: gem_softpin
results: parsing output: 42/ for test: gem_ctx_sseu
results: parsing output: 43/ for test: gem_exec_reloc
results: parsing output: 44/ for test: gem_exec_balancer
results: parsing output: 45/ for test: kms_dither
results: parsing output: 46/ for test: gem_exec_reloc
results: parsing output: 47/ for test: kms_fence_pin_leak
results: parsing output: 48/ for test: i915_pm_rps
results: parsing output: 49/ for test: core_setmaster
results: parsing output: 50/ for test: gem_exec_store
results: parsing output: 51/ for test: kms_flip
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: syncobj_timeline
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: kms_fb_coherency
results: parsing output: 56/ for test: api_intel_bb
results: parsing output: 57/ for test: gem_ctx_isolation
results: parsing output: 58/ for test: sw_sync
results: parsing output: 59/ for test: kms_cursor_legacy
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: gem_mmap_gtt
results: parsing output: 62/ for test: kms_ccs
results: parsing output: 63/ for test: kms_psr
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: gem_exec_schedule
results: parsing output: 66/ for test: gem_exec_params
results: parsing output: 67/ for test: gem_lmem_swapping
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_tiled_blits
results: parsing output: 71/ for test: vgem_basic
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: sysfs_preempt_timeout
results: parsing output: 74/ for test: kms_scaling_modes
results: parsing output: 75/ for test: gem_create
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: gem_exec_parallel
results: parsing output: 79/ for test: kms_psr2_sf
results: parsing output: 80/ for test: kms_plane_scaling
results: parsing output: 81/ for test: kms_chamelium_frames
results: parsing output: 82/ for test: gem_exec_fence
results: parsing output: 83/ for test: kms_ccs
results: parsing output: 84/ for test: syncobj_timeline
results: parsing output: 85/ for test: gem_exec_flush
results: parsing output: 86/ for test: i915_drm_fdinfo
results: parsing output: 87/ for test: kms_pm_rpm
results: parsing output: 88/ for test: gem_render_copy
results: parsing output: 89/ for test: kms_sequence
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: kms_rotation_crc
results: parsing output: 93/ for test: kms_flip
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_cursor_crc
results: parsing output: 96/ for test: kms_properties
results: parsing output: 97/ for test: kms_flip_scaled_crc
results: parsing output: 98/ for test: api_intel_allocator
results: parsing output: 99/ for test: kms_plane
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: drm_read
results: parsing output: 103/ for test: gem_mmap_gtt
results: parsing output: 104/ for test: kms_setmode
results: parsing output: 105/ for test: gem_exec_capture
results: parsing output: 106/ for test: syncobj_timeline
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: i915_pm_freq_api
results: parsing output: 110/ for test: kms_cursor_crc
results: parsing output: 111/ for test: kms_color
results: parsing output: 112/ for test: drm_read
results: parsing output: 113/ for test: kms_ccs
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_chamelium_hpd
results: parsing output: 116/ for test: kms_content_protection
results: parsing output: 117/ for test: kms_pm_lpsp
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_cursor_legacy
results: parsing output: 120/ for test: perf_pmu
results: parsing output: 121/ for test: prime_vgem
results: parsing output: 122/ for test: kms_psr
results: parsing output: 123/ for test: gem_userptr_blits
results: parsing output: 124/ for test: perf
results: parsing output: 125/ for test: vgem_basic
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: kms_hdr
results: parsing output: 128/ for test: kms_joiner
results: parsing output: 129/ for test: gem_exec_params
results: parsing output: 130/ for test: perf_pmu
results: parsing output: 131/ for test: syncobj_timeline
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.