[44.712043] Initializing watchdogs
[44.712080]   /dev/watchdog0
[44.716337] [001/130] (960s left) kms_flip (absolute-wf_vblank)
[44.824615] Starting subtest: absolute-wf_vblank
[44.826144] Starting dynamic subtest: A-HDMI-A1
[60.217521] Dynamic subtest A-HDMI-A1: SUCCESS (15.391s)
[60.223941] Starting dynamic subtest: B-HDMI-A1
[75.556696] Dynamic subtest B-HDMI-A1: SUCCESS (15.321s)
[75.557815] Subtest absolute-wf_vblank: SUCCESS (30.717s)
[75.686139] [002/130] (929s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[75.802268] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[75.803540] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[75.897702] [003/130] (929s left) gem_create (create-ext-placement-sanity-check)
[76.046939] Starting subtest: create-ext-placement-sanity-check
[76.049135] Subtest create-ext-placement-sanity-check: SUCCESS (0.002s)
[76.144733] [004/130] (929s left) gen3_render_tiledy_blits
[76.204294] [005/130] (929s left) vgem_basic (busy-fence)
[76.290479] Starting subtest: busy-fence
[76.291295] Subtest busy-fence: SUCCESS (0.001s)
[76.354590] [006/130] (928s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[76.468502] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[77.826852] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.358s)
[78.000479] [007/130] (927s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling)
[78.108826] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling
[78.109482] Starting dynamic subtest: pipe-A-valid-mode
[79.017803] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.908s)
[79.018568] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SUCCESS (0.908s)
[79.172321] [008/130] (926s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[79.275318] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[79.276596] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[79.367357] [009/130] (925s left) kms_content_protection (dp-mst-type-1)
[79.484710] Starting subtest: dp-mst-type-1
[79.486020] Subtest dp-mst-type-1: SKIP (0.000s)
[79.575569] [010/130] (925s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[79.688774] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[79.689445] Starting dynamic subtest: pipe-A-HDMI-A-1
[80.825540] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.132s)
[80.833047] Starting dynamic subtest: pipe-B-HDMI-A-1
[81.559199] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.732s)
[81.560337] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SUCCESS (1.866s)
[81.762400] [011/130] (923s left) gem_lmem_swapping (parallel-random-verify)
[81.803090] Subtest parallel-random-verify: SKIP (0.000s)
[81.820446] [012/130] (923s left) gem_render_copy (linear-to-vebox-y-tiled)
[81.858173] Starting subtest: linear-to-vebox-y-tiled
[81.858875] Starting dynamic subtest: smem
[81.989776] Dynamic subtest smem: SUCCESS (0.131s)
[81.990450] Subtest linear-to-vebox-y-tiled: SUCCESS (0.132s)
[82.178949] [013/130] (923s left) kms_chamelium_hpd (common-hpd-after-suspend)
[82.342183] Subtest common-hpd-after-suspend: SKIP (0.000s)
[82.397413] [014/130] (923s left) gem_exec_parallel (basic)
[82.440810] Starting subtest: basic
[82.441545] Starting dynamic subtest: rcs0
[83.782180] Dynamic subtest rcs0: SUCCESS (1.341s)
[83.787508] Starting dynamic subtest: bcs0
[85.072048] Dynamic subtest bcs0: SUCCESS (1.289s)
[85.080132] Starting dynamic subtest: vcs0
[86.368516] Dynamic subtest vcs0: SUCCESS (1.297s)
[86.374235] Starting dynamic subtest: vecs0
[87.658806] Dynamic subtest vecs0: SUCCESS (1.290s)
[87.659473] Subtest basic: SUCCESS (5.218s)
[87.852430] [015/130] (917s left) syncobj_timeline (signal)
[87.899132] Starting subtest: signal
[87.899842] Subtest signal: SUCCESS (0.000s)
[87.974650] [016/130] (917s left) gem_exec_whisper (basic-fds-forked)
[88.017317] Starting subtest: basic-fds-forked
[90.086044] Subtest basic-fds-forked: SUCCESS (2.069s)
[90.270552] [017/130] (915s left) gem_exec_fair (basic-none)
[90.318312] Starting subtest: basic-none
[90.318963] Starting dynamic subtest: rcs0
[95.448066] Dynamic subtest rcs0: FAIL (5.110s)
[95.460720] Starting dynamic subtest: bcs0
[100.623680] Dynamic subtest bcs0: FAIL (5.165s)
[100.636091] Starting dynamic subtest: vcs0
[105.791393] Dynamic subtest vcs0: FAIL (5.165s)
[105.802987] Starting dynamic subtest: vecs0
[110.968091] Dynamic subtest vecs0: FAIL (5.176s)
[110.969199] Subtest basic-none: FAIL (20.617s)
[111.125943] [018/130] (894s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[111.165994] Starting subtest: multi-wait-all-for-submit-unsubmitted
[111.273325] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.107s)
[111.345580] [019/130] (894s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[111.457754] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[111.458415] Starting dynamic subtest: pipe-A-HDMI-A-1
[111.464970] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[111.468822] Starting dynamic subtest: pipe-B-HDMI-A-1
[111.475355] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[111.476684] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.001s)
[111.686720] [020/130] (893s left) gem_mmap_wc (write-gtt-read-wc)
[111.726171] Starting subtest: write-gtt-read-wc
[112.000829] Subtest write-gtt-read-wc: SUCCESS (0.266s)
[112.097711] [021/130] (893s left) kms_async_flips (async-flip-with-page-flip-events)
[112.207858] Starting subtest: async-flip-with-page-flip-events
[112.385195] Starting dynamic subtest: pipe-A-HDMI-A-1-y-rc-ccs
[112.507546] Dynamic subtest pipe-A-HDMI-A-1-y-rc-ccs: SKIP (0.122s)
[112.511408] Starting dynamic subtest: pipe-A-HDMI-A-1-y-rc-ccs-cc
[112.639978] Dynamic subtest pipe-A-HDMI-A-1-y-rc-ccs-cc: SKIP (0.132s)
[112.643841] Starting dynamic subtest: pipe-A-HDMI-A-1-y
[114.777030] Dynamic subtest pipe-A-HDMI-A-1-y: SUCCESS (2.129s)
[114.784564] Starting dynamic subtest: pipe-A-HDMI-A-1-x
[116.844489] Dynamic subtest pipe-A-HDMI-A-1-x: SUCCESS (2.067s)
[116.852590] Starting dynamic subtest: pipe-A-HDMI-A-1-linear
[118.913188] Dynamic subtest pipe-A-HDMI-A-1-linear: SUCCESS (2.068s)
[119.056349] Starting dynamic subtest: pipe-B-HDMI-A-1-y-rc-ccs
[119.172283] Dynamic subtest pipe-B-HDMI-A-1-y-rc-ccs: SKIP (0.118s)
[119.176140] Starting dynamic subtest: pipe-B-HDMI-A-1-y-rc-ccs-cc
[119.283328] Dynamic subtest pipe-B-HDMI-A-1-y-rc-ccs-cc: SKIP (0.112s)
[119.287177] Starting dynamic subtest: pipe-B-HDMI-A-1-y
[121.379963] Dynamic subtest pipe-B-HDMI-A-1-y: SUCCESS (2.088s)
[121.389107] Starting dynamic subtest: pipe-B-HDMI-A-1-x
[123.428672] Dynamic subtest pipe-B-HDMI-A-1-x: SUCCESS (2.048s)
[123.434850] Starting dynamic subtest: pipe-B-HDMI-A-1-linear
[125.466028] Dynamic subtest pipe-B-HDMI-A-1-linear: SUCCESS (2.030s)
[125.466799] Subtest async-flip-with-page-flip-events: SUCCESS (13.242s)
[125.750414] [022/130] (879s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[125.851369] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[125.852664] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[125.965481] [023/130] (879s left) drm_fdinfo (memory-info-resident)
[126.005583] Starting subtest: memory-info-resident
[126.006270] Starting dynamic subtest: smem0
[127.755915] Dynamic subtest smem0: SUCCESS (1.750s)
[127.756585] Subtest memory-info-resident: SUCCESS (1.750s)
[127.817493] [024/130] (877s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[127.848356] Starting subtest: y-tiled-to-vebox-y-tiled
[127.849037] Starting dynamic subtest: smem
[127.987689] Dynamic subtest smem: SUCCESS (0.131s)
[127.988351] Subtest y-tiled-to-vebox-y-tiled: SUCCESS (0.131s)
[128.157570] [025/130] (877s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[128.266541] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.000s)
[128.306722] [026/130] (877s left) syncobj_timeline (multi-wait-for-submit-signaled)
[128.344740] Starting subtest: multi-wait-for-submit-signaled
[128.345397] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[128.406159] [027/130] (877s left) perf_pmu (busy-idle)
[128.443983] Starting subtest: busy-idle
[128.444688] Starting dynamic subtest: rcs0
[129.124306] Dynamic subtest rcs0: SUCCESS (0.680s)
[129.132140] Starting dynamic subtest: bcs0
[129.761521] Dynamic subtest bcs0: SUCCESS (0.637s)
[129.769936] Starting dynamic subtest: vcs0
[130.408558] Dynamic subtest vcs0: SUCCESS (0.647s)
[130.416856] Starting dynamic subtest: vecs0
[131.062344] Dynamic subtest vecs0: SUCCESS (0.654s)
[131.063549] Subtest busy-idle: SUCCESS (2.618s)
[131.140974] [028/130] (874s left) api_intel_allocator (reopen-fork)
[131.173335] Starting subtest: reopen-fork
[134.601586] Subtest reopen-fork: SUCCESS (3.394s)
[134.652209] [029/130] (871s left) vgem_basic (create)
[134.686032] Starting subtest: create
[134.686698] Subtest create: SUCCESS (0.000s)
[134.752239] [030/130] (871s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[134.857089] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[135.158783] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.302s)
[135.333948] [031/130] (870s left) kms_cdclk (mode-transition-all-outputs)
[135.372160] Subtest mode-transition-all-outputs: SKIP (0.000s)
[135.392979] [032/130] (870s left) kms_cursor_crc (cursor-random-32x10)
[135.503432] Starting subtest: cursor-random-32x10
[135.531275] Subtest cursor-random-32x10: SKIP (0.027s)
[135.624112] [033/130] (870s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[135.728325] Starting subtest: fbcpsr-tiling-linear
[135.729638] Subtest fbcpsr-tiling-linear: SKIP (0.000s)
[135.834536] [034/130] (869s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[135.872862] Subtest writes-after-reads-snoop: SKIP (0.000s)
[135.955594] [035/130] (869s left) gem_ctx_shared (single-timeline)
[135.990183] Starting subtest: single-timeline
[135.994662] Subtest single-timeline: SUCCESS (0.003s)
[136.187133] [036/130] (869s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[136.212850] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[136.313235] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.100s)
[136.395894] [037/130] (869s left) gem_exec_schedule (preempt-other-chain)
[136.441301] Starting subtest: preempt-other-chain
[136.441998] Starting dynamic subtest: rcs0
[136.460938] Dynamic subtest rcs0: SUCCESS (0.020s)
[136.465300] Starting dynamic subtest: bcs0
[136.478322] Dynamic subtest bcs0: SUCCESS (0.017s)
[136.482620] Starting dynamic subtest: vcs0
[136.495172] Dynamic subtest vcs0: SUCCESS (0.017s)
[136.499388] Starting dynamic subtest: vecs0
[136.511952] Dynamic subtest vecs0: SUCCESS (0.017s)
[136.512618] Subtest preempt-other-chain: SUCCESS (0.071s)
[136.813841] [038/130] (869s left) gem_ctx_persistence (engines-hostile-preempt)
[136.851552] Starting subtest: engines-hostile-preempt
[136.852239] Starting dynamic subtest: rcs0
[136.973362] Dynamic subtest rcs0: SUCCESS (0.121s)
[136.981963] Starting dynamic subtest: bcs0
[137.084434] Dynamic subtest bcs0: SUCCESS (0.111s)
[137.099098] Starting dynamic subtest: vcs0
[137.192243] Dynamic subtest vcs0: SUCCESS (0.108s)
[137.199558] Starting dynamic subtest: vecs0
[137.298261] Dynamic subtest vecs0: SUCCESS (0.106s)
[137.299369] Subtest engines-hostile-preempt: SUCCESS (0.446s)
[137.389706] [039/130] (868s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[137.500753] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[137.501424] Starting dynamic subtest: pipe-A
[137.665084] Dynamic subtest pipe-A: SUCCESS (0.164s)
[137.679101] Starting dynamic subtest: pipe-B
[137.811761] Dynamic subtest pipe-B: SUCCESS (0.146s)
[137.813120] Subtest planes-upscale-20x20-downscale-factor-0-5: SUCCESS (0.311s)
[137.980444] [040/130] (867s left) perf_pmu (busy-accuracy-2)
[138.010026] Starting subtest: busy-accuracy-2
[138.010691] Starting dynamic subtest: rcs0
[141.034526] Dynamic subtest rcs0: SUCCESS (3.022s)
[141.042955] Starting dynamic subtest: bcs0
[144.058070] Dynamic subtest bcs0: SUCCESS (3.023s)
[144.066202] Starting dynamic subtest: vcs0
[147.081537] Dynamic subtest vcs0: SUCCESS (3.023s)
[147.088702] Starting dynamic subtest: vecs0
[150.107627] Dynamic subtest vecs0: SUCCESS (3.026s)
[150.108730] Subtest busy-accuracy-2: SUCCESS (12.094s)
[150.189960] [041/130] (855s left) kms_plane (pixel-format)
[150.290872] Starting subtest: pixel-format
[150.329974] Starting dynamic subtest: pipe-A-plane-0
[157.540050] Dynamic subtest pipe-A-plane-0: SUCCESS (7.210s)
[157.548536] Starting dynamic subtest: pipe-A-plane-3
[161.581685] Dynamic subtest pipe-A-plane-3: SUCCESS (4.041s)
[161.589850] Starting dynamic subtest: pipe-A-plane-5
[161.828203] Dynamic subtest pipe-A-plane-5: SUCCESS (0.246s)
[161.979393] Starting dynamic subtest: pipe-B-plane-0
[168.967910] Dynamic subtest pipe-B-plane-0: SUCCESS (7.001s)
[168.976033] Starting dynamic subtest: pipe-B-plane-3
[173.008856] Dynamic subtest pipe-B-plane-3: SUCCESS (4.041s)
[173.017076] Starting dynamic subtest: pipe-B-plane-5
[173.255436] Dynamic subtest pipe-B-plane-5: SUCCESS (0.246s)
[173.323952] Subtest pixel-format: SUCCESS (23.032s)
[173.498048] [042/130] (832s left) kms_flip (dpms-vs-vblank-race)
[173.600372] Starting subtest: dpms-vs-vblank-race
[173.601050] Starting dynamic subtest: A-HDMI-A1
[179.233548] Dynamic subtest A-HDMI-A1: SUCCESS (5.631s)
[179.242620] Starting dynamic subtest: B-HDMI-A1
[184.668366] Dynamic subtest B-HDMI-A1: SUCCESS (5.434s)
[184.669160] Subtest dpms-vs-vblank-race: SUCCESS (11.069s)
[184.847669] [043/130] (821s left) gem_exec_balancer (invalid-bonds)
[184.891885] Starting subtest: invalid-bonds
[184.894530] Subtest invalid-bonds: SUCCESS (0.003s)
[185.730042] [044/130] (820s left) syncobj_wait (reset-during-wait-for-submit)
[185.757387] Starting subtest: reset-during-wait-for-submit
[185.858977] Subtest reset-during-wait-for-submit: SUCCESS (0.101s)
[185.942960] [045/130] (820s left) kms_psr (psr-cursor-blt)
[186.051491] Subtest psr-cursor-blt: SKIP (0.000s)
[186.079197] [046/130] (819s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[186.191444] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[186.192761] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[186.320515] [047/130] (819s left) gem_exec_schedule (implicit-read-write)
[186.362356] Starting subtest: implicit-read-write
[186.363046] Starting dynamic subtest: rcs0
[186.405617] Dynamic subtest rcs0: SUCCESS (0.044s)
[186.413675] Starting dynamic subtest: bcs0
[186.451345] Dynamic subtest bcs0: SUCCESS (0.045s)
[186.462442] Starting dynamic subtest: vcs0
[186.501144] Dynamic subtest vcs0: SUCCESS (0.048s)
[186.511915] Starting dynamic subtest: vecs0
[186.551658] Dynamic subtest vecs0: SUCCESS (0.050s)
[186.552736] Subtest implicit-read-write: SUCCESS (0.191s)
[186.859400] [048/130] (819s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[186.961423] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[186.962692] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[187.086901] [049/130] (819s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[187.191636] Starting subtest: 4-tiled-16bpp-rotate-90
[187.192910] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.000s)
[187.315292] [050/130] (818s left) i915_getparams_basic (basic-eu-total)
[187.351999] Starting subtest: basic-eu-total
[187.353321] Subtest basic-eu-total: SUCCESS (0.000s)
[187.426950] [051/130] (818s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[187.541599] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[187.542899] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[187.656181] [052/130] (818s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[187.761460] Starting subtest: psr-2p-primscrn-spr-indfb-move
[187.762738] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[187.884432] [053/130] (818s left) kms_pm_rpm (modeset-stress-extra-wait)
[188.317787] Starting subtest: modeset-stress-extra-wait
[240.107605] Subtest modeset-stress-extra-wait: SUCCESS (51.781s)
[240.217273] [054/130] (765s left) gem_exec_reloc (basic-gtt-noreloc)
[240.254906] Subtest basic-gtt-noreloc: SKIP (0.000s)
[240.312300] [055/130] (765s left) gem_mmap_gtt (basic)
[240.342073] Starting subtest: basic
[240.342753] Subtest basic: SUCCESS (0.000s)
[240.410784] [056/130] (765s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[240.523601] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[240.524908] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[240.629679] [057/130] (765s left) prime_vgem (sync)
[240.714817] Starting subtest: sync
[240.715993] Starting dynamic subtest: rcs0
[240.757451] Dynamic subtest rcs0: SUCCESS (0.042s)
[240.764597] Starting dynamic subtest: bcs0
[240.803764] Dynamic subtest bcs0: SUCCESS (0.045s)
[240.817627] Starting dynamic subtest: vcs0
[240.824328] Dynamic subtest vcs0: SUCCESS (0.020s)
[240.835067] Starting dynamic subtest: vecs0
[240.850657] Dynamic subtest vecs0: SUCCESS (0.025s)
[240.851743] Subtest sync: SUCCESS (0.136s)
[240.971220] [058/130] (765s left) kms_atomic_transition (plane-all-transition-nonblocking)
[241.074018] Starting subtest: plane-all-transition-nonblocking
[241.075502] Starting dynamic subtest: pipe-A-HDMI-A-1
[245.338377] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.229s)
[245.358120] Starting dynamic subtest: pipe-B-HDMI-A-1
[249.632437] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (4.245s)
[249.633485] Subtest plane-all-transition-nonblocking: SUCCESS (8.550s)
[249.750426] [059/130] (756s left) gem_softpin (noreloc-interruptible)
[249.786975] Starting subtest: noreloc-interruptible
[255.212598] Subtest noreloc-interruptible: SUCCESS (5.417s)
[255.329646] [060/130] (751s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[255.433486] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[255.434784] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[255.541550] [061/130] (750s left) kms_addfb_basic (size-max)
[255.653895] Starting subtest: size-max
[255.654590] Subtest size-max: SUCCESS (0.000s)
[255.751460] [062/130] (750s left) gem_ctx_persistence (legacy-engines-persistence)
[255.786077] Starting subtest: legacy-engines-persistence
[255.786750] Starting dynamic subtest: render
[256.594181] Dynamic subtest render: SUCCESS (0.807s)
[256.602833] Starting dynamic subtest: bsd
[257.361189] Dynamic subtest bsd: SUCCESS (0.766s)
[257.370428] Starting dynamic subtest: blt
[258.129341] Dynamic subtest blt: SUCCESS (0.766s)
[258.138714] Starting dynamic subtest: vebox
[258.901271] Dynamic subtest vebox: SUCCESS (0.770s)
[258.902633] Subtest legacy-engines-persistence: SUCCESS (3.115s)
[258.966985] [063/130] (747s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[259.074274] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[261.396321] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (2.323s)
[261.551349] [064/130] (744s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[261.579681] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[261.643383] [065/130] (744s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[261.753432] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[264.185537] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (2.433s)
[264.348816] [066/130] (742s left) kms_psr (fbc-psr-sprite-blt)
[264.448607] Subtest fbc-psr-sprite-blt: SKIP (0.000s)
[264.486069] [067/130] (742s left) gem_wait (wait)
[264.526543] Starting subtest: wait
[264.527231] Starting dynamic subtest: all-engines
[265.592481] Dynamic subtest all-engines: SUCCESS (1.065s)
[265.601392] Starting dynamic subtest: rcs0
[266.612648] Dynamic subtest rcs0: SUCCESS (1.015s)
[266.621243] Starting dynamic subtest: bcs0
[267.630297] Dynamic subtest bcs0: SUCCESS (1.021s)
[267.639159] Starting dynamic subtest: vcs0
[268.655280] Dynamic subtest vcs0: SUCCESS (1.024s)
[268.664209] Starting dynamic subtest: vecs0
[269.683575] Dynamic subtest vecs0: SUCCESS (1.027s)
[269.684823] Subtest wait: SUCCESS (5.157s)
[269.883645] [068/130] (736s left) gem_pread (exhaustion)
[269.921930] Subtest exhaustion: SKIP (0.000s)
[269.993370] [069/130] (736s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[270.104431] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[270.105745] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[270.227428] [070/130] (736s left) gem_exec_reloc (basic-concurrent16)
[270.264948] Subtest basic-concurrent16: SKIP (0.000s)
[270.333830] [071/130] (736s left) gem_exec_params (cliprects_ptr-dirt)
[270.370529] Starting subtest: cliprects_ptr-dirt
[270.371214] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[270.495537] [072/130] (736s left) gem_watchdog (default-virtual)
[270.536050] Starting subtest: default-virtual
[274.805060] Subtest default-virtual: SUCCESS (4.262s)
[274.882142] [073/130] (731s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[274.986127] Starting subtest: cursorA-vs-flipA-toggle
[285.849451] Subtest cursorA-vs-flipA-toggle: SUCCESS (10.862s)
[286.004452] [074/130] (720s left) gem_mmap_gtt (basic-small-copy)
[286.040986] Starting subtest: basic-small-copy
[288.225858] Subtest basic-small-copy: SUCCESS (2.185s)
[288.296905] [075/130] (718s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[288.439057] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[289.499562] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (1.060s)
[289.643626] [076/130] (717s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[289.758429] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[289.759713] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[289.871230] [077/130] (716s left) gem_mmap_offset (open-flood)
[289.907754] Starting subtest: open-flood
[311.396204] Subtest open-flood: SUCCESS (21.489s)
[311.529707] [078/130] (695s left) gem_exec_reloc (basic-gtt-read-noreloc)
[311.591679] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[311.648220] [079/130] (695s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[311.754875] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[311.755534] Starting dynamic subtest: pipe-A
[312.408643] Dynamic subtest pipe-A: SUCCESS (0.653s)
[312.423465] Starting dynamic subtest: pipe-B
[313.049037] Dynamic subtest pipe-B: SUCCESS (0.639s)
[313.050208] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (1.294s)
[313.243854] [080/130] (693s left) gem_tiled_fence_blits (basic)
[313.443521] Starting subtest: basic
[313.468549] Subtest basic: SUCCESS (0.025s)
[313.608491] [081/130] (693s left) kms_psr (psr2-cursor-render)
[313.739441] Subtest psr2-cursor-render: SKIP (0.000s)
[313.781062] [082/130] (693s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[313.891351] Starting subtest: fbcpsr-indfb-scaledprimary
[313.892644] Subtest fbcpsr-indfb-scaledprimary: SKIP (0.000s)
[314.003931] [083/130] (692s left) gem_eio (in-flight-internal-10ms)
[314.045481] Starting subtest: in-flight-internal-10ms
[314.301187] Subtest in-flight-internal-10ms: SUCCESS (0.256s)
[314.459141] [084/130] (692s left) i915_pm_rps (reset)
[314.493554] Starting subtest: reset
[318.017378] Subtest reset: SUCCESS (3.517s)
[318.139986] [085/130] (688s left) kms_sequence (get-busy)
[318.239995] Starting subtest: get-busy
[318.240818] Starting dynamic subtest: pipe-A-HDMI-A-1
[320.999757] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.758s)
[321.006297] Starting dynamic subtest: pipe-B-HDMI-A-1
[323.672892] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.672s)
[323.673646] Subtest get-busy: SUCCESS (5.432s)
[323.776513] [086/130] (683s left) kms_vblank (ts-continuation-dpms-suspend)
[323.881868] Starting subtest: ts-continuation-dpms-suspend
[323.883334] Starting dynamic subtest: pipe-A-HDMI-A-1
[341.060390] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (17.177s)
[341.065952] Starting dynamic subtest: pipe-B-HDMI-A-1
[358.157035] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (17.096s)
[358.157756] Subtest ts-continuation-dpms-suspend: SUCCESS (34.274s)
[361.320553] [087/130] (648s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[361.436006] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[361.437387] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[361.547469] [088/130] (648s left) gem_unfence_active_buffers
[361.735245] [089/130] (648s left) kms_hdr (invalid-metadata-sizes)
[361.838993] Starting subtest: invalid-metadata-sizes
[361.840978] Subtest invalid-metadata-sizes: SKIP (0.000s)
[361.925296] [090/130] (648s left) gem_spin_batch (legacy)
[361.962281] Starting subtest: legacy
[361.962969] Starting dynamic subtest: default
[365.311648] Dynamic subtest default: SUCCESS (3.314s)
[365.321521] Starting dynamic subtest: render
[368.603104] Dynamic subtest render: SUCCESS (3.315s)
[368.612608] Starting dynamic subtest: bsd
[371.921156] Dynamic subtest bsd: SUCCESS (3.317s)
[371.930858] Starting dynamic subtest: bsd1
[375.263193] Dynamic subtest bsd1: SUCCESS (3.316s)
[375.281474] Starting dynamic subtest: blt
[378.554826] Dynamic subtest blt: SUCCESS (3.315s)
[378.564754] Starting dynamic subtest: vebox
[381.896285] Dynamic subtest vebox: SUCCESS (3.315s)
[381.897373] Subtest legacy: SUCCESS (19.899s)
[382.049728] [091/130] (628s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[382.151635] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[382.152918] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[382.266416] [092/130] (627s left) gem_exec_flush (basic-wb-ro-default)
[382.298721] Starting subtest: basic-wb-ro-default
[387.703935] Subtest basic-wb-ro-default: SUCCESS (5.405s)
[387.905039] [093/130] (622s left) kms_flip (blocking-wf_vblank)
[388.039398] Starting subtest: blocking-wf_vblank
[388.040922] Starting dynamic subtest: A-HDMI-A1
[403.750706] Dynamic subtest A-HDMI-A1: SUCCESS (15.710s)
[403.760189] Starting dynamic subtest: B-HDMI-A1
[419.394674] Dynamic subtest B-HDMI-A1: SUCCESS (15.642s)
[419.398253] Subtest blocking-wf_vblank: SUCCESS (31.358s)
[419.565313] [094/130] (590s left) kms_cursor_crc (cursor-sliding-32x32)
[419.668500] Starting subtest: cursor-sliding-32x32
[419.695940] Subtest cursor-sliding-32x32: SKIP (0.027s)
[419.801766] [095/130] (590s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[419.902496] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[419.903789] Subtest fbcpsr-rgb565-draw-mmap-wc: SKIP (0.000s)
[420.030193] [096/130] (590s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[420.134838] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[420.157764] [097/130] (590s left) gem_exec_fence (syncobj-export)
[420.449040] Starting subtest: syncobj-export
[420.450858] Subtest syncobj-export: SUCCESS (0.002s)
[420.742367] [098/130] (589s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[420.849972] Starting subtest: 2x-long-flip-vs-cursor-atomic
[420.852356] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[420.933952] [099/130] (589s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[421.039918] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[421.040593] Starting dynamic subtest: pipe-A-valid-mode
[421.090476] Dynamic subtest pipe-A-valid-mode: SKIP (0.048s)
[421.092103] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.049s)
[421.202889] [100/130] (589s left) gem_barrier_race (remote-request)
[421.247271] Starting subtest: remote-request
[421.248356] Starting dynamic subtest: rcs0
[426.323633] Dynamic subtest rcs0: SUCCESS (5.077s)
[426.324323] Subtest remote-request: SUCCESS (5.077s)
[426.483647] [101/130] (583s left) kms_invalid_mode (zero-vdisplay)
[426.615528] Starting subtest: zero-vdisplay
[426.616246] Starting dynamic subtest: pipe-A-HDMI-A-1
[426.664677] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.048s)
[426.674020] Starting dynamic subtest: pipe-B-HDMI-A-1
[426.674684] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[426.675332] Subtest zero-vdisplay: SUCCESS (0.051s)
[426.807137] [102/130] (583s left) syncobj_basic (bad-destroy)
[426.832296] Starting subtest: bad-destroy
[426.832975] Subtest bad-destroy: SUCCESS (0.000s)
[426.921189] [103/130] (583s left) kms_chamelium_frames (hdmi-crc-fast)
[427.073651] Subtest hdmi-crc-fast: SKIP (0.000s)
[427.136607] [104/130] (583s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[427.284570] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[427.346418] [105/130] (583s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[427.455367] Starting subtest: yf-tiled-32bpp-rotate-0
[427.456721] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[427.571566] [106/130] (582s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[427.676312] Starting subtest: basic-flip-before-cursor-atomic
[428.724159] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.047s)
[428.880977] [107/130] (581s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[428.909877] Starting subtest: rel-constants-invalid-rel-gen5
[428.910544] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[429.023505] [108/130] (581s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[429.134993] Starting subtest: extended-pageflip-modeset-hang-oldfb
[429.136689] Starting dynamic subtest: pipe-A
[448.914170] Dynamic subtest pipe-A: SUCCESS (19.778s)
[448.920752] Starting dynamic subtest: pipe-B
[468.876528] Dynamic subtest pipe-B: SUCCESS (19.947s)
[468.877398] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (39.727s)
[469.038571] [109/130] (541s left) kms_pm_backlight (fade-with-suspend)
[469.143451] Subtest fade-with-suspend: SKIP (0.000s)
[469.209580] [110/130] (541s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[469.318695] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[469.320021] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[469.446109] [111/130] (541s left) prime_vgem (fence-flip-hang)
[469.491439] Subtest fence-flip-hang: SKIP (0.000s)
[469.616265] [112/130] (540s left) gem_tiled_fence_blits (normal)
[469.720051] Starting subtest: normal
[477.638573] Subtest normal: SUCCESS (7.917s)
[477.741689] [113/130] (532s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[477.860099] Starting subtest: x-tiled-16bpp-rotate-90
[477.919827] Subtest x-tiled-16bpp-rotate-90: SKIP (0.059s)
[478.059687] [114/130] (532s left) kms_display_modes (extended-mode-basic)
[478.164987] Starting subtest: extended-mode-basic
[478.166571] Subtest extended-mode-basic: SKIP (0.000s)
[478.189951] [115/130] (532s left) i915_pm_rpm (system-suspend-execbuf)
[478.620016] Starting subtest: system-suspend-execbuf
[501.053464] Subtest system-suspend-execbuf: SUCCESS (22.433s)
[502.229727] [116/130] (509s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[502.335063] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[502.379366] [117/130] (509s left) gem_exec_reloc (basic-cpu-wc-active)
[502.411938] Subtest basic-cpu-wc-active: SKIP (0.000s)
[502.471610] [118/130] (509s left) gem_lmem_swapping (heavy-verify-random)
[502.507572] Subtest heavy-verify-random: SKIP (0.000s)
[502.550969] [119/130] (509s left) gem_exec_await (wide-all)
[502.599386] Starting subtest: wide-all
[524.255048] Subtest wide-all: SUCCESS (21.646s)
[524.445511] [120/130] (487s left) kms_fb_coherency (memset-crc)
[524.587360] Starting subtest: memset-crc
[524.588333] Starting dynamic subtest: mmap-gtt
[525.050056] Dynamic subtest mmap-gtt: SUCCESS (0.462s)
[525.114627] Starting dynamic subtest: mmap-offset-wc
[525.474270] Dynamic subtest mmap-offset-wc: SUCCESS (0.368s)
[525.556453] Starting dynamic subtest: mmap-offset-uc
[526.332706] Dynamic subtest mmap-offset-uc: SUCCESS (0.787s)
[526.396558] Starting dynamic subtest: mmap-legacy-wc
[526.756180] Dynamic subtest mmap-legacy-wc: SUCCESS (0.368s)
[526.827812] Subtest memset-crc: SUCCESS (2.240s)
[526.986077] [121/130] (484s left) api_intel_bb (purge-bb)
[527.019674] Starting subtest: purge-bb
[527.020343] Subtest purge-bb: SUCCESS (0.001s)
[527.155784] [122/130] (484s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[527.260427] Starting subtest: psr-shrfb-scaledprimary
[527.261717] Subtest psr-shrfb-scaledprimary: SKIP (0.000s)
[527.356652] [123/130] (484s left) kms_psr (psr-sprite-mmap-cpu)
[527.463516] Subtest psr-sprite-mmap-cpu: SKIP (0.000s)
[527.503834] [124/130] (484s left) kms_psr2_su (frontbuffer-xrgb8888)
[527.535915] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[527.579902] [125/130] (484s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[527.617469] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[527.618153] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[527.707410] [126/130] (484s left) drm_fdinfo (busy-idle)
[527.741628] Starting subtest: busy-idle
[527.742300] Starting dynamic subtest: rcs0
[528.358756] Dynamic subtest rcs0: SUCCESS (0.615s)
[528.366958] Starting dynamic subtest: bcs0
[528.983225] Dynamic subtest bcs0: SUCCESS (0.625s)
[528.992974] Starting dynamic subtest: vcs0
[529.610260] Dynamic subtest vcs0: SUCCESS (0.626s)
[529.620605] Starting dynamic subtest: vecs0
[530.230625] Dynamic subtest vecs0: SUCCESS (0.615s)
[530.231735] Subtest busy-idle: SUCCESS (2.485s)
[530.290543] [127/130] (481s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[530.394936] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[530.395594] Starting dynamic subtest: pipe-A-HDMI-A-1
[530.401975] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[530.407962] Starting dynamic subtest: pipe-B-HDMI-A-1
[530.414297] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[530.415583] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SKIP (0.002s)
[530.618791] [128/130] (481s left) syncobj_eventfd (timeline-wait)
[530.650958] Starting subtest: timeline-wait
[530.661556] Subtest timeline-wait: SUCCESS (0.011s)
[530.752049] [129/130] (481s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[530.781297] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[530.781975] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[530.865044] [130/130] (481s left) kms_legacy_colorkey (invalid-plane)
[530.964060] Starting subtest: invalid-plane
[530.964735] Starting dynamic subtest: zero-id
[530.965399] Dynamic subtest zero-id: SUCCESS (0.000s)
[530.971477] Starting dynamic subtest: outrange-id
[530.972137] Dynamic subtest outrange-id: SUCCESS (0.000s)
[530.972802] Subtest invalid-plane: SUCCESS (0.001s)
[531.054352] Closing watchdogs
Done.