[55.196101] Initializing watchdogs
[55.196148]   /dev/watchdog0
[55.209475] [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]
[55.213751] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[55.215830] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[55.219073] [001/133] (960s left) kms_addfb_basic (size-max)
[55.335148] Starting subtest: size-max
[55.337308] Subtest size-max: SUCCESS (0.000s)
[55.434377] [002/133] (960s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[55.531410] Starting subtest: flip-primary-invalidate-overlay
[67.104474] Subtest flip-primary-invalidate-overlay: SUCCESS (11.575s)
[67.296171] [003/133] (948s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[67.400922] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[75.090683] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.693s)
[75.245662] [004/133] (940s left) syncobj_basic (illegal-fd-to-handle)
[75.308905] Starting subtest: illegal-fd-to-handle
[75.311187] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[75.423070] [005/133] (940s left) kms_properties (get_properties-sanity-atomic)
[75.524692] Starting subtest: get_properties-sanity-atomic
[75.527087] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[75.605122] [006/133] (940s left) kms_scaling_modes (scaling-mode-full-aspect)
[75.690165] Starting subtest: scaling-mode-full-aspect
[75.692565] Starting dynamic subtest: pipe-A-eDP-1
[75.783508] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.093s)
[75.791193] Starting dynamic subtest: pipe-B-eDP-1
[76.944680] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.159s)
[76.951969] Starting dynamic subtest: pipe-C-eDP-1
[78.059446] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.114s)
[78.067659] Starting dynamic subtest: pipe-D-eDP-1
[79.179975] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.119s)
[79.182245] Subtest scaling-mode-full-aspect: SUCCESS (3.490s)
[80.441308] [007/133] (935s left) i915_pm_rpm (gem-idle)
[82.091617] Starting subtest: gem-idle
[88.289509] Subtest gem-idle: SUCCESS (6.199s)
[88.637323] [008/133] (927s left) gem_mmap_wc (pf-nonblock)
[89.914089] Subtest pf-nonblock: SKIP (0.000s)
[90.009193] [009/133] (926s left) kms_cursor_edge_walk (64x64-left-edge)
[90.094315] Starting subtest: 64x64-left-edge
[90.096617] Starting dynamic subtest: pipe-A-eDP-1
[93.590864] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.495s)
[93.599750] Starting dynamic subtest: pipe-D-eDP-1
[96.712813] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.121s)
[96.715198] Subtest 64x64-left-edge: SUCCESS (6.617s)
[97.534256] [010/133] (918s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling)
[97.635121] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling
[97.637460] Starting dynamic subtest: pipe-A-default-mode
[97.931200] Dynamic subtest pipe-A-default-mode: SKIP (0.293s)
[97.935830] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.294s)
[98.759250] [011/133] (917s left) gem_fenced_exec_thrash (no-spare-fences)
[98.823527] Subtest no-spare-fences: SKIP (0.000s)
[98.897963] [012/133] (917s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[98.989585] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[98.994090] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[99.101148] [013/133] (917s left) sysfs_heartbeat_interval (precise)
[99.160239] Starting subtest: precise
[99.162652] Starting dynamic subtest: vecs0
[106.938805] Dynamic subtest vecs0: SUCCESS (7.774s)
[106.947920] Starting dynamic subtest: ccs0
[108.159823] Dynamic subtest ccs0: SUCCESS (1.223s)
[108.169033] Starting dynamic subtest: vcs0
[115.941864] Dynamic subtest vcs0: SUCCESS (7.778s)
[115.951322] Starting dynamic subtest: bcs0
[117.110703] Dynamic subtest bcs0: SUCCESS (1.170s)
[117.122242] Starting dynamic subtest: rcs0
[118.264014] Dynamic subtest rcs0: SUCCESS (1.151s)
[118.272350] Starting dynamic subtest: vcs1
[125.936634] Dynamic subtest vcs1: SUCCESS (7.669s)
[125.939078] Subtest precise: SUCCESS (26.773s)
[126.020748] [014/133] (890s left) kms_flip (wf_vblank-ts-check-interruptible)
[126.115867] Starting subtest: wf_vblank-ts-check-interruptible
[126.118122] Starting dynamic subtest: A-eDP1
[135.180520] Dynamic subtest A-eDP1: SUCCESS (9.063s)
[135.190632] Starting dynamic subtest: B-eDP1
[144.209545] Dynamic subtest B-eDP1: SUCCESS (9.028s)
[144.219824] Starting dynamic subtest: C-eDP1
[153.250352] Dynamic subtest C-eDP1: SUCCESS (9.038s)
[153.257847] Starting dynamic subtest: D-eDP1
[162.169626] Dynamic subtest D-eDP1: SUCCESS (8.916s)
[162.174711] Subtest wf_vblank-ts-check-interruptible: SUCCESS (36.055s)
[163.411816] [015/133] (852s left) syncobj_timeline (multi-wait-for-submit-signaled)
[163.465805] Starting subtest: multi-wait-for-submit-signaled
[163.468177] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[163.557702] [016/133] (852s left) gem_softpin (evict-snoop-interruptible)
[163.617027] Starting subtest: evict-snoop-interruptible
[163.621438] Subtest evict-snoop-interruptible: SKIP (0.000s)
[163.738639] [017/133] (852s left) api_intel_bb (object-reloc-keep-cache)
[163.786800] Starting subtest: object-reloc-keep-cache
[163.791407] Subtest object-reloc-keep-cache: SKIP (0.003s)
[163.930630] [018/133] (852s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[164.024161] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[164.026356] Starting dynamic subtest: pipe-A-eDP-1
[164.260925] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.204s)
[164.268402] Starting dynamic subtest: pipe-B-eDP-1
[165.566247] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.304s)
[165.576799] Starting dynamic subtest: pipe-C-eDP-1
[166.770315] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.203s)
[166.779395] Starting dynamic subtest: pipe-D-eDP-1
[167.995719] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.228s)
[167.997806] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.943s)
[169.135276] [019/133] (847s left) i915_query (engine-info-invalid)
[169.200481] Starting subtest: engine-info-invalid
[169.202791] Subtest engine-info-invalid: SUCCESS (0.000s)
[169.308604] [020/133] (847s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[169.401806] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[169.405947] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[169.519846] [021/133] (846s left) kms_vrr (seamless-rr-switch-drrs)
[169.610267] Starting subtest: seamless-rr-switch-drrs
[169.616982] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[169.691862] [022/133] (846s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[169.797905] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[169.802040] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[169.915740] [023/133] (846s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[169.973172] Starting subtest: etime-single-wait-for-submit-submitted
[170.081915] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.108s)
[170.166052] [024/133] (846s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[170.266179] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[170.270773] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[170.368939] [025/133] (846s left) kms_color (ctm-green-to-red)
[170.463069] Starting subtest: ctm-green-to-red
[170.465202] Starting dynamic subtest: pipe-A-eDP-1
[171.165338] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.699s)
[171.174798] Starting dynamic subtest: pipe-B-eDP-1
[172.602416] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.437s)
[172.613025] Starting dynamic subtest: pipe-C-eDP-1
[173.981857] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.380s)
[173.990614] Starting dynamic subtest: pipe-D-eDP-1
[175.306233] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.321s)
[175.308695] Subtest ctm-green-to-red: SUCCESS (4.839s)
[176.139297] [026/133] (840s left) gem_exec_reloc (basic-range-active)
[176.198195] Subtest basic-range-active: SKIP (0.000s)
[176.274227] [027/133] (840s left) kms_pm_rpm (dpms-non-lpsp)
[177.996487] Starting subtest: dpms-non-lpsp
[178.001285] Subtest dpms-non-lpsp: SKIP (0.001s)
[178.588887] [028/133] (838s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[178.693159] Starting subtest: flip-vs-dpms-on-nop-interruptible
[178.695350] Starting dynamic subtest: A-eDP1
[180.551167] Dynamic subtest A-eDP1: SUCCESS (1.857s)
[180.561108] Starting dynamic subtest: B-eDP1
[182.374845] Dynamic subtest B-eDP1: SUCCESS (1.823s)
[182.385249] Starting dynamic subtest: C-eDP1
[184.191604] Dynamic subtest C-eDP1: SUCCESS (1.816s)
[184.199650] Starting dynamic subtest: D-eDP1
[186.016572] Dynamic subtest D-eDP1: SUCCESS (1.824s)
[186.018909] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.326s)
[187.223735] [029/133] (829s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[187.321884] Starting subtest: 4-tiled-32bpp-rotate-0
[188.756725] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.434s)
[188.927334] [030/133] (827s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[189.028452] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[189.032073] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[189.150841] [031/133] (827s left) kms_cursor_crc (cursor-dpms)
[189.291209] Starting subtest: cursor-dpms
[189.293104] Starting dynamic subtest: pipe-A-eDP-1
[192.382605] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.086s)
[192.390063] Starting dynamic subtest: pipe-D-eDP-1
[196.066493] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.683s)
[196.068916] Subtest cursor-dpms: SUCCESS (6.772s)
[196.905289] [032/133] (819s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[197.026173] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[197.030590] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[197.191618] [033/133] (819s left) gem_exec_fence (submit)
[197.367977] Starting subtest: submit
[197.372955] Subtest submit: SKIP (0.000s)
[199.021598] [FACT gem_exec_fence (submit)] new: kernel.kmod_is_loaded.vgem: true
[199.024983] [034/133] (817s left) gem_mmap_gtt (basic-write)
[199.084809] Subtest basic-write: SKIP (0.000s)
[199.149343] [035/133] (817s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[199.247891] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[203.488924] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.244s)
[204.628899] [036/133] (812s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[204.720772] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[205.534159] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.814s)
[205.716556] [037/133] (811s left) gem_exec_fence (syncobj-timeline-repeat)
[206.254721] Starting subtest: syncobj-timeline-repeat
[206.474594] Subtest syncobj-timeline-repeat: SUCCESS (0.220s)
[208.010071] [038/133] (809s left) kms_properties (crtc-properties-atomic)
[208.095330] Starting subtest: crtc-properties-atomic
[208.097656] Starting dynamic subtest: pipe-A-eDP-1
[208.535536] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.435s)
[208.544299] Starting dynamic subtest: pipe-B-eDP-1
[209.682744] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.146s)
[209.690640] Starting dynamic subtest: pipe-C-eDP-1
[210.806118] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.124s)
[210.813783] Starting dynamic subtest: pipe-D-eDP-1
[211.935616] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.126s)
[211.937862] Subtest crtc-properties-atomic: SUCCESS (3.838s)
[212.756500] [039/133] (804s left) gen7_exec_parse (oacontrol-tracking)
[212.810679] Subtest oacontrol-tracking: SKIP (0.000s)
[212.895134] [040/133] (804s left) gem_userptr_blits (probe)
[212.962317] Starting subtest: probe
[213.036746] Subtest probe: SUCCESS (0.073s)
[213.185223] [041/133] (803s left) gem_ctx_engines (none)
[213.248538] Starting subtest: none
[213.250896] Subtest none: SUCCESS (0.001s)
[213.455114] [042/133] (803s left) kms_vblank (accuracy-idle)
[213.537250] Starting subtest: accuracy-idle
[213.539132] Starting dynamic subtest: pipe-A-eDP-1
[215.294029] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.758s)
[215.307715] Starting dynamic subtest: pipe-D-eDP-1
[217.780109] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.483s)
[217.782388] Subtest accuracy-idle: SUCCESS (4.244s)
[218.614273] [043/133] (798s left) gem_lmem_swapping (heavy-multi)
[218.655455] Subtest heavy-multi: SKIP (0.000s)
[218.701226] [044/133] (798s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[218.818473] Starting subtest: cursorB-vs-flipB-atomic-transitions
[218.822994] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s)
[218.973894] [045/133] (798s left) perf_pmu (busy-hang)
[219.012145] Starting subtest: busy-hang
[219.014629] Starting dynamic subtest: rcs0
[220.278514] Dynamic subtest rcs0: SUCCESS (1.266s)
[220.293387] Starting dynamic subtest: bcs0
[221.519679] Dynamic subtest bcs0: SUCCESS (1.236s)
[221.529674] Starting dynamic subtest: vcs0
[223.454069] Dynamic subtest vcs0: SUCCESS (1.932s)
[223.464672] Starting dynamic subtest: vcs1
[225.439047] Dynamic subtest vcs1: SUCCESS (1.983s)
[225.448699] Starting dynamic subtest: vecs0
[227.420046] Dynamic subtest vecs0: SUCCESS (1.982s)
[227.430946] Starting dynamic subtest: ccs0
[228.654958] Dynamic subtest ccs0: SUCCESS (1.229s)
[228.657179] Subtest busy-hang: SUCCESS (9.639s)
[228.753916] [046/133] (788s left) kms_cursor_crc (cursor-onscreen-64x64)
[228.930153] Starting subtest: cursor-onscreen-64x64
[228.935435] Starting dynamic subtest: pipe-A-eDP-1
[231.019831] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.087s)
[231.056455] Starting dynamic subtest: pipe-D-eDP-1
[233.759858] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.718s)
[233.762190] Subtest cursor-onscreen-64x64: SUCCESS (4.829s)
[234.564251] [047/133] (782s left) kms_psr (fbc-pr-primary-mmap-cpu)
[234.651626] Starting subtest: fbc-pr-primary-mmap-cpu
[234.655796] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[234.731700] [048/133] (782s left) gem_ctx_param (set-priority-not-supported)
[234.792889] Starting subtest: set-priority-not-supported
[234.797091] Subtest set-priority-not-supported: SKIP (0.000s)
[234.879834] [049/133] (782s left) kms_invalid_mode (clock-too-high)
[234.977208] Starting subtest: clock-too-high
[234.979463] Starting dynamic subtest: pipe-A-eDP-1
[234.983849] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[234.992323] Starting dynamic subtest: pipe-B-eDP-1
[234.996429] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[235.004557] Starting dynamic subtest: pipe-C-eDP-1
[235.008967] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[235.016896] Starting dynamic subtest: pipe-D-eDP-1
[235.021244] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[235.025527] Subtest clock-too-high: SKIP (0.004s)
[235.062217] [050/133] (782s left) gem_ctx_freq (sysfs)
[235.120725] Starting subtest: sysfs
[235.123066] Starting dynamic subtest: gt0
[240.640931] Dynamic subtest gt0: SUCCESS (5.520s)
[240.651254] Starting dynamic subtest: gt1
[281.875667] Dynamic subtest gt1: SUCCESS (41.231s)
[281.878169] Subtest sysfs: SUCCESS (46.753s)
[282.042638] [051/133] (735s left) gem_exec_schedule (submit-golden-slice)
[282.108946] Starting subtest: submit-golden-slice
[282.111305] Starting dynamic subtest: rcs0
[282.164679] Dynamic subtest rcs0: SUCCESS (0.064s)
[282.176254] Starting dynamic subtest: bcs0
[282.221293] Dynamic subtest bcs0: SUCCESS (0.055s)
[282.233207] Starting dynamic subtest: vcs0
[282.281153] Dynamic subtest vcs0: SUCCESS (0.060s)
[282.294920] Starting dynamic subtest: vcs1
[282.334985] Dynamic subtest vcs1: SUCCESS (0.052s)
[282.347803] Starting dynamic subtest: vecs0
[282.397419] Dynamic subtest vecs0: SUCCESS (0.062s)
[282.406657] Starting dynamic subtest: ccs0
[282.458842] Dynamic subtest ccs0: SUCCESS (0.061s)
[282.461307] Subtest submit-golden-slice: SUCCESS (0.359s)
[284.050757] [052/133] (733s left) kms_async_flips (invalid-async-flip-atomic)
[284.150550] Starting subtest: invalid-async-flip-atomic
[284.519819] Starting dynamic subtest: pipe-A-eDP-1
[285.932893] Dynamic subtest pipe-A-eDP-1: FAIL (0.823s)
[285.944081] Starting dynamic subtest: pipe-B-eDP-1
[286.866276] Dynamic subtest pipe-B-eDP-1: FAIL (0.749s)
[286.876298] Starting dynamic subtest: pipe-C-eDP-1
[287.616941] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.795s)
[287.978058] Starting dynamic subtest: pipe-D-eDP-1
[288.747908] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.778s)
[288.750294] Subtest invalid-async-flip-atomic: FAIL (4.600s)
[289.903455] [053/133] (727s left) kms_psr (pr-sprite-plane-onoff)
[290.004102] Starting subtest: pr-sprite-plane-onoff
[290.008411] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[290.087689] [054/133] (727s left) drm_read (empty-nonblock)
[290.224553] Starting subtest: empty-nonblock
[290.226985] Subtest empty-nonblock: SUCCESS (0.000s)
[290.385615] [055/133] (727s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[290.483178] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[290.485447] Starting dynamic subtest: pipe-A-eDP-1
[291.325974] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.835s)
[291.335485] Starting dynamic subtest: pipe-B-eDP-1
[292.871274] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.543s)
[292.879934] Starting dynamic subtest: pipe-C-eDP-1
[294.327686] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.456s)
[294.337434] Starting dynamic subtest: pipe-D-eDP-1
[295.780138] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.450s)
[295.782074] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.289s)
[296.980918] [056/133] (720s left) gem_mmap_gtt (zero-extend)
[297.039051] Subtest zero-extend: SKIP (0.000s)
[297.103187] [057/133] (720s left) kms_colorop (plane-xr24-xr24-pq_125_eotf)
[297.233642] Subtest plane-XR24-XR24-pq_125_eotf: SKIP (0.000s)
[297.317734] [058/133] (720s left) gem_madvise (dontneed-before-pwrite)
[297.349401] Starting subtest: dontneed-before-pwrite
[297.376898] Subtest dontneed-before-pwrite: SKIP (0.025s)
[297.443684] [059/133] (720s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[297.817667] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[298.581695] [060/133] (719s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[298.682810] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[302.658043] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (3.979s)
[303.805627] [061/133] (714s left) gem_exec_async (forked-writes)
[303.869776] Starting subtest: forked-writes
[303.871633] Starting dynamic subtest: rcs0
[303.894680] Dynamic subtest rcs0: SUCCESS (0.027s)
[303.904182] Starting dynamic subtest: bcs0
[303.915474] Dynamic subtest bcs0: SUCCESS (0.019s)
[303.927508] Starting dynamic subtest: vcs0
[303.934583] Dynamic subtest vcs0: SUCCESS (0.019s)
[303.944056] Starting dynamic subtest: vcs1
[303.956080] Dynamic subtest vcs1: SUCCESS (0.021s)
[303.965209] Starting dynamic subtest: vecs0
[303.978178] Dynamic subtest vecs0: SUCCESS (0.021s)
[303.987492] Starting dynamic subtest: ccs0
[304.001383] Dynamic subtest ccs0: SUCCESS (0.022s)
[304.003846] Subtest forked-writes: SUCCESS (0.134s)
[304.253755] [062/133] (713s left) kms_pm_backlight (fade-with-dpms)
[304.352448] Starting subtest: fade-with-dpms
[306.451645] Starting dynamic subtest: eDP-1
[309.145916] Dynamic subtest eDP-1: SUCCESS (2.696s)
[309.148064] Subtest fade-with-dpms: SUCCESS (4.797s)
[309.952899] [063/133] (708s left) gem_exec_alignment (pi)
[310.017681] Starting subtest: pi
[359.033055] Subtest pi: SUCCESS (49.013s)
[359.973405] [064/133] (658s left) gem_userptr_blits (readonly-unsync)
[360.070467] Subtest readonly-unsync: SKIP (0.000s)
[360.232090] [065/133] (657s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[360.445708] Starting subtest: cursor-rapid-movement-64x21
[360.492975] Subtest cursor-rapid-movement-64x21: SKIP (0.042s)
[360.759270] [066/133] (657s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[360.864856] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[360.869371] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[360.979839] [067/133] (657s left) gem_sync (basic-store-all)
[361.057449] Starting subtest: basic-store-all
[365.290958] Subtest basic-store-all: SUCCESS (4.241s)
[365.487541] [068/133] (652s left) gem_exec_balancer (persistence)
[365.749822] Starting subtest: persistence
[366.611517] Subtest persistence: SUCCESS (0.859s)
[366.753886] [069/133] (651s left) gem_exec_schedule (lateslice)
[366.837737] Starting subtest: lateslice
[366.840037] Starting dynamic subtest: rcs0
[366.862246] Dynamic subtest rcs0: SUCCESS (0.029s)
[366.873091] Starting dynamic subtest: bcs0
[366.886473] Dynamic subtest bcs0: SUCCESS (0.024s)
[366.895191] Starting dynamic subtest: vcs0
[366.910637] Dynamic subtest vcs0: SUCCESS (0.023s)
[366.918951] Starting dynamic subtest: vcs1
[366.935682] Dynamic subtest vcs1: SUCCESS (0.024s)
[366.947315] Starting dynamic subtest: vecs0
[366.957589] Dynamic subtest vecs0: SUCCESS (0.021s)
[366.967945] Starting dynamic subtest: ccs0
[366.978124] Dynamic subtest ccs0: SUCCESS (0.021s)
[366.980275] Subtest lateslice: SUCCESS (0.146s)
[369.026908] [070/133] (649s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[369.126472] Starting subtest: psr-rgb565-draw-render
[376.154761] Subtest psr-rgb565-draw-render: SUCCESS (7.030s)
[376.289232] [071/133] (642s left) gem_ccs (block-copy-compressed)
[376.354805] Starting subtest: block-copy-compressed
[376.359155] Subtest block-copy-compressed: SKIP (0.000s)
[376.503944] [072/133] (641s left) syncobj_eventfd (invalid-illegal-handle)
[376.554641] Starting subtest: invalid-illegal-handle
[376.556971] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[376.675060] [073/133] (641s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[376.776343] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[376.780771] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[376.907166] [074/133] (641s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[376.994298] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[376.996480] Starting dynamic subtest: pipe-A-eDP-1
[377.019365] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[377.029977] Starting dynamic subtest: pipe-B-eDP-1
[377.050323] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[377.058369] Starting dynamic subtest: pipe-C-eDP-1
[377.078801] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[377.086489] Starting dynamic subtest: pipe-D-eDP-1
[377.103652] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[377.107079] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[379.214391] [075/133] (639s left) kms_psr (pr-cursor-mmap-cpu)
[379.303175] Starting subtest: pr-cursor-mmap-cpu
[379.307526] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[379.392225] [076/133] (639s left) gem_ctx_persistence (heartbeat-hostile)
[379.439805] Starting subtest: heartbeat-hostile
[379.444313] Subtest heartbeat-hostile: SKIP (0.000s)
[379.576481] [077/133] (639s left) kms_flip (nonexisting-fb)
[379.676045] Starting subtest: nonexisting-fb
[379.678424] Starting dynamic subtest: A-eDP1
[380.898177] Dynamic subtest A-eDP1: SUCCESS (1.223s)
[380.907994] Starting dynamic subtest: B-eDP1
[382.022602] Dynamic subtest B-eDP1: SUCCESS (1.123s)
[382.032528] Starting dynamic subtest: C-eDP1
[383.152292] Dynamic subtest C-eDP1: SUCCESS (1.129s)
[383.161774] Starting dynamic subtest: D-eDP1
[384.282677] Dynamic subtest D-eDP1: SUCCESS (1.129s)
[384.285077] Subtest nonexisting-fb: SUCCESS (4.612s)
[385.487175] [078/133] (633s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[385.581620] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[385.586060] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[385.700414] [079/133] (632s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[385.793946] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[385.796276] Starting dynamic subtest: pipe-A
[385.815149] Dynamic subtest pipe-A: SKIP (0.017s)
[385.824853] Starting dynamic subtest: pipe-B
[385.844782] Dynamic subtest pipe-B: SKIP (0.030s)
[385.854146] Starting dynamic subtest: pipe-C
[385.874202] Dynamic subtest pipe-C: SKIP (0.030s)
[385.883097] Starting dynamic subtest: pipe-D
[385.905817] Dynamic subtest pipe-D: SKIP (0.030s)
[385.909578] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.109s)
[386.045738] [080/133] (632s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[386.102142] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[386.178311] [081/133] (632s left) gem_mmap (big-bo)
[386.237855] Subtest big-bo: SKIP (0.000s)
[386.312688] [082/133] (632s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[386.406402] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[386.410059] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[386.535173] [083/133] (632s left) kms_debugfs (display-off-read-all)
[386.612651] Starting subtest: display-off-read-all
[386.911067] Subtest display-off-read-all: SUCCESS (0.299s)
[387.722104] [084/133] (631s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[387.820760] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[387.825183] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[387.960328] [085/133] (630s left) i915_hangman (gt-engine-hang)
[388.021499] Starting subtest: gt-engine-hang
[388.023802] Starting dynamic subtest: rcs0
[389.874861] Dynamic subtest rcs0: SUCCESS (1.851s)
[389.884748] Starting dynamic subtest: bcs0
[391.858959] Dynamic subtest bcs0: SUCCESS (1.981s)
[391.871710] Starting dynamic subtest: vcs0
[393.842504] Dynamic subtest vcs0: SUCCESS (1.981s)
[393.854902] Starting dynamic subtest: vcs1
[395.827620] Dynamic subtest vcs1: SUCCESS (1.982s)
[395.837926] Starting dynamic subtest: vecs0
[397.875240] Dynamic subtest vecs0: SUCCESS (2.044s)
[397.885566] Starting dynamic subtest: ccs0
[399.859061] Dynamic subtest ccs0: SUCCESS (1.981s)
[399.862065] Subtest gt-engine-hang: SUCCESS (11.837s)
[399.954967] [086/133] (619s left) prime_vgem (basic-read)
[400.030398] Starting subtest: basic-read
[400.048289] Subtest basic-read: SKIP (0.016s)
[400.186130] [087/133] (618s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[400.275883] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[407.263369] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (6.990s)
[407.422296] [088/133] (611s left) perf_pmu (most-busy-idle-check-all)
[407.462844] Starting subtest: most-busy-idle-check-all
[407.464764] Starting dynamic subtest: rcs0
[408.918023] Dynamic subtest rcs0: SUCCESS (1.454s)
[408.930300] Starting dynamic subtest: bcs0
[410.900135] Dynamic subtest bcs0: SUCCESS (1.979s)
[410.910094] Starting dynamic subtest: vcs0
[412.886469] Dynamic subtest vcs0: SUCCESS (1.983s)
[412.898658] Starting dynamic subtest: vcs1
[414.869560] Dynamic subtest vcs1: SUCCESS (1.979s)
[414.881485] Starting dynamic subtest: vecs0
[416.917419] Dynamic subtest vecs0: SUCCESS (2.044s)
[416.929528] Starting dynamic subtest: ccs0
[418.901453] Dynamic subtest ccs0: SUCCESS (1.981s)
[418.904451] Subtest most-busy-idle-check-all: SUCCESS (11.439s)
[419.018841] [089/133] (600s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[419.118981] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[419.121243] Starting dynamic subtest: pipe-A-eDP-1
[419.144089] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[419.153818] Starting dynamic subtest: pipe-B-eDP-1
[419.175293] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[419.183989] Starting dynamic subtest: pipe-C-eDP-1
[419.206129] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[419.214722] Starting dynamic subtest: pipe-D-eDP-1
[419.236319] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[419.240311] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[421.423379] [090/133] (597s left) gem_userptr_blits (coherency-unsync)
[421.497955] Subtest coherency-unsync: SKIP (0.000s)
[421.644141] [091/133] (597s left) perf (whitelisted-registers-userspace-config)
[421.788274] Starting subtest: whitelisted-registers-userspace-config
[421.790051] Subtest whitelisted-registers-userspace-config: SUCCESS (0.000s)
[421.828993] [092/133] (597s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[421.890982] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[421.971480] [093/133] (597s left) kms_legacy_colorkey (invalid-plane)
[422.053737] Starting subtest: invalid-plane
[422.056021] Starting dynamic subtest: zero-id
[422.058122] Dynamic subtest zero-id: SUCCESS (0.000s)
[422.066882] Starting dynamic subtest: outrange-id
[422.068717] Dynamic subtest outrange-id: SUCCESS (0.000s)
[422.070575] Subtest invalid-plane: SUCCESS (0.001s)
[422.140787] [094/133] (597s left) kms_invalid_mode (bad-vtotal)
[422.225157] Starting subtest: bad-vtotal
[422.227485] Starting dynamic subtest: pipe-A-eDP-1
[422.509741] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[422.520022] Starting dynamic subtest: pipe-B-eDP-1
[422.522231] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[422.531202] Starting dynamic subtest: pipe-C-eDP-1
[422.533058] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[422.541677] Starting dynamic subtest: pipe-D-eDP-1
[422.543576] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[422.545478] Subtest bad-vtotal: SUCCESS (0.290s)
[423.351319] [095/133] (595s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[423.439115] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[423.441361] Starting dynamic subtest: pipe-A-default-mode
[426.150193] Dynamic subtest pipe-A-default-mode: SUCCESS (2.712s)
[426.152620] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.713s)
[427.035845] [096/133] (592s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[427.127393] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[427.131543] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[427.257089] [097/133] (592s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[427.361125] Starting subtest: flip-vs-cursor-crc-legacy
[428.024126] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.662s)
[428.860028] [098/133] (590s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[428.965603] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[436.226076] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.263s)
[436.396908] [099/133] (583s left) gem_render_copy (yf-tiled-ccs-to-linear)
[436.457925] Starting subtest: yf-tiled-ccs-to-linear
[436.462202] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[436.652492] [100/133] (582s left) kms_colorop (plane-xr30-xr30-multiply_inv_125)
[436.768221] Subtest plane-XR30-XR30-multiply_inv_125: SKIP (0.000s)
[436.861991] [101/133] (582s left) kms_plane_lowres (tiling-4)
[436.946078] Starting subtest: tiling-4
[436.947881] Starting dynamic subtest: pipe-A-eDP-1
[436.952295] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[437.249935] Starting dynamic subtest: pipe-B-eDP-1
[437.254578] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[437.265345] Starting dynamic subtest: pipe-C-eDP-1
[437.269848] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[437.278588] Starting dynamic subtest: pipe-D-eDP-1
[437.282515] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[437.286385] Subtest tiling-4: SKIP (0.304s)
[438.113080] [102/133] (581s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[438.205934] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[438.208099] Starting dynamic subtest: pipe-A-eDP-1
[438.231946] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[438.243770] Starting dynamic subtest: pipe-B-eDP-1
[438.267494] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[438.275762] Starting dynamic subtest: pipe-C-eDP-1
[438.299400] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[438.307618] Starting dynamic subtest: pipe-D-eDP-1
[438.331578] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[438.336348] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[440.460916] [103/133] (579s left) kms_plane_scaling (invalid-parameters)
[440.548704] Starting subtest: invalid-parameters
[440.550982] Starting dynamic subtest: less-than-1-height-src
[440.559809] Dynamic subtest less-than-1-height-src: SUCCESS (0.013s)
[440.569456] Starting dynamic subtest: less-than-1-width-src
[440.574350] Dynamic subtest less-than-1-width-src: SUCCESS (0.012s)
[440.576557] Subtest invalid-parameters: SUCCESS (0.026s)
[440.710874] [104/133] (578s left) core_getversion (basic)
[440.744712] Starting subtest: basic
[440.748736] Subtest basic: SUCCESS (0.000s)
[440.837793] [105/133] (578s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[445.825214] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[445.829620] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.002s)
[446.705517] [106/133] (573s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[446.806596] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[446.810637] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[446.925751] [107/133] (572s left) kms_busy (basic-hang)
[447.015397] Starting subtest: basic-hang
[447.017635] Starting dynamic subtest: flip-pipe-A
[447.603280] Dynamic subtest flip-pipe-A: SUCCESS (0.587s)
[447.613702] Starting dynamic subtest: modeset-pipe-A
[451.020322] Dynamic subtest modeset-pipe-A: SUCCESS (3.416s)
[451.029801] Starting dynamic subtest: flip-pipe-D
[452.251762] Dynamic subtest flip-pipe-D: SUCCESS (1.231s)
[452.261525] Starting dynamic subtest: modeset-pipe-D
[455.644045] Dynamic subtest modeset-pipe-D: SUCCESS (3.391s)
[455.646606] Subtest basic-hang: SUCCESS (8.631s)
[456.473927] [108/133] (563s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[456.576659] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[456.580725] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[456.673964] [109/133] (563s left) gem_pread (display)
[456.729585] Subtest display: SKIP (0.000s)
[456.792812] [110/133] (563s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[456.889435] Starting subtest: x-tiled-64bpp-rotate-180
[458.588044] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.697s)
[458.801179] [111/133] (561s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[458.860025] Starting subtest: y-tiled-to-vebox-x-tiled
[458.864710] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[459.069324] [112/133] (560s left) gem_exec_reloc (basic-gtt-read-noreloc)
[459.124515] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[459.226346] [113/133] (560s left) perf_pmu (interrupts)
[459.264389] Starting subtest: interrupts
[460.372374] Subtest interrupts: SUCCESS (1.109s)
[460.503299] [114/133] (559s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[460.563795] Starting subtest: etime-single-wait-all-for-submit-submitted
[460.672975] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.109s)
[460.760368] [115/133] (559s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[460.855886] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[461.657642] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.803s)
[461.862389] [116/133] (558s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[461.922890] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[461.925133] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[462.047237] [117/133] (558s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[467.012434] Starting subtest: pr-plane-move-sf-dmg-area
[467.016968] Subtest pr-plane-move-sf-dmg-area: SKIP (0.002s)
[467.877125] [118/133] (552s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[467.937870] Starting subtest: y-tiled-ccs-to-y-tiled
[467.942553] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[468.130494] [119/133] (552s left) kms_psr2_su (page_flip-xrgb8888)
[468.179424] Subtest page_flip-XRGB8888: SKIP (0.000s)
[468.244075] [120/133] (552s left) gem_softpin (evict-prime)
[468.309339] Starting subtest: evict-prime
[468.311647] Starting dynamic subtest: rcs0
[469.501047] Dynamic subtest rcs0: SUCCESS (1.191s)
[469.513176] Starting dynamic subtest: bcs0
[470.653335] Dynamic subtest bcs0: SUCCESS (1.149s)
[470.665706] Starting dynamic subtest: vcs0
[471.903279] Dynamic subtest vcs0: SUCCESS (1.247s)
[471.913054] Starting dynamic subtest: vcs1
[473.906565] Dynamic subtest vcs1: SUCCESS (2.002s)
[473.916386] Starting dynamic subtest: vecs0
[475.962358] Dynamic subtest vecs0: SUCCESS (2.054s)
[475.973787] Starting dynamic subtest: ccs0
[477.101827] Dynamic subtest ccs0: SUCCESS (1.138s)
[477.113353] Starting dynamic subtest: all
[478.875430] Dynamic subtest all: SUCCESS (1.770s)
[478.878040] Subtest evict-prime: SUCCESS (10.566s)
[478.980219] [121/133] (541s left) i915_drm_fdinfo (isolation)
[479.019798] Starting subtest: isolation
[479.021643] Starting dynamic subtest: rcs0
[479.069080] Dynamic subtest rcs0: SKIP (0.044s)
[479.080510] Starting dynamic subtest: bcs0
[479.084743] Dynamic subtest bcs0: SKIP (0.001s)
[479.093282] Starting dynamic subtest: vcs0
[479.097621] Dynamic subtest vcs0: SKIP (0.000s)
[479.106457] Starting dynamic subtest: vcs1
[479.110699] Dynamic subtest vcs1: SKIP (0.000s)
[479.120893] Starting dynamic subtest: vecs0
[479.125293] Dynamic subtest vecs0: SKIP (0.000s)
[479.133633] Starting dynamic subtest: ccs0
[479.138069] Dynamic subtest ccs0: SKIP (0.000s)
[479.142348] Subtest isolation: SKIP (0.051s)
[479.178717] [122/133] (541s left) gem_exec_store (cachelines)
[479.235483] Starting subtest: cachelines
[479.237741] Starting dynamic subtest: rcs0
[479.361964] Dynamic subtest rcs0: SUCCESS (0.126s)
[479.373866] Starting dynamic subtest: bcs0
[479.426882] Dynamic subtest bcs0: SUCCESS (0.064s)
[479.436154] Starting dynamic subtest: vcs0
[479.489253] Dynamic subtest vcs0: SUCCESS (0.060s)
[479.501094] Starting dynamic subtest: vcs1
[479.554936] Dynamic subtest vcs1: SUCCESS (0.062s)
[479.566158] Starting dynamic subtest: vecs0
[479.627124] Dynamic subtest vecs0: SUCCESS (0.070s)
[479.638751] Starting dynamic subtest: ccs0
[479.691033] Dynamic subtest ccs0: SUCCESS (0.061s)
[479.693761] Subtest cachelines: SUCCESS (0.456s)
[479.900820] [123/133] (540s left) gem_userptr_blits (create-destroy-sync)
[479.968808] Starting subtest: create-destroy-sync
[484.980668] Subtest create-destroy-sync: SUCCESS (5.012s)
[485.115641] [124/133] (535s left) kms_addfb_basic (basic-y-tiled-legacy)
[485.175730] Starting subtest: basic-y-tiled-legacy
[485.180906] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[485.359030] [125/133] (535s left) kms_psr (fbc-psr2-sprite-blt)
[485.447274] Starting subtest: fbc-psr2-sprite-blt
[485.449436] Starting dynamic subtest: eDP-1
[485.453718] Dynamic subtest eDP-1: SKIP (0.000s)
[485.458167] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[485.529800] [126/133] (535s left) kms_flip (absolute-wf_vblank)
[485.623698] Starting subtest: absolute-wf_vblank
[485.625592] Starting dynamic subtest: A-eDP1
[494.333390] Dynamic subtest A-eDP1: SUCCESS (8.712s)
[494.345113] Starting dynamic subtest: B-eDP1
[503.062540] Dynamic subtest B-eDP1: SUCCESS (8.728s)
[503.073444] Starting dynamic subtest: C-eDP1
[511.777658] Dynamic subtest C-eDP1: SUCCESS (8.714s)
[511.786517] Starting dynamic subtest: D-eDP1
[520.504725] Dynamic subtest D-eDP1: SUCCESS (8.725s)
[520.509604] Subtest absolute-wf_vblank: SUCCESS (34.890s)
[521.734891] [127/133] (498s left) gem_mmap (bad-object)
[521.798605] Subtest bad-object: SKIP (0.000s)
[521.855095] [128/133] (498s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[521.909523] Subtest writes-after-reads-snoop: SKIP (0.000s)
[521.979743] [129/133] (498s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[522.373777] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[523.156858] [130/133] (497s left) api_intel_allocator (fork-simple-stress)
[523.209835] Starting subtest: fork-simple-stress
[528.603391] Subtest fork-simple-stress: SUCCESS (5.394s)
[528.722075] [131/133] (492s left) gem_exec_fence (basic-wait-all)
[528.803876] Starting subtest: basic-wait-all
[528.935609] Subtest basic-wait-all: SUCCESS (0.131s)
[531.024197] [132/133] (489s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[531.135297] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[537.764523] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.630s)
[537.917150] [133/133] (482s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[538.008695] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[544.861338] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.854s)
[545.009764] Closing watchdogs
results: parsing output: 0/ for test: kms_addfb_basic
results: parsing output: 1/ for test: kms_psr_stress_test
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: syncobj_basic
results: parsing output: 4/ for test: kms_properties
results: parsing output: 5/ for test: kms_scaling_modes
results: parsing output: 6/ for test: i915_pm_rpm
results: parsing output: 7/ for test: gem_mmap_wc
results: parsing output: 8/ for test: kms_cursor_edge_walk
results: parsing output: 9/ for test: kms_flip_scaled_crc
results: parsing output: 10/ for test: gem_fenced_exec_thrash
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: sysfs_heartbeat_interval
results: parsing output: 13/ for test: kms_flip
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: gem_softpin
results: parsing output: 16/ for test: api_intel_bb
results: parsing output: 17/ for test: kms_ccs
results: parsing output: 18/ for test: i915_query
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_vrr
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_color
results: parsing output: 25/ for test: gem_exec_reloc
results: parsing output: 26/ for test: kms_pm_rpm
results: parsing output: 27/ for test: kms_flip
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_cursor_crc
results: parsing output: 31/ for test: kms_cursor_legacy
results: parsing output: 32/ for test: gem_exec_fence
results: parsing output: 33/ for test: gem_mmap_gtt
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: gem_exec_fence
results: parsing output: 37/ for test: kms_properties
results: parsing output: 38/ for test: gen7_exec_parse
results: parsing output: 39/ for test: gem_userptr_blits
results: parsing output: 40/ for test: gem_ctx_engines
results: parsing output: 41/ for test: kms_vblank
results: parsing output: 42/ for test: gem_lmem_swapping
results: parsing output: 43/ for test: kms_cursor_legacy
results: parsing output: 44/ for test: perf_pmu
results: parsing output: 45/ for test: kms_cursor_crc
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: gem_ctx_param
results: parsing output: 48/ for test: kms_invalid_mode
results: parsing output: 49/ for test: gem_ctx_freq
results: parsing output: 50/ for test: gem_exec_schedule
results: parsing output: 51/ for test: kms_async_flips
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: drm_read
results: parsing output: 54/ for test: kms_ccs
results: parsing output: 55/ for test: gem_mmap_gtt
results: parsing output: 56/ for test: kms_colorop
results: parsing output: 57/ for test: gem_madvise
results: parsing output: 58/ for test: kms_chamelium_hpd
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gem_exec_async
results: parsing output: 61/ for test: kms_pm_backlight
results: parsing output: 62/ for test: gem_exec_alignment
results: parsing output: 63/ for test: gem_userptr_blits
results: parsing output: 64/ for test: kms_cursor_crc
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: gem_sync
results: parsing output: 67/ for test: gem_exec_balancer
results: parsing output: 68/ for test: gem_exec_schedule
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_ccs
results: parsing output: 71/ for test: syncobj_eventfd
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: kms_psr
results: parsing output: 75/ for test: gem_ctx_persistence
results: parsing output: 76/ for test: kms_flip
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_plane_scaling
results: parsing output: 79/ for test: gem_mmap_gtt
results: parsing output: 80/ for test: gem_mmap
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_debugfs
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: i915_hangman
results: parsing output: 85/ for test: prime_vgem
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: perf_pmu
results: parsing output: 88/ for test: kms_ccs
results: parsing output: 89/ for test: gem_userptr_blits
results: parsing output: 90/ for test: perf
results: parsing output: 91/ for test: gem_exec_reloc
results: parsing output: 92/ for test: kms_legacy_colorkey
results: parsing output: 93/ for test: kms_invalid_mode
results: parsing output: 94/ for test: kms_flip_scaled_crc
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_cursor_legacy
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: gem_render_copy
results: parsing output: 99/ for test: kms_colorop
results: parsing output: 100/ for test: kms_plane_lowres
results: parsing output: 101/ for test: kms_ccs
results: parsing output: 102/ for test: kms_plane_scaling
results: parsing output: 103/ for test: core_getversion
results: parsing output: 104/ for test: kms_psr2_sf
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_busy
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_pread
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: gem_render_copy
results: parsing output: 111/ for test: gem_exec_reloc
results: parsing output: 112/ for test: perf_pmu
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: kms_psr2_sf
results: parsing output: 117/ for test: gem_render_copy
results: parsing output: 118/ for test: kms_psr2_su
results: parsing output: 119/ for test: gem_softpin
results: parsing output: 120/ for test: i915_drm_fdinfo
results: parsing output: 121/ for test: gem_exec_store
results: parsing output: 122/ for test: gem_userptr_blits
results: parsing output: 123/ for test: kms_addfb_basic
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: kms_flip
results: parsing output: 126/ for test: gem_mmap
results: parsing output: 127/ for test: gem_partial_pwrite_pread
results: parsing output: 128/ for test: kms_chamelium_hpd
results: parsing output: 129/ for test: api_intel_allocator
results: parsing output: 130/ for test: gem_exec_fence
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.