[57.549800] Initializing watchdogs
[57.549846]   /dev/watchdog0
[57.565256] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[57.569294] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.571391] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.574841] [001/132] (960s left) kms_addfb_basic (bad-pitch-128)
[57.654031] Starting subtest: bad-pitch-128
[57.656638] Subtest bad-pitch-128: SUCCESS (0.000s)
[57.777547] [002/132] (960s left) kms_busy (basic-hang)
[57.866820] Starting subtest: basic-hang
[57.869212] Starting dynamic subtest: flip-pipe-A
[58.506026] Dynamic subtest flip-pipe-A: SUCCESS (0.638s)
[58.514602] Starting dynamic subtest: modeset-pipe-A
[61.914620] Dynamic subtest modeset-pipe-A: SUCCESS (3.408s)
[61.926387] Starting dynamic subtest: flip-pipe-D
[63.106906] Dynamic subtest flip-pipe-D: SUCCESS (1.190s)
[63.117041] Starting dynamic subtest: modeset-pipe-D
[66.537561] Dynamic subtest modeset-pipe-D: SUCCESS (3.429s)
[66.540093] Subtest basic-hang: SUCCESS (8.669s)
[67.361610] [003/132] (950s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[67.437800] Starting subtest: single-wait-all-for-submit-available-submitted
[67.440417] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.001s)
[67.643176] [004/132] (950s left) gem_exec_big (single)
[67.787660] Starting subtest: single
[69.644424] Subtest single: SUCCESS (1.856s)
[69.778812] [005/132] (948s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[69.900095] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[69.904583] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[69.982648] [006/132] (948s left) kms_dsc (dsc-with-output-formats)
[70.060808] Starting subtest: dsc-with-output-formats
[70.082665] Subtest dsc-with-output-formats: SKIP (0.001s)
[70.130057] [007/132] (948s left) gem_wait (write-busy)
[70.200441] Starting subtest: write-busy
[70.202435] Starting dynamic subtest: all-engines
[70.835929] Dynamic subtest all-engines: SUCCESS (0.637s)
[70.850953] Starting dynamic subtest: rcs0
[71.384062] Dynamic subtest rcs0: SUCCESS (0.548s)
[71.398515] Starting dynamic subtest: bcs0
[71.932623] Dynamic subtest bcs0: SUCCESS (0.548s)
[71.947824] Starting dynamic subtest: vcs0
[73.882768] Dynamic subtest vcs0: SUCCESS (1.947s)
[73.897150] Starting dynamic subtest: vcs1
[75.865151] Dynamic subtest vcs1: SUCCESS (1.982s)
[75.879775] Starting dynamic subtest: vecs0
[77.849395] Dynamic subtest vecs0: SUCCESS (1.983s)
[77.864869] Starting dynamic subtest: ccs0
[78.399736] Dynamic subtest ccs0: SUCCESS (0.550s)
[78.402226] Subtest write-busy: SUCCESS (8.201s)
[78.594824] [FACT gem_wait (write-busy)] new: kernel.kmod_is_loaded.vgem: true
[78.598340] [008/132] (939s left) gem_mmap_wc (pf-nonblock)
[78.652892] Subtest pf-nonblock: SKIP (0.000s)
[78.712166] [009/132] (939s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[78.801480] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[78.805894] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[78.893984] [010/132] (939s left) sysfs_timeslice_duration (duration)
[78.964398] Starting subtest: duration
[78.966807] Starting dynamic subtest: vecs0
[93.816904] Dynamic subtest vecs0: SUCCESS (14.849s)
[93.828346] Starting dynamic subtest: ccs0
[106.959498] Dynamic subtest ccs0: SUCCESS (13.143s)
[106.970373] Starting dynamic subtest: vcs0
[121.783451] Dynamic subtest vcs0: SUCCESS (14.821s)
[121.794896] Starting dynamic subtest: bcs0
[134.918465] Dynamic subtest bcs0: SUCCESS (13.134s)
[134.929854] Starting dynamic subtest: rcs0
[148.051900] Dynamic subtest rcs0: SUCCESS (13.133s)
[148.067973] Starting dynamic subtest: vcs1
[161.783726] Dynamic subtest vcs1: SUCCESS (13.727s)
[161.786787] Subtest duration: SUCCESS (82.815s)
[161.858781] [011/132] (856s left) gem_render_copy (yf-tiled-to-vebox-linear)
[161.919259] Starting subtest: yf-tiled-to-vebox-linear
[161.923762] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[162.106838] [012/132] (856s left) gem_spin_batch (legacy)
[162.154516] Starting subtest: legacy
[162.157579] Starting dynamic subtest: default
[165.397374] Dynamic subtest default: SUCCESS (3.237s)
[165.407664] Starting dynamic subtest: render
[168.631051] Dynamic subtest render: SUCCESS (3.232s)
[168.640967] Starting dynamic subtest: bsd
[171.868393] Dynamic subtest bsd: SUCCESS (3.235s)
[171.878536] Starting dynamic subtest: bsd1
[175.105684] Dynamic subtest bsd1: SUCCESS (3.235s)
[175.114637] Starting dynamic subtest: bsd2
[178.337627] Dynamic subtest bsd2: SUCCESS (3.232s)
[178.346239] Starting dynamic subtest: blt
[181.573454] Dynamic subtest blt: SUCCESS (3.234s)
[181.582627] Starting dynamic subtest: vebox
[184.808774] Dynamic subtest vebox: SUCCESS (3.234s)
[184.810985] Subtest legacy: SUCCESS (22.649s)
[184.996981] [013/132] (833s left) sw_sync (sync_multi_consumer_producer)
[185.046109] Starting subtest: sync_multi_consumer_producer
[185.368591] Subtest sync_multi_consumer_producer: SUCCESS (0.321s)
[185.429909] [014/132] (833s left) kms_pm_dc (dc9-dpms)
[186.516141] Starting subtest: dc9-dpms
[187.929455] Subtest dc9-dpms: SUCCESS (1.412s)
[188.009039] [015/132] (830s left) kms_pm_rpm (pm-tiling)
[190.046471] Starting subtest: pm-tiling
[190.051852] Subtest pm-tiling: SKIP (0.000s)
[190.420078] [016/132] (828s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[190.496748] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[197.556320] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.065s)
[197.669553] [017/132] (821s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[197.752829] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[197.755182] Starting dynamic subtest: pipe-A-eDP-1
[197.812585] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[197.821821] Starting dynamic subtest: pipe-B-eDP-1
[197.879412] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[197.888582] Starting dynamic subtest: pipe-C-eDP-1
[197.945221] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[197.954284] Starting dynamic subtest: pipe-D-eDP-1
[198.011403] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[198.015690] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.007s)
[200.000086] [018/132] (818s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[200.084271] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[200.088560] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[200.203789] [019/132] (818s left) gem_ctx_engines (execute-oneforall)
[200.266061] Starting subtest: execute-oneforall
[200.740734] Subtest execute-oneforall: SUCCESS (0.474s)
[201.994652] [020/132] (816s left) perf_pmu (idle)
[202.036577] Starting subtest: idle
[202.038826] Starting dynamic subtest: rcs0
[202.572828] Dynamic subtest rcs0: SUCCESS (0.536s)
[202.584876] Starting dynamic subtest: bcs0
[203.103176] Dynamic subtest bcs0: SUCCESS (0.528s)
[203.114938] Starting dynamic subtest: vcs0
[203.630777] Dynamic subtest vcs0: SUCCESS (0.527s)
[203.641945] Starting dynamic subtest: vcs1
[204.150093] Dynamic subtest vcs1: SUCCESS (0.517s)
[204.161868] Starting dynamic subtest: vecs0
[204.672656] Dynamic subtest vecs0: SUCCESS (0.521s)
[204.684855] Starting dynamic subtest: ccs0
[205.196208] Dynamic subtest ccs0: SUCCESS (0.521s)
[205.199018] Subtest idle: SUCCESS (3.160s)
[205.312787] [021/132] (813s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[205.410499] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[212.432834] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.026s)
[212.544216] [022/132] (806s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[212.644618] Starting subtest: cursorB-vs-flipA-toggle
[212.649715] Subtest cursorB-vs-flipA-toggle: SKIP (0.002s)
[212.806833] [023/132] (806s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[212.867924] Starting subtest: etime-multi-wait-all-available-unsubmitted
[212.974041] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.105s)
[213.063630] [024/132] (805s left) gem_exec_schedule (u-independent)
[213.125321] Starting subtest: u-independent
[213.127719] Starting dynamic subtest: rcs0
[214.874930] Dynamic subtest rcs0: SUCCESS (1.756s)
[214.887063] Starting dynamic subtest: vcs0
[216.868227] Dynamic subtest vcs0: SUCCESS (1.992s)
[216.880037] Starting dynamic subtest: vcs1
[218.849780] Dynamic subtest vcs1: SUCCESS (1.982s)
[218.861064] Starting dynamic subtest: vecs0
[220.842705] Dynamic subtest vecs0: SUCCESS (1.992s)
[220.854196] Starting dynamic subtest: ccs0
[222.810414] Dynamic subtest ccs0: SUCCESS (1.964s)
[222.813156] Subtest u-independent: SUCCESS (9.692s)
[223.110348] [025/132] (795s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[223.196205] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[223.200297] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s)
[223.266058] [026/132] (795s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[223.352759] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[223.357197] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[223.466890] [027/132] (795s left) prime_vgem (basic-fence-blt)
[223.544757] Starting subtest: basic-fence-blt
[223.626959] Subtest basic-fence-blt: SUCCESS (0.082s)
[223.761923] [028/132] (795s left) kms_color_pipeline (plane-ctm3x4)
[223.849331] Starting subtest: plane-ctm3x4
[223.973673] Starting dynamic subtest: pipe-A-plane-0
[224.096560] Dynamic subtest pipe-A-plane-0: SUCCESS (0.122s)
[224.105994] Starting dynamic subtest: pipe-A-plane-1
[224.205719] Dynamic subtest pipe-A-plane-1: SUCCESS (0.111s)
[224.214566] Starting dynamic subtest: pipe-A-plane-2
[224.316846] Dynamic subtest pipe-A-plane-2: SUCCESS (0.111s)
[225.493978] Starting dynamic subtest: pipe-B-plane-0
[225.620988] Dynamic subtest pipe-B-plane-0: SUCCESS (0.133s)
[225.630779] Starting dynamic subtest: pipe-B-plane-1
[225.731591] Dynamic subtest pipe-B-plane-1: SUCCESS (0.111s)
[225.740701] Starting dynamic subtest: pipe-B-plane-2
[225.843493] Dynamic subtest pipe-B-plane-2: SUCCESS (0.111s)
[227.030324] Starting dynamic subtest: pipe-C-plane-0
[227.134051] Dynamic subtest pipe-C-plane-0: SUCCESS (0.111s)
[227.143699] Starting dynamic subtest: pipe-C-plane-1
[227.256283] Dynamic subtest pipe-C-plane-1: SUCCESS (0.122s)
[227.265556] Starting dynamic subtest: pipe-C-plane-2
[227.378628] Dynamic subtest pipe-C-plane-2: SUCCESS (0.122s)
[228.555669] Starting dynamic subtest: pipe-D-plane-0
[228.660044] Dynamic subtest pipe-D-plane-0: SUCCESS (0.111s)
[228.668740] Starting dynamic subtest: pipe-D-plane-1
[228.784926] Dynamic subtest pipe-D-plane-1: SUCCESS (0.123s)
[228.794638] Starting dynamic subtest: pipe-D-plane-2
[228.904480] Dynamic subtest pipe-D-plane-2: SUCCESS (0.121s)
[229.195849] Subtest plane-ctm3x4: SUCCESS (5.347s)
[230.030114] [029/132] (789s left) kms_flip (plain-flip-ts-check)
[230.107275] Starting subtest: plain-flip-ts-check
[230.109546] Starting dynamic subtest: A-eDP1
[239.022135] Dynamic subtest A-eDP1: SUCCESS (8.916s)
[239.034360] Starting dynamic subtest: B-eDP1
[247.852805] Dynamic subtest B-eDP1: SUCCESS (8.830s)
[247.862772] Starting dynamic subtest: C-eDP1
[256.674840] Dynamic subtest C-eDP1: SUCCESS (8.820s)
[256.688046] Starting dynamic subtest: D-eDP1
[265.525151] Dynamic subtest D-eDP1: SUCCESS (8.848s)
[265.530230] Subtest plain-flip-ts-check: SUCCESS (35.424s)
[266.708965] [030/132] (752s left) kms_psr (pr-suspend)
[266.793838] Starting subtest: pr-suspend
[266.797807] Subtest pr-suspend: SKIP (0.000s)
[266.865190] [031/132] (752s left) gem_render_copy (y-tiled-ccs-to-linear)
[266.919220] Starting subtest: y-tiled-ccs-to-linear
[266.923678] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[267.103684] [032/132] (752s left) kms_chamelium_frames (dp-crc-fast)
[267.475478] Subtest dp-crc-fast: SKIP (0.000s)
[268.327872] [033/132] (751s left) kms_frontbuffer_tracking (psr-slowdraw)
[268.415994] Starting subtest: psr-slowdraw
[293.598041] Subtest psr-slowdraw: SUCCESS (25.185s)
[293.718491] [034/132] (725s left) gem_mmap_wc (copy)
[293.784501] Subtest copy: SKIP (0.000s)
[293.864798] [035/132] (725s left) syncobj_wait (invalid-signal-one-illegal-handle)
[293.917185] Starting subtest: invalid-signal-one-illegal-handle
[293.919421] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[294.018203] [036/132] (725s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[294.096978] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[294.104266] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.008s)
[294.216722] [037/132] (725s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[294.265258] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[294.267601] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[294.378421] [038/132] (725s left) kms_psr (fbc-psr2-primary-blt)
[294.454098] Starting subtest: fbc-psr2-primary-blt
[294.455966] Starting dynamic subtest: eDP-1
[294.459192] Dynamic subtest eDP-1: SKIP (0.000s)
[294.462652] Subtest fbc-psr2-primary-blt: SKIP (0.001s)
[294.527373] [039/132] (725s left) kms_force_connector_basic (prune-stale-modes)
[294.585217] Subtest prune-stale-modes: SKIP (0.000s)
[294.645914] [040/132] (725s left) gen9_exec_parse (unaligned-access)
[294.709251] Subtest unaligned-access: SKIP (0.000s)
[294.790829] [041/132] (724s left) syncobj_timeline (etime-single-wait-all-submitted)
[294.844445] Starting subtest: etime-single-wait-all-submitted
[294.950120] Subtest etime-single-wait-all-submitted: SUCCESS (0.103s)
[295.023782] [042/132] (724s left) gem_userptr_blits (stress-mm-invalidate-close)
[295.103231] Starting subtest: stress-mm-invalidate-close
[297.253045] Subtest stress-mm-invalidate-close: SUCCESS (2.148s)
[297.392295] [043/132] (722s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[297.441284] Starting subtest: multi-wait-all-for-submit-submitted
[297.549103] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.108s)
[297.629396] [044/132] (722s left) gem_userptr_blits (unsync-unmap-after-close)
[297.704148] Subtest unsync-unmap-after-close: SKIP (0.000s)
[297.818126] [045/132] (722s left) gem_exec_parallel (userptr)
[297.887026] Starting subtest: userptr
[297.889235] Starting dynamic subtest: rcs0
[299.415907] Dynamic subtest rcs0: SUCCESS (1.531s)
[299.428079] Starting dynamic subtest: bcs0
[300.922313] Dynamic subtest bcs0: SUCCESS (1.505s)
[300.934527] Starting dynamic subtest: vcs0
[302.809210] Dynamic subtest vcs0: SUCCESS (1.883s)
[302.819037] Starting dynamic subtest: vcs1
[304.857162] Dynamic subtest vcs1: SUCCESS (2.045s)
[304.866889] Starting dynamic subtest: vecs0
[306.841232] Dynamic subtest vecs0: SUCCESS (1.982s)
[306.852663] Starting dynamic subtest: ccs0
[308.350528] Dynamic subtest ccs0: SUCCESS (1.508s)
[308.352886] Subtest userptr: SUCCESS (10.466s)
[308.536884] [046/132] (711s left) gem_lmem_evict (dontneed-evict-race)
[308.583696] Subtest dontneed-evict-race: SKIP (0.000s)
[308.621548] [047/132] (711s left) i915_pm_rc6_residency (rc6-fence)
[308.679808] Starting subtest: rc6-fence
[308.710447] Starting dynamic subtest: gt0
[321.032427] Dynamic subtest gt0: SUCCESS (12.321s)
[321.044076] Starting dynamic subtest: gt1
[335.833618] Dynamic subtest gt1: SUCCESS (14.798s)
[335.836282] Subtest rc6-fence: SUCCESS (27.153s)
[335.949413] [048/132] (684s left) syncobj_timeline (invalid-query-one-illegal-handle)
[336.028306] Starting subtest: invalid-query-one-illegal-handle
[336.030722] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s)
[336.142489] [049/132] (683s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[336.214255] Starting subtest: multiplane-rotation-cropping-bottom
[353.605689] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.393s)
[353.715495] [050/132] (666s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[353.800581] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[353.803882] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[353.894658] [051/132] (666s left) kms_concurrent (multi-plane-atomic-lowres)
[353.975720] Starting subtest: multi-plane-atomic-lowres
[353.977625] Starting dynamic subtest: pipe-A-eDP-1
[354.438834] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.463s)
[354.448707] Starting dynamic subtest: pipe-B-eDP-1
[355.739974] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.299s)
[355.751867] Starting dynamic subtest: pipe-C-eDP-1
[356.949866] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.209s)
[356.959978] Starting dynamic subtest: pipe-D-eDP-1
[358.173318] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.221s)
[358.175656] Subtest multi-plane-atomic-lowres: SUCCESS (4.197s)
[359.014161] [052/132] (661s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[359.087506] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[363.963971] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.880s)
[365.114446] [053/132] (655s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[365.197826] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[371.890490] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.697s)
[372.043175] [054/132] (648s left) gem_ctx_isolation (preservation-reset)
[372.225572] Starting subtest: preservation-reset
[372.227788] Starting dynamic subtest: rcs0
[372.499717] Dynamic subtest rcs0: SUCCESS (0.278s)
[372.510490] Starting dynamic subtest: bcs0
[372.816942] Dynamic subtest bcs0: SUCCESS (0.316s)
[372.827516] Starting dynamic subtest: vcs0
[373.139546] Dynamic subtest vcs0: SUCCESS (0.321s)
[373.150270] Starting dynamic subtest: vcs1
[375.158860] Dynamic subtest vcs1: SUCCESS (2.018s)
[375.172592] Starting dynamic subtest: vecs0
[377.146579] Dynamic subtest vecs0: SUCCESS (1.987s)
[377.158527] Starting dynamic subtest: ccs0
[379.145813] Dynamic subtest ccs0: SUCCESS (1.997s)
[379.149520] Subtest preservation-reset: SUCCESS (6.926s)
[379.299217] [055/132] (641s left) gem_ctx_persistence (smoketest)
[379.387415] Starting subtest: smoketest
[419.836834] Subtest smoketest: SUCCESS (40.441s)
[419.913250] [056/132] (600s left) kms_vrr (flip-basic)
[419.998429] Starting subtest: flip-basic
[420.003903] Subtest flip-basic: SKIP (0.000s)
[420.069205] [057/132] (600s left) kms_atomic_transition (plane-all-transition-nonblocking)
[420.143695] Starting subtest: plane-all-transition-nonblocking
[420.146021] Starting dynamic subtest: pipe-A-eDP-1
[422.636716] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.494s)
[422.942821] Starting dynamic subtest: pipe-B-eDP-1
[426.145465] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.213s)
[426.463437] Subtest plane-all-transition-nonblocking: SUCCESS (6.319s)
[427.276451] [058/132] (593s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[427.342201] Subtest no-spare-fences-busy: SKIP (0.000s)
[427.416102] [059/132] (593s left) perf (invalid-remove-userspace-config)
[427.539031] Starting subtest: invalid-remove-userspace-config
[427.545088] Subtest invalid-remove-userspace-config: SUCCESS (0.008s)
[427.589047] [060/132] (592s left) kms_psr (psr2-sprite-mmap-gtt)
[427.658634] Starting subtest: psr2-sprite-mmap-gtt
[427.660886] Starting dynamic subtest: eDP-1
[429.081842] Dynamic subtest eDP-1: SKIP (1.419s)
[429.086796] Subtest psr2-sprite-mmap-gtt: SKIP (1.421s)
[429.210789] [061/132] (591s left) i915_query (query-regions-unallocated)
[429.274012] Starting subtest: query-regions-unallocated
[429.276244] Subtest query-regions-unallocated: SUCCESS (0.000s)
[429.379565] [062/132] (591s left) gem_mmap_offset (open-flood)
[429.429953] Starting subtest: open-flood
[450.917300] Subtest open-flood: SUCCESS (21.489s)
[451.041543] [063/132] (569s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[451.117922] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[451.121431] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[451.194948] [064/132] (569s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[451.274075] Starting subtest: y-tiled-16bpp-rotate-90
[451.277633] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[451.361623] [065/132] (569s left) gem_exec_reloc (basic-write-cpu-active)
[451.422966] Subtest basic-write-cpu-active: SKIP (0.000s)
[451.491349] [066/132] (569s left) kms_addfb_basic (bad-pitch-32)
[451.539161] Starting subtest: bad-pitch-32
[451.540902] Subtest bad-pitch-32: SUCCESS (0.000s)
[451.662229] [067/132] (569s left) kms_big_fb (linear-16bpp-rotate-90)
[451.750253] Starting subtest: linear-16bpp-rotate-90
[451.769821] Subtest linear-16bpp-rotate-90: SKIP (0.019s)
[451.880602] [068/132] (568s left) gem_exec_gttfill (basic)
[451.935165] Starting subtest: basic
[454.450069] Subtest basic: SUCCESS (2.513s)
[454.641357] [069/132] (566s left) gem_ccs (ctrl-surf-copy)
[454.738765] Starting subtest: ctrl-surf-copy
[454.743897] Subtest ctrl-surf-copy: SKIP (0.000s)
[454.833934] [070/132] (566s left) kms_dp_link_training (non-uhbr-sst)
[454.913779] Starting subtest: non-uhbr-sst
[454.921872] Subtest non-uhbr-sst: SKIP (0.000s)
[454.997496] [071/132] (565s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[455.070044] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[455.072729] Starting dynamic subtest: pipe-A-eDP-1
[455.966428] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.887s)
[455.977691] Starting dynamic subtest: pipe-B-eDP-1
[457.579555] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.611s)
[457.589347] Starting dynamic subtest: pipe-C-eDP-1
[459.209312] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.630s)
[459.219805] Starting dynamic subtest: pipe-D-eDP-1
[460.669365] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.459s)
[460.671661] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.593s)
[461.834673] [072/132] (559s left) gem_eio (wait-immediate)
[462.050185] Starting subtest: wait-immediate
[462.402266] Subtest wait-immediate: SUCCESS (0.352s)
[462.544436] [073/132] (558s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[462.637922] Starting subtest: fbc-modesetfrombusy
[466.490948] Subtest fbc-modesetfrombusy: SUCCESS (3.856s)
[467.655406] [074/132] (553s left) dumb_buffer (create-valid-dumb)
[467.712117] Starting subtest: create-valid-dumb
[467.714448] Subtest create-valid-dumb: SUCCESS (0.000s)
[467.814162] [075/132] (553s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[467.876050] Starting subtest: map-fixed-invalidate-overlap-busy
[467.880572] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[468.003420] [076/132] (553s left) kms_atomic_interruptible (legacy-setmode)
[468.075566] Starting subtest: legacy-setmode
[468.077754] Starting dynamic subtest: pipe-A-eDP-1
[474.985928] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.909s)
[474.988298] Subtest legacy-setmode: SUCCESS (6.910s)
[475.852656] [077/132] (545s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[475.943029] Starting subtest: fbc-pr-cursor-mmap-gtt
[475.947494] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[476.029606] [078/132] (545s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[476.166800] Starting subtest: cursor-rapid-movement-32x32
[476.214122] Subtest cursor-rapid-movement-32x32: SKIP (0.042s)
[476.503431] [079/132] (544s left) kms_plane (pixel-format-x-tiled-modifier)
[476.573939] Starting subtest: pixel-format-x-tiled-modifier
[476.601888] Starting dynamic subtest: pipe-A-plane-0
[477.256557] Dynamic subtest pipe-A-plane-0: SUCCESS (0.655s)
[477.265886] Starting dynamic subtest: pipe-A-plane-3
[477.667911] Dynamic subtest pipe-A-plane-3: SUCCESS (0.410s)
[477.679280] Starting dynamic subtest: pipe-A-plane-5
[477.682996] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[478.736394] Starting dynamic subtest: pipe-B-plane-0
[479.386818] Dynamic subtest pipe-B-plane-0: SUCCESS (0.655s)
[479.397396] Starting dynamic subtest: pipe-B-plane-3
[479.806060] Dynamic subtest pipe-B-plane-3: SUCCESS (0.421s)
[479.819490] Starting dynamic subtest: pipe-B-plane-5
[479.825513] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[480.119884] Subtest pixel-format-x-tiled-modifier: SUCCESS (3.545s)
[480.941909] [080/132] (540s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[481.041439] Starting subtest: 4-tiled-addfb-size-offset-overflow
[481.043758] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[481.147390] [081/132] (540s left) kms_selftest (drm_plane_helper)
[481.191211] Starting subtest: drm_plane_helper
[481.246580] Starting dynamic subtest: drm_test_check_plane_state
[481.336996] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.089s)
[481.350230] Starting dynamic subtest: drm_test_check_invalid_plane_state
[481.446040] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.110s)
[481.448565] Subtest drm_plane_helper: SUCCESS (0.255s)
[481.601779] [082/132] (539s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[481.687222] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[481.691398] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[481.790123] [083/132] (539s left) kms_chamelium_hpd (hdmi-hpd)
[482.162816] Subtest hdmi-hpd: SKIP (0.000s)
[483.036508] [084/132] (538s left) kms_invalid_mode (int-max-clock)
[483.118305] Starting subtest: int-max-clock
[483.120665] Starting dynamic subtest: pipe-A-eDP-1
[483.404220] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[483.414085] Starting dynamic subtest: pipe-B-eDP-1
[483.416602] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[483.425491] Starting dynamic subtest: pipe-C-eDP-1
[483.427987] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[483.437977] Starting dynamic subtest: pipe-D-eDP-1
[483.440434] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[483.442808] Subtest int-max-clock: SUCCESS (0.290s)
[484.261778] [085/132] (537s left) gem_exec_suspend (basic-s0)
[484.327482] Starting subtest: basic-S0
[484.330069] Starting dynamic subtest: smem
[504.492553] Dynamic subtest smem: SUCCESS (6.510s)
[504.495841] Subtest basic-S0: SUCCESS (6.512s)
[504.679702] [086/132] (516s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[504.769945] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[504.774111] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[504.877407] [087/132] (516s left) gem_exec_reloc (basic-gtt-read-active)
[504.944796] Subtest basic-gtt-read-active: SKIP (0.000s)
[505.017627] [088/132] (516s left) gem_exec_schedule (preempt-queue)
[505.094510] Subtest preempt-queue: SKIP (0.000s)
[505.395075] [089/132] (516s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[505.469252] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[505.477431] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.009s)
[505.560125] [090/132] (516s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[505.618769] Starting subtest: yf-tiled-ccs-to-yf-tiled
[505.623191] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[505.803912] [091/132] (516s left) api_intel_allocator (open-vm)
[505.853134] Starting subtest: open-vm
[505.855708] Subtest open-vm: SUCCESS (0.004s)
[505.990319] [092/132] (515s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[506.066974] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[506.069210] Starting dynamic subtest: pipe-A-eDP-1
[506.092780] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[506.103599] Starting dynamic subtest: pipe-B-eDP-1
[506.126143] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[506.135347] Starting dynamic subtest: pipe-C-eDP-1
[506.158238] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[506.167637] Starting dynamic subtest: pipe-D-eDP-1
[506.191752] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[506.195813] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[508.388261] [093/132] (513s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[508.456460] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[515.261044] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.802s)
[515.386192] [094/132] (506s left) kms_lease (lease-invalid-plane)
[515.472303] Starting subtest: lease-invalid-plane
[515.474669] Starting dynamic subtest: pipe-A-eDP-1
[515.476856] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[515.486579] Starting dynamic subtest: pipe-B-eDP-1
[515.488740] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[515.498001] Starting dynamic subtest: pipe-C-eDP-1
[515.499838] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[515.509010] Starting dynamic subtest: pipe-D-eDP-1
[515.511161] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[515.513285] Subtest lease-invalid-plane: SUCCESS (0.005s)
[515.550094] [095/132] (506s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[515.626287] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[515.628504] Starting dynamic subtest: pipe-A
[515.648814] Dynamic subtest pipe-A: SKIP (0.018s)
[515.659406] Starting dynamic subtest: pipe-B
[515.683944] Dynamic subtest pipe-B: SKIP (0.036s)
[515.693465] Starting dynamic subtest: pipe-C
[515.718149] Dynamic subtest pipe-C: SKIP (0.031s)
[515.727317] Starting dynamic subtest: pipe-D
[515.750465] Dynamic subtest pipe-D: SKIP (0.033s)
[515.754227] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.120s)
[515.844314] [096/132] (506s left) core_auth (getclient-simple)
[515.884820] Starting subtest: getclient-simple
[515.900648] Subtest getclient-simple: SUCCESS (0.015s)
[516.015734] [097/132] (506s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[516.081810] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[516.086178] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[516.174621] [098/132] (505s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[516.272520] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area
[516.275870] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[516.344781] [099/132] (505s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[516.423693] Starting subtest: fbc-psr-sprite-mmap-cpu
[516.425657] Starting dynamic subtest: eDP-1
[516.429210] Dynamic subtest eDP-1: SKIP (0.000s)
[516.432474] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.001s)
[516.498602] [100/132] (505s left) vgem_basic (dmabuf-fence-before)
[516.550427] Starting subtest: dmabuf-fence-before
[516.552441] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[516.609366] [101/132] (505s left) kms_plane (planar-pixel-format-settings)
[516.680115] Starting subtest: planar-pixel-format-settings
[516.749267] Subtest planar-pixel-format-settings: SUCCESS (0.070s)
[516.854019] [102/132] (505s left) gen9_exec_parse (bb-start-far)
[516.911847] Subtest bb-start-far: SKIP (0.000s)
[516.976802] [103/132] (505s left) kms_addfb_basic (basic-y-tiled-legacy)
[517.024349] Starting subtest: basic-y-tiled-legacy
[517.027534] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[517.150221] [104/132] (505s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[517.231807] Starting subtest: disable-crc-after-crtc
[517.233692] Starting dynamic subtest: pipe-A-eDP-1
[518.864865] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.633s)
[518.875778] Starting dynamic subtest: pipe-B-eDP-1
[521.141597] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.273s)
[521.152306] Starting dynamic subtest: pipe-C-eDP-1
[523.386408] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.242s)
[523.397430] Starting dynamic subtest: pipe-D-eDP-1
[525.648032] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.260s)
[525.650284] Subtest disable-crc-after-crtc: SUCCESS (8.415s)
[526.487142] [105/132] (495s left) kms_cursor_crc (cursor-suspend)
[526.606081] Starting subtest: cursor-suspend
[526.607958] Starting dynamic subtest: pipe-A-eDP-1
[559.116406] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.216s)
[559.127888] Starting dynamic subtest: pipe-D-eDP-1
[593.122733] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.850s)
[593.124825] Subtest cursor-suspend: SUCCESS (7.069s)
[593.924252] [106/132] (428s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[593.980634] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[594.045303] [107/132] (428s left) gem_create (create-invalid-size)
[594.096435] Starting subtest: create-invalid-size
[594.098313] Subtest create-invalid-size: SUCCESS (0.000s)
[594.280997] [108/132] (428s left) kms_async_flips (test-time-stamp-atomic)
[594.351737] Starting subtest: test-time-stamp-atomic
[594.730585] Starting dynamic subtest: pipe-A-eDP-1
[595.527568] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.794s)
[595.909013] Starting dynamic subtest: pipe-B-eDP-1
[596.665538] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.763s)
[597.032376] Starting dynamic subtest: pipe-C-eDP-1
[597.795702] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.770s)
[598.159359] Starting dynamic subtest: pipe-D-eDP-1
[598.931933] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.779s)
[598.934331] Subtest test-time-stamp-atomic: SUCCESS (4.580s)
[600.097452] [109/132] (422s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[600.171573] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[600.175519] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[600.262806] [110/132] (422s left) sw_sync (alloc_timeline)
[600.299898] Starting subtest: alloc_timeline
[600.302147] Subtest alloc_timeline: SUCCESS (0.000s)
[600.363330] [111/132] (422s left) gem_lmem_swapping (parallel-random-verify-ccs)
[600.405387] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[600.449911] [112/132] (422s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[600.518764] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[600.522842] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[600.620615] [113/132] (422s left) gem_exec_fence (parallel)
[600.803357] Starting subtest: parallel
[600.805799] Starting dynamic subtest: rcs0
[602.954342] Dynamic subtest rcs0: SUCCESS (2.151s)
[602.967238] Starting dynamic subtest: bcs0
[605.108891] Dynamic subtest bcs0: SUCCESS (2.153s)
[605.121199] Starting dynamic subtest: vcs0
[607.262297] Dynamic subtest vcs0: SUCCESS (2.152s)
[607.275132] Starting dynamic subtest: vcs1
[609.411179] Dynamic subtest vcs1: SUCCESS (2.148s)
[609.422231] Starting dynamic subtest: vecs0
[611.564843] Dynamic subtest vecs0: SUCCESS (2.152s)
[611.576161] Starting dynamic subtest: ccs0
[613.718013] Dynamic subtest ccs0: SUCCESS (2.152s)
[613.720084] Subtest parallel: SUCCESS (12.913s)
[614.362957] [114/132] (408s left) gem_exec_params (invalid-ring)
[614.431747] Starting subtest: invalid-ring
[614.434064] Subtest invalid-ring: SUCCESS (0.000s)
[614.573718] [115/132] (408s left) kms_flip (plain-flip-interruptible)
[614.654770] Starting subtest: plain-flip-interruptible
[614.657135] Starting dynamic subtest: A-eDP1
[616.292754] Dynamic subtest A-eDP1: SUCCESS (1.636s)
[616.309064] Starting dynamic subtest: B-eDP1
[617.933726] Dynamic subtest B-eDP1: SUCCESS (1.638s)
[617.948472] Starting dynamic subtest: C-eDP1
[619.562729] Dynamic subtest C-eDP1: SUCCESS (1.626s)
[619.573556] Starting dynamic subtest: D-eDP1
[621.185421] Dynamic subtest D-eDP1: SUCCESS (1.620s)
[621.190699] Subtest plain-flip-interruptible: SUCCESS (6.534s)
[622.357269] [116/132] (400s left) kms_plane_lowres (tiling-y)
[622.440346] Starting subtest: tiling-y
[622.444656] Subtest tiling-y: SKIP (0.000s)
[622.517015] [117/132] (400s left) kms_flip (flip-vs-wf_vblank-interruptible)
[622.596913] Starting subtest: flip-vs-wf_vblank-interruptible
[622.599168] Starting dynamic subtest: A-eDP1
[624.492623] Dynamic subtest A-eDP1: SUCCESS (1.892s)
[624.504466] Starting dynamic subtest: B-eDP1
[626.420367] Dynamic subtest B-eDP1: SUCCESS (1.924s)
[626.432719] Starting dynamic subtest: C-eDP1
[628.338452] Dynamic subtest C-eDP1: SUCCESS (1.914s)
[628.349725] Starting dynamic subtest: D-eDP1
[630.266788] Dynamic subtest D-eDP1: SUCCESS (1.926s)
[630.272206] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.666s)
[631.496958] [118/132] (391s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[631.569637] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[631.574307] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[632.731267] [119/132] (390s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[632.804283] Starting subtest: yf-tiled-32bpp-rotate-270
[632.808813] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[632.899734] [120/132] (390s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf)
[632.978268] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf
[632.982242] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[633.059468] [121/132] (390s left) kms_flip (flip-vs-rmfb-interruptible)
[633.131495] Starting subtest: flip-vs-rmfb-interruptible
[633.133761] Starting dynamic subtest: A-eDP1
[641.820737] Dynamic subtest A-eDP1: SUCCESS (8.685s)
[641.834510] Starting dynamic subtest: B-eDP1
[650.451067] Dynamic subtest B-eDP1: SUCCESS (8.624s)
[650.466389] Starting dynamic subtest: C-eDP1
[659.061291] Dynamic subtest C-eDP1: SUCCESS (8.606s)
[659.074433] Starting dynamic subtest: D-eDP1
[667.730653] Dynamic subtest D-eDP1: SUCCESS (8.667s)
[667.734882] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.598s)
[668.893054] [122/132] (354s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[668.973868] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[668.976194] Starting dynamic subtest: pipe-A-eDP-1
[668.998167] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[669.010615] Starting dynamic subtest: pipe-B-eDP-1
[669.031080] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[669.041265] Starting dynamic subtest: pipe-C-eDP-1
[669.062060] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[669.071668] Starting dynamic subtest: pipe-D-eDP-1
[669.094104] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[669.098474] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.008s)
[671.169108] [123/132] (351s left) gem_exec_balancer (bonded-pair)
[671.227913] Starting subtest: bonded-pair
[671.232511] Subtest bonded-pair: SKIP (0.000s)
[671.552888] [124/132] (351s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[671.629493] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[671.633590] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[671.745202] [125/132] (351s left) kms_rotation_crc (exhaust-fences)
[671.823518] Starting subtest: exhaust-fences
[671.827338] Subtest exhaust-fences: SKIP (0.000s)
[671.911895] [126/132] (351s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[672.003334] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[676.440522] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.440s)
[677.573286] [127/132] (345s left) gem_exec_params (invalid-ring2)
[677.623483] Starting subtest: invalid-ring2
[677.625910] Subtest invalid-ring2: SUCCESS (0.000s)
[677.719811] [128/132] (345s left) i915_pciid
[677.853224] [129/132] (345s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[677.936475] Starting subtest: x-tiled-64bpp-rotate-0
[679.392709] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.458s)
[679.572002] [130/132] (343s left) kms_cursor_crc (cursor-onscreen-32x32)
[679.709696] Starting subtest: cursor-onscreen-32x32
[679.758801] Subtest cursor-onscreen-32x32: SKIP (0.042s)
[680.036992] [131/132] (343s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[680.110446] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[680.114327] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s)
[680.195633] [132/132] (343s left) perf_pmu (busy-double-start)
[680.241205] Starting subtest: busy-double-start
[680.243213] Starting dynamic subtest: rcs0
[683.836804] Dynamic subtest rcs0: SUCCESS (3.597s)
[683.849710] Starting dynamic subtest: bcs0
[687.428874] Dynamic subtest bcs0: SUCCESS (3.589s)
[687.442058] Starting dynamic subtest: vcs0
[691.438994] Dynamic subtest vcs0: SUCCESS (4.007s)
[691.452240] Starting dynamic subtest: vcs1
[695.456960] Dynamic subtest vcs1: SUCCESS (4.015s)
[695.469521] Starting dynamic subtest: vecs0
[699.423014] Dynamic subtest vecs0: SUCCESS (3.963s)
[699.435727] Starting dynamic subtest: ccs0
[703.067267] Dynamic subtest ccs0: FAIL (3.587s)
[703.069336] Subtest busy-double-start: FAIL (22.770s)
[703.108870] Closing watchdogs
results: parsing output: 0/ for test: kms_addfb_basic
results: parsing output: 1/ for test: kms_busy
results: parsing output: 2/ for test: syncobj_timeline
results: parsing output: 3/ for test: gem_exec_big
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_dsc
results: parsing output: 6/ for test: gem_wait
results: parsing output: 7/ for test: gem_mmap_wc
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: sysfs_timeslice_duration
results: parsing output: 10/ for test: gem_render_copy
results: parsing output: 11/ for test: gem_spin_batch
results: parsing output: 12/ for test: sw_sync
results: parsing output: 13/ for test: kms_pm_dc
results: parsing output: 14/ for test: kms_pm_rpm
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: gem_ctx_engines
results: parsing output: 19/ for test: perf_pmu
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_cursor_legacy
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: gem_exec_schedule
results: parsing output: 24/ for test: kms_flip_scaled_crc
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: prime_vgem
results: parsing output: 27/ for test: kms_color_pipeline
results: parsing output: 28/ for test: kms_flip
results: parsing output: 29/ for test: kms_psr
results: parsing output: 30/ for test: gem_render_copy
results: parsing output: 31/ for test: kms_chamelium_frames
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: gem_mmap_wc
results: parsing output: 34/ for test: syncobj_wait
results: parsing output: 35/ for test: kms_flip
results: parsing output: 36/ for test: syncobj_timeline
results: parsing output: 37/ for test: kms_psr
results: parsing output: 38/ for test: kms_force_connector_basic
results: parsing output: 39/ for test: gen9_exec_parse
results: parsing output: 40/ for test: syncobj_timeline
results: parsing output: 41/ for test: gem_userptr_blits
results: parsing output: 42/ for test: syncobj_wait
results: parsing output: 43/ for test: gem_userptr_blits
results: parsing output: 44/ for test: gem_exec_parallel
results: parsing output: 45/ for test: gem_lmem_evict
results: parsing output: 46/ for test: i915_pm_rc6_residency
results: parsing output: 47/ for test: syncobj_timeline
results: parsing output: 48/ for test: kms_rotation_crc
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_concurrent
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: gem_ctx_isolation
results: parsing output: 54/ for test: gem_ctx_persistence
results: parsing output: 55/ for test: kms_vrr
results: parsing output: 56/ for test: kms_atomic_transition
results: parsing output: 57/ for test: gem_fenced_exec_thrash
results: parsing output: 58/ for test: perf
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: i915_query
results: parsing output: 61/ for test: gem_mmap_offset
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: gem_exec_reloc
results: parsing output: 65/ for test: kms_addfb_basic
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: gem_exec_gttfill
results: parsing output: 68/ for test: gem_ccs
results: parsing output: 69/ for test: kms_dp_link_training
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: gem_eio
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: dumb_buffer
results: parsing output: 74/ for test: gem_userptr_blits
results: parsing output: 75/ for test: kms_atomic_interruptible
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: kms_cursor_crc
results: parsing output: 78/ for test: kms_plane
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: kms_selftest
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_chamelium_hpd
results: parsing output: 83/ for test: kms_invalid_mode
results: parsing output: 84/ for test: gem_exec_suspend
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_exec_reloc
results: parsing output: 87/ for test: gem_exec_schedule
results: parsing output: 88/ for test: kms_flip
results: parsing output: 89/ for test: gem_render_copy
results: parsing output: 90/ for test: api_intel_allocator
results: parsing output: 91/ for test: kms_ccs
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_lease
results: parsing output: 94/ for test: kms_plane_scaling
results: parsing output: 95/ for test: core_auth
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_psr2_sf
results: parsing output: 98/ for test: kms_psr
results: parsing output: 99/ for test: vgem_basic
results: parsing output: 100/ for test: kms_plane
results: parsing output: 101/ for test: gen9_exec_parse
results: parsing output: 102/ for test: kms_addfb_basic
results: parsing output: 103/ for test: kms_pipe_crc_basic
results: parsing output: 104/ for test: kms_cursor_crc
results: parsing output: 105/ for test: gem_exec_reloc
results: parsing output: 106/ for test: gem_create
results: parsing output: 107/ for test: kms_async_flips
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: sw_sync
results: parsing output: 110/ for test: gem_lmem_swapping
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: gem_exec_fence
results: parsing output: 113/ for test: gem_exec_params
results: parsing output: 114/ for test: kms_flip
results: parsing output: 115/ for test: kms_plane_lowres
results: parsing output: 116/ for test: kms_flip
results: parsing output: 117/ for test: kms_ccs
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: kms_psr2_sf
results: parsing output: 120/ for test: kms_flip
results: parsing output: 121/ for test: kms_ccs
results: parsing output: 122/ for test: gem_exec_balancer
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_rotation_crc
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_exec_params
results: parsing output: 127/ for test: i915_pciid
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: kms_cursor_crc
results: parsing output: 130/ for test: kms_flip_scaled_crc
results: parsing output: 131/ for test: perf_pmu
Done.