[57.242374] Initializing watchdogs
[57.242419]   /dev/watchdog0
[57.256899] [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]
[57.261385] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.263635] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.267448] [001/155] (960s left) gem_softpin (evict-active)
[57.351691] Starting subtest: evict-active
[57.363106] Subtest evict-active: SUCCESS (0.010s)
[57.489383] [002/155] (960s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[57.604226] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu
[57.608655] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[57.712898] [003/155] (960s left) syncobj_timeline (invalid-query-illegal-handle)
[57.773676] Starting subtest: invalid-query-illegal-handle
[57.776258] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[57.878019] [004/155] (960s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-pwrite)
[57.977087] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-pwrite
[57.981396] Subtest fbchdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[58.090215] [005/155] (959s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[58.201230] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[58.205561] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[58.265796] [006/155] (959s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[58.320967] Starting subtest: etime-single-wait-for-submit-unsubmitted
[58.429259] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.104s)
[58.516169] [007/155] (959s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-pwrite)
[58.622883] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-pwrite
[58.627322] Subtest hdr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[58.752688] [008/155] (959s left) kms_async_flips (async-flip-suspend-resume)
[58.838652] Starting subtest: async-flip-suspend-resume
[59.232123] Starting dynamic subtest: pipe-A-eDP-1
[77.157356] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.108s)
[77.553198] Starting dynamic subtest: pipe-B-eDP-1
[95.163699] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.834s)
[95.536002] Starting dynamic subtest: pipe-C-eDP-1
[113.162724] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.863s)
[113.538135] Starting dynamic subtest: pipe-D-eDP-1
[131.146884] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.866s)
[131.149402] Subtest async-flip-suspend-resume: SUCCESS (13.167s)
[132.382693] [009/155] (885s left) gem_exec_balancer (full)
[132.519829] Starting subtest: full
[137.028729] Subtest full: SUCCESS (4.411s)
[137.354125] [010/155] (880s left) kms_frontbuffer_tracking (fbchdr-suspend)
[137.460887] Starting subtest: fbchdr-suspend
[137.465621] Subtest fbchdr-suspend: SKIP (0.000s)
[137.541608] [011/155] (880s left) gem_userptr_blits (map-fixed-invalidate-busy)
[137.612771] Starting subtest: map-fixed-invalidate-busy
[137.618116] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[137.739937] [012/155] (880s left) kms_plane_alpha_blend (constant-alpha-min)
[137.825621] Starting subtest: constant-alpha-min
[138.120507] Starting dynamic subtest: pipe-A-eDP-1
[138.832467] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.701s)
[138.843680] Starting dynamic subtest: pipe-D-eDP-1
[140.297714] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.447s)
[140.300721] Subtest constant-alpha-min: SUCCESS (2.439s)
[141.193789] [013/155] (877s left) kms_plane (pixel-format-linear-modifier)
[141.290591] Starting subtest: pixel-format-linear-modifier
[141.318443] Starting dynamic subtest: pipe-A-plane-0
[141.923691] Dynamic subtest pipe-A-plane-0: SUCCESS (0.600s)
[141.933845] Starting dynamic subtest: pipe-A-plane-3
[142.371635] Dynamic subtest pipe-A-plane-3: SUCCESS (0.444s)
[142.381387] Starting dynamic subtest: pipe-A-plane-5
[142.584471] Dynamic subtest pipe-A-plane-5: SUCCESS (0.211s)
[143.707873] Starting dynamic subtest: pipe-B-plane-0
[144.335023] Dynamic subtest pipe-B-plane-0: SUCCESS (0.633s)
[144.346701] Starting dynamic subtest: pipe-B-plane-3
[144.782105] Dynamic subtest pipe-B-plane-3: SUCCESS (0.444s)
[144.792129] Starting dynamic subtest: pipe-B-plane-5
[145.006083] Dynamic subtest pipe-B-plane-5: SUCCESS (0.222s)
[145.318230] Subtest pixel-format-linear-modifier: SUCCESS (3.997s)
[146.189536] [014/155] (872s left) tools_test (tools_test)
[146.249390] Starting subtest: tools_test
[146.294092] Subtest tools_test: SUCCESS (0.067s)
[146.357837] [015/155] (871s left) kms_rotation_crc (multiplane-rotation)
[146.453832] Starting subtest: multiplane-rotation
[164.096298] Subtest multiplane-rotation: SUCCESS (17.605s)
[164.210467] [016/155] (854s left) fbdev (pan)
[164.256137] Starting subtest: pan
[164.285528] Subtest pan: SUCCESS (0.031s)
[164.354569] [017/155] (854s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[164.423494] Starting subtest: map-fixed-invalidate-overlap-busy
[164.427270] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[164.537498] [018/155] (853s left) kms_flip (blocking-absolute-wf_vblank)
[164.628063] Starting subtest: blocking-absolute-wf_vblank
[164.630052] Starting dynamic subtest: A-eDP1
[173.424567] Dynamic subtest A-eDP1: SUCCESS (8.764s)
[173.436313] Starting dynamic subtest: B-eDP1
[182.166368] Dynamic subtest B-eDP1: SUCCESS (8.739s)
[182.178226] Starting dynamic subtest: C-eDP1
[190.897487] Dynamic subtest C-eDP1: SUCCESS (8.717s)
[190.906658] Starting dynamic subtest: D-eDP1
[199.632841] Dynamic subtest D-eDP1: SUCCESS (8.729s)
[199.635543] Subtest blocking-absolute-wf_vblank: SUCCESS (34.965s)
[200.808111] [019/155] (817s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[200.902534] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[200.907737] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[200.984233] [020/155] (817s left) gem_exec_schedule (preemptive-hang)
[201.154888] Starting subtest: preemptive-hang
[201.157848] Starting dynamic subtest: rcs0
[210.243771] Dynamic subtest rcs0: SUCCESS (9.083s)
[210.254780] Starting dynamic subtest: bcs0
[219.266058] Dynamic subtest bcs0: SUCCESS (9.013s)
[219.279926] Starting dynamic subtest: vcs0
[228.223370] Dynamic subtest vcs0: SUCCESS (8.955s)
[228.233652] Starting dynamic subtest: vcs1
[237.310958] Dynamic subtest vcs1: SUCCESS (9.086s)
[237.324742] Starting dynamic subtest: vecs0
[246.263493] Dynamic subtest vecs0: SUCCESS (8.959s)
[246.275545] Starting dynamic subtest: ccs0
[255.230788] Dynamic subtest ccs0: SUCCESS (8.964s)
[255.233728] Subtest preemptive-hang: SUCCESS (54.069s)
[255.464192] [021/155] (763s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[255.560485] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[255.563025] Starting dynamic subtest: pipe-A-eDP-1
[255.586628] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[255.598247] Starting dynamic subtest: pipe-B-eDP-1
[255.624651] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[255.635883] Starting dynamic subtest: pipe-C-eDP-1
[255.661750] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[255.671416] Starting dynamic subtest: pipe-D-eDP-1
[255.697234] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[255.702577] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[257.861218] [022/155] (760s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[257.982268] Starting subtest: cursorA-vs-flipB-legacy
[257.987271] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[258.128482] [023/155] (760s left) perf_pmu (init-busy)
[258.165897] Starting subtest: init-busy
[258.168444] Starting dynamic subtest: rcs0
[258.170900] Dynamic subtest rcs0: SUCCESS (0.001s)
[258.180433] Starting dynamic subtest: bcs0
[258.182606] Dynamic subtest bcs0: SUCCESS (0.001s)
[258.191494] Starting dynamic subtest: vcs0
[258.193710] Dynamic subtest vcs0: SUCCESS (0.001s)
[258.202466] Starting dynamic subtest: vcs1
[258.204698] Dynamic subtest vcs1: SUCCESS (0.001s)
[258.213794] Starting dynamic subtest: vecs0
[258.216659] Dynamic subtest vecs0: SUCCESS (0.001s)
[258.225861] Starting dynamic subtest: ccs0
[258.228255] Dynamic subtest ccs0: SUCCESS (0.001s)
[258.230558] Subtest init-busy: SUCCESS (0.008s)
[258.269184] [024/155] (760s left) kms_lease (lease-invalid-crtc)
[258.361566] Starting subtest: lease-invalid-crtc
[258.364056] Starting dynamic subtest: pipe-A-eDP-1
[258.366728] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[258.375898] Starting dynamic subtest: pipe-B-eDP-1
[258.378730] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[258.387470] Starting dynamic subtest: pipe-C-eDP-1
[258.390011] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[258.398844] Starting dynamic subtest: pipe-D-eDP-1
[258.401604] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[258.404283] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[258.441869] [025/155] (760s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-mmap-gtt)
[258.548690] Starting subtest: hdr-rgb101010-draw-mmap-gtt
[258.553640] Subtest hdr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[258.648794] [026/155] (760s left) kms_content_protection (dp-mst-type-0)
[258.783124] Starting subtest: dp-mst-type-0
[258.787432] Subtest dp-mst-type-0: SKIP (0.000s)
[258.904844] [027/155] (759s left) kms_frontbuffer_tracking (hdr-1p-rte)
[258.998900] Starting subtest: hdr-1p-rte
[259.003756] Subtest hdr-1p-rte: SKIP (0.000s)
[259.082338] [028/155] (759s left) kms_frontbuffer_tracking (hdr-2p-rte)
[259.178648] Starting subtest: hdr-2p-rte
[259.182883] Subtest hdr-2p-rte: SKIP (0.000s)
[259.264322] [029/155] (759s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[259.386407] Starting subtest: cursorB-vs-flipA-atomic-transitions
[259.390568] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[259.528980] [030/155] (759s left) prime_vgem (sync)
[259.642690] Starting subtest: sync
[259.645415] Starting dynamic subtest: rcs0
[259.686540] Dynamic subtest rcs0: SUCCESS (0.044s)
[259.695405] Starting dynamic subtest: bcs0
[259.749114] Dynamic subtest bcs0: SUCCESS (0.062s)
[259.758313] Starting dynamic subtest: vcs0
[259.796177] Dynamic subtest vcs0: SUCCESS (0.047s)
[259.805633] Starting dynamic subtest: vcs1
[259.842547] Dynamic subtest vcs1: SUCCESS (0.045s)
[259.851746] Starting dynamic subtest: vecs0
[259.891580] Dynamic subtest vecs0: SUCCESS (0.048s)
[259.900881] Starting dynamic subtest: ccs0
[259.938730] Dynamic subtest ccs0: SUCCESS (0.046s)
[259.941444] Subtest sync: SUCCESS (0.297s)
[260.052442] [FACT prime_vgem (sync)] new: kernel.kmod_is_loaded.vgem: true
[260.055994] [031/155] (758s left) i915_pm_rpm (system-suspend)
[262.278722] Starting subtest: system-suspend
[279.934915] Subtest system-suspend: SUCCESS (2.865s)
[280.334936] [032/155] (738s left) gem_mmap_gtt (hang-user)
[280.392946] Subtest hang-user: SKIP (0.000s)
[280.451487] [033/155] (738s left) perf (enable-disable)
[280.585970] Starting subtest: enable-disable
[280.588806] Starting dynamic subtest: 0-rcs0
[282.856936] Dynamic subtest 0-rcs0: SUCCESS (2.212s)
[282.867982] Starting dynamic subtest: 1-vcs0
[287.359344] Dynamic subtest 1-vcs0: SUCCESS (4.422s)
[287.362043] Subtest enable-disable: SUCCESS (6.636s)
[287.407243] [034/155] (731s left) kms_cursor_crc (cursor-dpms)
[287.542240] Starting subtest: cursor-dpms
[287.544889] Starting dynamic subtest: pipe-A-eDP-1
[290.577546] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.999s)
[290.587594] Starting dynamic subtest: pipe-D-eDP-1
[294.286651] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.683s)
[294.288887] Subtest cursor-dpms: SUCCESS (6.685s)
[295.138608] [035/155] (723s left) kms_cursor_crc (cursor-tearing-position-change)
[295.258534] Starting subtest: cursor-tearing-position-change
[295.260889] Starting dynamic subtest: pipe-A-eDP-1
[295.828902] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.565s)
[295.839853] Starting dynamic subtest: pipe-D-eDP-1
[297.072184] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.237s)
[297.074655] Subtest cursor-tearing-position-change: SUCCESS (1.804s)
[297.914287] [036/155] (721s left) kms_dsc (dsc-with-output-formats)
[298.005785] Starting subtest: dsc-with-output-formats
[298.029243] Subtest dsc-with-output-formats: SKIP (0.000s)
[298.077814] [037/155] (721s left) gem_exec_schedule (implicit-read-write)
[298.155685] Starting subtest: implicit-read-write
[298.158055] Starting dynamic subtest: rcs0
[298.264196] Dynamic subtest rcs0: SUCCESS (0.120s)
[298.280184] Starting dynamic subtest: vcs0
[298.344337] Dynamic subtest vcs0: SUCCESS (0.079s)
[298.363450] Starting dynamic subtest: vcs1
[298.424012] Dynamic subtest vcs1: SUCCESS (0.079s)
[298.436442] Starting dynamic subtest: vecs0
[298.511672] Dynamic subtest vecs0: SUCCESS (0.087s)
[298.523631] Starting dynamic subtest: ccs0
[298.594909] Dynamic subtest ccs0: SUCCESS (0.080s)
[298.597914] Subtest implicit-read-write: SUCCESS (0.450s)
[299.998808] [038/155] (719s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[300.088675] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[300.091305] Starting dynamic subtest: pipe-A
[300.109567] Dynamic subtest pipe-A: SKIP (0.017s)
[300.119342] Starting dynamic subtest: pipe-B
[300.140935] Dynamic subtest pipe-B: SKIP (0.030s)
[300.150826] Starting dynamic subtest: pipe-C
[300.172777] Dynamic subtest pipe-C: SKIP (0.029s)
[300.182918] Starting dynamic subtest: pipe-D
[300.201713] Dynamic subtest pipe-D: SKIP (0.030s)
[300.206977] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.108s)
[300.306189] [039/155] (718s left) kms_flip (flip-vs-suspend)
[300.402827] Starting subtest: flip-vs-suspend
[300.405825] Starting dynamic subtest: A-eDP1
[461.139559] Dynamic subtest A-eDP1: SUCCESS (12.325s)
[461.142956] Subtest flip-vs-suspend: SUCCESS (12.327s)
[461.276506] [040/155] (558s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[461.380808] Starting subtest: bad-aux-stride-y-tiled-ccs
[461.383134] Starting dynamic subtest: pipe-A-eDP-1
[461.406064] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[461.417779] Starting dynamic subtest: pipe-B-eDP-1
[461.439683] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[461.450949] Starting dynamic subtest: pipe-C-eDP-1
[461.473488] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[461.484625] Starting dynamic subtest: pipe-D-eDP-1
[461.505801] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[461.509549] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.006s)
[463.751793] [041/155] (555s left) syncobj_timeline (wait-zero-handles)
[463.809576] Starting subtest: wait-zero-handles
[463.812029] Subtest wait-zero-handles: SUCCESS (0.000s)
[463.910209] [042/155] (555s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[464.009555] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[464.014191] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[464.100748] [043/155] (555s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-indfb-plflip-blt)
[464.204854] Starting subtest: fbcpsrhdr-2p-scndscrn-indfb-plflip-blt
[464.208886] Subtest fbcpsrhdr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[464.314313] [044/155] (555s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[464.416605] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[464.420787] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[464.514915] [045/155] (555s left) gem_exec_params (sol-reset-not-gen7)
[464.577907] Starting subtest: sol-reset-not-gen7
[464.580484] Subtest sol-reset-not-gen7: SUCCESS (0.003s)
[464.701469] [046/155] (554s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[465.257399] Starting subtest: syncobj-timeline-invalid-wait
[465.263805] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.005s)
[466.399550] [047/155] (553s left) kms_psr (fbc-pr-cursor-blt)
[466.491118] Starting subtest: fbc-pr-cursor-blt
[466.495244] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[466.608771] [048/155] (553s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[466.711805] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[466.716058] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[466.814968] [049/155] (553s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[466.913977] Starting subtest: x-tiled-8bpp-rotate-90
[466.936540] Subtest x-tiled-8bpp-rotate-90: SKIP (0.022s)
[467.071105] [050/155] (552s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[467.176824] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[474.888947] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.634s)
[475.015270] [051/155] (544s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-indfb-pgflip-blt)
[475.117352] Starting subtest: psrhdr-2p-scndscrn-indfb-pgflip-blt
[475.121699] Subtest psrhdr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[475.215840] [052/155] (544s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[475.315537] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[475.317860] Starting dynamic subtest: pipe-A-eDP-1
[475.340832] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[475.354303] Starting dynamic subtest: pipe-B-eDP-1
[475.376320] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[475.385852] Starting dynamic subtest: pipe-C-eDP-1
[475.407498] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[475.417047] Starting dynamic subtest: pipe-D-eDP-1
[475.438891] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[475.443321] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[477.639743] [053/155] (542s left) gem_mmap_wc (read-write)
[477.691919] Subtest read-write: SKIP (0.000s)
[477.752454] [054/155] (542s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[477.797562] Starting subtest: etime-multi-wait-all-submitted-signaled
[477.900261] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.103s)
[477.973693] [055/155] (542s left) perf (whitelisted-registers-userspace-config)
[478.068232] Starting subtest: whitelisted-registers-userspace-config
[478.070789] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[478.111892] [056/155] (542s left) gem_eio (in-flight-10ms)
[478.336561] Starting subtest: in-flight-10ms
[487.130268] Subtest in-flight-10ms: SUCCESS (8.770s)
[487.306445] [057/155] (532s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[487.410667] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[487.414618] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s)
[487.487624] [058/155] (532s left) gem_fence_thrash (bo-write-verify-y)
[487.522059] Starting subtest: bo-write-verify-y
[487.550421] Subtest bo-write-verify-y: SKIP (0.026s)
[487.611622] [059/155] (532s left) kms_psr (pr-sprite-blt)
[487.710811] Starting subtest: pr-sprite-blt
[487.714984] Subtest pr-sprite-blt: SKIP (0.000s)
[487.788637] [060/155] (532s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[487.887753] Starting subtest: 4-tiled-64bpp-rotate-90
[487.908392] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.020s)
[488.024151] [061/155] (532s left) gem_ctx_persistence (legacy-engines-mixed-process)
[488.078997] Starting subtest: legacy-engines-mixed-process
[488.081090] Starting dynamic subtest: render
[489.282303] Dynamic subtest render: SUCCESS (1.201s)
[489.296338] Starting dynamic subtest: bsd1
[491.347711] Dynamic subtest bsd1: SUCCESS (2.060s)
[491.363593] Starting dynamic subtest: bsd2
[493.322304] Dynamic subtest bsd2: SUCCESS (1.970s)
[493.334758] Starting dynamic subtest: blt
[495.286279] Dynamic subtest blt: SUCCESS (1.961s)
[495.298943] Starting dynamic subtest: vebox
[497.350361] Dynamic subtest vebox: SUCCESS (2.063s)
[497.352826] Subtest legacy-engines-mixed-process: SUCCESS (9.264s)
[497.444194] [062/155] (522s left) gem_ppgtt (shrink-vs-evict-pinned)
[497.499450] Starting subtest: shrink-vs-evict-pinned
[503.297419] Subtest shrink-vs-evict-pinned: SUCCESS (5.743s)
[503.345860] [063/155] (517s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping)
[503.438697] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping
[503.443235] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[503.527712] [064/155] (516s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[503.580592] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[503.648945] [065/155] (516s left) api_intel_bb (reset-bb)
[503.710838] Starting subtest: reset-bb
[503.716151] Subtest reset-bb: SUCCESS (0.004s)
[503.832405] [066/155] (516s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-wc)
[503.940581] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-wc
[503.945237] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[504.056977] [067/155] (516s left) i915_query (query-topology-unsupported)
[504.109056] Starting subtest: query-topology-unsupported
[504.113598] Subtest query-topology-unsupported: SKIP (0.000s)
[504.223716] [068/155] (516s left) gem_ctx_exec (basic-norecovery)
[504.269688] Starting subtest: basic-norecovery
[504.549375] Subtest basic-norecovery: SUCCESS (0.280s)
[504.657977] [069/155] (516s left) gem_softpin (evict-active-interruptible)
[504.711652] Starting subtest: evict-active-interruptible
[504.719312] Subtest evict-active-interruptible: SUCCESS (0.007s)
[504.835208] [070/155] (515s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[504.931189] Starting subtest: plane-all-transition-nonblocking-fencing
[504.933131] Starting dynamic subtest: pipe-A-eDP-1
[507.428577] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.497s)
[507.744917] Starting dynamic subtest: pipe-B-eDP-1
[510.995688] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.263s)
[511.298004] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.363s)
[512.142867] [071/155] (508s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[512.251312] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[512.256960] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[512.349960] [072/155] (508s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[512.399844] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[512.461565] [073/155] (508s left) kms_big_fb (linear-8bpp-rotate-90)
[512.549680] Starting subtest: linear-8bpp-rotate-90
[512.570682] Subtest linear-8bpp-rotate-90: SKIP (0.020s)
[512.674431] [074/155] (508s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[512.780122] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[519.505370] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.728s)
[519.653212] [075/155] (501s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[519.707944] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[519.777082] [076/155] (501s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[519.879626] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[523.583585] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.708s)
[524.785973] [077/155] (496s left) kms_vblank (invalid)
[524.891351] Starting subtest: invalid
[524.893665] Starting dynamic subtest: pipe-A-eDP-1
[525.290217] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.400s)
[525.292420] Subtest invalid: SUCCESS (0.401s)
[526.117979] [078/155] (494s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[526.225045] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[526.229448] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[526.313355] [079/155] (494s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[526.407798] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[526.412380] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[526.505212] [080/155] (494s left) kms_pm_rpm (cursor-dpms)
[528.438463] Starting subtest: cursor-dpms
[528.443299] Subtest cursor-dpms: SKIP (0.000s)
[528.834961] [081/155] (492s left) kms_color (ctm-negative)
[528.934343] Starting subtest: ctm-negative
[528.936553] Starting dynamic subtest: pipe-A-eDP-1
[529.645119] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.708s)
[529.656733] Starting dynamic subtest: pipe-B-eDP-1
[531.032679] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.386s)
[531.048694] Starting dynamic subtest: pipe-C-eDP-1
[532.414274] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.381s)
[532.427201] Starting dynamic subtest: pipe-D-eDP-1
[533.744044] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.328s)
[533.745956] Subtest ctm-negative: SUCCESS (4.807s)
[534.559290] [082/155] (486s left) kms_psr (fbc-psr2-cursor-plane-move)
[534.657405] Starting subtest: fbc-psr2-cursor-plane-move
[534.659382] Starting dynamic subtest: eDP-1
[534.663566] Dynamic subtest eDP-1: SKIP (0.000s)
[534.667692] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s)
[534.731144] [083/155] (486s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-shrfb-msflip-blt)
[534.832651] Starting subtest: fbchdr-2p-scndscrn-shrfb-msflip-blt
[534.837056] Subtest fbchdr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[534.935099] [084/155] (486s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[534.999617] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[535.001758] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.001s)
[535.102968] [085/155] (486s left) kms_dp_linktrain_fallback (dp-fallback)
[535.211158] Starting subtest: dp-fallback
[535.217622] Subtest dp-fallback: SKIP (0.000s)
[535.283718] [086/155] (486s left) gem_lmem_swapping (massive)
[535.323805] Subtest massive: SKIP (0.000s)
[535.375025] [087/155] (486s left) kms_frontbuffer_tracking (psrhdr-slowdraw)
[535.479778] Starting subtest: psrhdr-slowdraw
[535.483427] Subtest psrhdr-slowdraw: SKIP (0.000s)
[535.574984] [088/155] (485s left) gem_exec_balancer (smoke)
[535.642020] Starting subtest: smoke
[558.326076] Subtest smoke: SUCCESS (22.621s)
[559.179906] [089/155] (462s left) kms_addfb_basic (unused-pitches)
[559.240664] Starting subtest: unused-pitches
[559.242963] Subtest unused-pitches: SUCCESS (0.000s)
[559.382466] [090/155] (462s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[559.442729] Starting subtest: multi-wait-for-submit-unsubmitted
[559.547362] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.103s)
[559.640039] [091/155] (462s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[559.743729] Starting subtest: fbcpsr-rgb101010-draw-blt
[564.515681] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (4.781s)
[564.669271] [092/155] (457s left) perf (blocking-parameterized)
[564.762726] Starting subtest: blocking-parameterized
[584.832046] Subtest blocking-parameterized: SUCCESS (20.019s)
[584.873642] [093/155] (436s left) gem_exec_schedule (u-submit-late-slice)
[584.955735] Starting subtest: u-submit-late-slice
[584.958027] Starting dynamic subtest: rcs0
[585.008015] Dynamic subtest rcs0: SUCCESS (0.057s)
[585.020144] Starting dynamic subtest: bcs0
[585.068556] Dynamic subtest bcs0: SUCCESS (0.059s)
[585.081733] Starting dynamic subtest: vcs0
[585.118543] Dynamic subtest vcs0: SUCCESS (0.049s)
[585.129552] Starting dynamic subtest: vcs1
[585.170332] Dynamic subtest vcs1: SUCCESS (0.051s)
[585.184811] Starting dynamic subtest: vecs0
[585.232923] Dynamic subtest vecs0: SUCCESS (0.060s)
[585.247367] Starting dynamic subtest: ccs0
[585.287695] Dynamic subtest ccs0: SUCCESS (0.054s)
[585.290096] Subtest u-submit-late-slice: SUCCESS (0.339s)
[586.383400] [094/155] (435s left) kms_prop_blob (invalid-get-prop)
[586.442673] Starting subtest: invalid-get-prop
[586.444940] Subtest invalid-get-prop: SUCCESS (0.000s)
[586.556943] [095/155] (435s left) kms_cdclk (plane-scaling)
[586.648747] Starting subtest: plane-scaling
[586.650956] Starting dynamic subtest: pipe-A-eDP-1
[586.941866] Dynamic subtest pipe-A-eDP-1: SKIP (0.290s)
[586.953693] Starting dynamic subtest: pipe-B-eDP-1
[586.958325] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[586.969370] Starting dynamic subtest: pipe-C-eDP-1
[586.974020] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[586.984798] Starting dynamic subtest: pipe-D-eDP-1
[586.989319] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[586.993760] Subtest plane-scaling: SKIP (0.298s)
[587.801949] [096/155] (434s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[587.894296] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[587.898727] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[587.984233] [097/155] (433s left) kms_addfb_basic (bad-pitch-0)
[588.043298] Starting subtest: bad-pitch-0
[588.045602] Subtest bad-pitch-0: SUCCESS (0.000s)
[588.196046] [098/155] (433s left) gem_userptr_blits (sd-probe)
[588.257055] Starting subtest: sd-probe
[588.259220] Subtest sd-probe: SUCCESS (0.000s)
[588.379426] [099/155] (433s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-pwrite)
[588.474348] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-pwrite
[588.479017] Subtest psrhdr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[588.570676] [100/155] (433s left) gem_eio (unwedge-stress)
[588.794584] Starting subtest: unwedge-stress
[588.796303] Starting dynamic subtest: render
[593.586666] Dynamic subtest render: SUCCESS (4.789s)
[593.604582] Starting dynamic subtest: bsd1
[611.797748] Dynamic subtest bsd1: SUCCESS (18.208s)
[611.815572] Starting dynamic subtest: bsd2
[629.819355] Dynamic subtest bsd2: SUCCESS (18.017s)
[629.836557] Starting dynamic subtest: blt
[629.840485] Dynamic subtest blt: SKIP (0.000s)
[629.850586] Starting dynamic subtest: vebox
[647.762968] Dynamic subtest vebox: SUCCESS (17.937s)
[647.764964] Subtest unwedge-stress: SUCCESS (58.956s)
[649.311667] [101/155] (372s left) i915_drm_fdinfo (busy)
[649.358400] Starting subtest: busy
[649.360718] Starting dynamic subtest: rcs0
[649.389653] Dynamic subtest rcs0: SKIP (0.031s)
[649.402592] Starting dynamic subtest: bcs0
[649.407142] Dynamic subtest bcs0: SKIP (0.000s)
[649.417179] Starting dynamic subtest: vcs0
[649.421739] Dynamic subtest vcs0: SKIP (0.000s)
[649.431972] Starting dynamic subtest: vcs1
[649.436378] Dynamic subtest vcs1: SKIP (0.000s)
[649.446765] Starting dynamic subtest: vecs0
[649.451162] Dynamic subtest vecs0: SKIP (0.000s)
[649.461553] Starting dynamic subtest: ccs0
[649.465915] Dynamic subtest ccs0: SKIP (0.000s)
[649.470322] Subtest busy: SKIP (0.037s)
[649.509986] [102/155] (372s left) kms_big_fb (x-tiled-addfb-size-overflow)
[649.614620] Starting subtest: x-tiled-addfb-size-overflow
[649.616936] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.000s)
[649.723402] [103/155] (372s left) gem_exec_schedule (preempt-user)
[649.795458] Starting subtest: preempt-user
[649.797535] Starting dynamic subtest: rcs0
[649.814710] Dynamic subtest rcs0: SUCCESS (0.025s)
[649.829544] Starting dynamic subtest: bcs0
[649.835908] Dynamic subtest bcs0: SUCCESS (0.020s)
[649.847344] Starting dynamic subtest: vcs0
[649.860456] Dynamic subtest vcs0: SUCCESS (0.024s)
[649.871534] Starting dynamic subtest: vcs1
[649.882477] Dynamic subtest vcs1: SUCCESS (0.021s)
[649.893547] Starting dynamic subtest: vecs0
[649.904232] Dynamic subtest vecs0: SUCCESS (0.020s)
[649.915352] Starting dynamic subtest: ccs0
[649.930359] Dynamic subtest ccs0: SUCCESS (0.025s)
[649.932804] Subtest preempt-user: SUCCESS (0.141s)
[651.412132] [104/155] (370s left) gem_mmap_gtt (basic-read)
[651.473403] Subtest basic-read: SKIP (0.000s)
[651.532754] [105/155] (370s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[651.634939] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[658.970850] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.336s)
[659.101636] [106/155] (363s left) kms_chamelium_edid (hdmi-edid-read)
[659.481462] Subtest hdmi-edid-read: SKIP (0.000s)
[660.339558] [107/155] (361s left) gem_lmem_swapping (random)
[660.381807] Subtest random: SKIP (0.000s)
[660.423539] [108/155] (361s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[660.508465] Starting subtest: 2x-absolute-wf_vblank-interruptible
[660.519062] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.011s)
[660.631099] [109/155] (361s left) vgem_basic (create)
[660.666373] Starting subtest: create
[660.668694] Subtest create: SUCCESS (0.000s)
[660.731992] [110/155] (361s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[660.821056] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu
[660.825525] Subtest psrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[660.921886] [111/155] (361s left) kms_frontbuffer_tracking (fbcpsrhdr-modesetfrombusy)
[661.029093] Starting subtest: fbcpsrhdr-modesetfrombusy
[661.033157] Subtest fbcpsrhdr-modesetfrombusy: SKIP (0.000s)
[661.137870] [112/155] (361s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[661.243334] Starting subtest: fbcpsr-tiling-y
[661.247484] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[661.348545] [113/155] (361s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-render)
[661.445222] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-render
[661.448848] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[661.531554] [114/155] (361s left) gem_ctx_sseu (invalid-args)
[661.595068] Subtest invalid-args: SKIP (0.000s)
[661.667132] [115/155] (361s left) kms_psr (pr-cursor-blt)
[661.759843] Starting subtest: pr-cursor-blt
[661.763406] Subtest pr-cursor-blt: SKIP (0.000s)
[661.836456] [116/155] (360s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[662.092849] Starting subtest: cursor-rapid-movement-256x85
[662.139179] Subtest cursor-rapid-movement-256x85: SKIP (0.041s)
[662.313964] [117/155] (360s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[662.408633] Starting subtest: psr-rgb101010-draw-mmap-cpu
[669.538303] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (7.132s)
[669.653461] [118/155] (353s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[669.751166] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[669.755219] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[669.866986] [119/155] (352s left) kms_psr (psr2-primary-blt)
[669.955569] Starting subtest: psr2-primary-blt
[669.957869] Starting dynamic subtest: eDP-1
[671.694010] Dynamic subtest eDP-1: SUCCESS (1.736s)
[671.696209] Subtest psr2-primary-blt: SUCCESS (1.737s)
[672.568320] [120/155] (350s left) prime_mmap (test_aperture_limit)
[672.622876] Starting subtest: test_aperture_limit
[672.624851] Starting dynamic subtest: test_aperture_limit-smem
[672.631776] Dynamic subtest test_aperture_limit-smem: SKIP (0.008s)
[672.636206] Subtest test_aperture_limit: SKIP (0.008s)
[672.703046] [121/155] (350s left) gem_caching (writes)
[672.756942] Subtest writes: SKIP (0.000s)
[672.832118] [122/155] (350s left) i915_hangman (engine-engine-hang)
[672.889993] Starting subtest: engine-engine-hang
[672.891859] Starting dynamic subtest: rcs0
[674.260587] Dynamic subtest rcs0: SUCCESS (1.370s)
[674.275151] Starting dynamic subtest: bcs0
[676.244570] Dynamic subtest bcs0: SUCCESS (1.981s)
[676.258544] Starting dynamic subtest: vcs0
[678.293906] Dynamic subtest vcs0: SUCCESS (2.046s)
[678.308073] Starting dynamic subtest: vcs1
[680.276930] Dynamic subtest vcs1: SUCCESS (1.979s)
[680.292049] Starting dynamic subtest: vecs0
[682.261881] Dynamic subtest vecs0: SUCCESS (1.982s)
[682.278921] Starting dynamic subtest: ccs0
[684.309837] Dynamic subtest ccs0: SUCCESS (2.045s)
[684.313412] Subtest engine-engine-hang: SUCCESS (11.418s)
[684.394761] [123/155] (338s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-move)
[684.492575] Starting subtest: hdr-2p-scndscrn-cur-indfb-move
[684.497130] Subtest hdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[684.591449] [124/155] (338s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[684.683975] Starting subtest: yf-tiled-64bpp-rotate-0
[684.688548] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[684.784219] [125/155] (338s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-shrfb-msflip-blt)
[684.886611] Starting subtest: fbchdr-2p-primscrn-shrfb-msflip-blt
[684.890777] Subtest fbchdr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[684.978542] [126/155] (338s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-pwrite)
[685.067947] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-pwrite
[685.072342] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[685.161070] [127/155] (338s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[685.215570] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[685.284522] [128/155] (337s left) gem_spin_batch (resubmit)
[685.347668] Starting subtest: resubmit
[685.349600] Starting dynamic subtest: rcs0
[685.351612] Dynamic subtest rcs0: SUCCESS (0.005s)
[685.363571] Starting dynamic subtest: bcs0
[685.365549] Dynamic subtest bcs0: SUCCESS (0.002s)
[685.375942] Starting dynamic subtest: vcs0
[685.377768] Dynamic subtest vcs0: SUCCESS (0.002s)
[685.387453] Starting dynamic subtest: vcs1
[685.389325] Dynamic subtest vcs1: SUCCESS (0.004s)
[685.399435] Starting dynamic subtest: vecs0
[685.401305] Dynamic subtest vecs0: SUCCESS (0.002s)
[685.411118] Starting dynamic subtest: ccs0
[685.412991] Dynamic subtest ccs0: SUCCESS (0.002s)
[685.414792] Subtest resubmit: SUCCESS (0.023s)
[685.616662] [129/155] (337s left) api_intel_allocator (standalone)
[685.674125] Starting subtest: standalone
[685.688422] Subtest standalone: SUCCESS (0.016s)
[685.805793] [130/155] (337s left) i915_query (query-regions-sanity-check)
[685.855554] Starting subtest: query-regions-sanity-check
[685.864095] Subtest query-regions-sanity-check: SUCCESS (0.010s)
[685.986381] [131/155] (337s left) kms_chamelium_hpd (hdmi-hpd-storm)
[686.364486] Subtest hdmi-hpd-storm: SKIP (0.000s)
[687.181880] [132/155] (336s left) gen7_exec_parse (basic-rejected)
[687.239591] Subtest basic-rejected: SKIP (0.000s)
[687.294371] [133/155] (336s left) kms_joiner (basic-force-ultra-joiner)
[687.383731] Starting subtest: basic-force-ultra-joiner
[687.388148] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[687.452791] [134/155] (336s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-indfb-msflip-blt)
[687.550567] Starting subtest: psrhdr-2p-primscrn-indfb-msflip-blt
[687.554837] Subtest psrhdr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[687.653420] [135/155] (335s left) syncobj_basic (bad-destroy)
[687.712186] Starting subtest: bad-destroy
[687.714121] Subtest bad-destroy: SUCCESS (0.000s)
[687.812926] [136/155] (335s left) kms_flip (2x-flip-vs-expired-vblank)
[687.911336] Starting subtest: 2x-flip-vs-expired-vblank
[687.922236] Subtest 2x-flip-vs-expired-vblank: SKIP (0.011s)
[688.050779] [137/155] (335s left) kms_flip (dpms-vs-vblank-race)
[688.134597] Starting subtest: dpms-vs-vblank-race
[688.136264] Starting dynamic subtest: A-eDP1
[692.057430] Dynamic subtest A-eDP1: SUCCESS (3.922s)
[692.068981] Starting dynamic subtest: B-eDP1
[695.569279] Dynamic subtest B-eDP1: SUCCESS (3.511s)
[695.580164] Starting dynamic subtest: C-eDP1
[699.148142] Dynamic subtest C-eDP1: SUCCESS (3.580s)
[699.159296] Starting dynamic subtest: D-eDP1
[703.785246] Dynamic subtest D-eDP1: SUCCESS (4.633s)
[703.788132] Subtest dpms-vs-vblank-race: SUCCESS (15.656s)
[704.664951] [138/155] (318s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-fullscreen)
[704.763386] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-fullscreen
[704.767878] Subtest psrhdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[704.868298] [139/155] (318s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[704.961419] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[704.963673] Starting dynamic subtest: pipe-A
[704.986220] Dynamic subtest pipe-A: SKIP (0.021s)
[704.997600] Starting dynamic subtest: pipe-B
[705.017265] Dynamic subtest pipe-B: SKIP (0.031s)
[705.027844] Starting dynamic subtest: pipe-C
[705.048829] Dynamic subtest pipe-C: SKIP (0.032s)
[705.060547] Starting dynamic subtest: pipe-D
[705.087223] Dynamic subtest pipe-D: SKIP (0.036s)
[705.091589] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SKIP (0.122s)
[705.186440] [140/155] (318s left) gem_exec_params (secure-non-master)
[705.244231] Starting subtest: secure-non-master
[705.248588] Subtest secure-non-master: SKIP (0.000s)
[705.354656] [141/155] (318s left) syncobj_timeline (wait-for-submit-snapshot)
[705.406650] Starting subtest: wait-for-submit-snapshot
[705.487472] Subtest wait-for-submit-snapshot: SUCCESS (0.081s)
[705.577643] [142/155] (318s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[705.664192] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[705.667743] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[705.758673] [143/155] (318s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[705.868445] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[705.871858] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[705.965277] [144/155] (317s left) core_setmaster (master-drop-set-root)
[706.031925] Starting subtest: master-drop-set-root
[706.044855] Subtest master-drop-set-root: SUCCESS (0.013s)
[706.096342] [145/155] (317s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[706.186382] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[706.190004] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[706.282935] [146/155] (317s left) kms_vblank (wait-busy-hang)
[706.367003] Starting subtest: wait-busy-hang
[706.368555] Starting dynamic subtest: pipe-A-eDP-1
[734.061923] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.697s)
[734.077911] Starting dynamic subtest: pipe-D-eDP-1
[759.033244] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.967s)
[759.035466] Subtest wait-busy-hang: SUCCESS (52.668s)
[759.927987] [147/155] (264s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[760.022187] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[760.026667] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[760.135380] [148/155] (263s left) kms_atomic (plane-primary-legacy)
[760.233320] Starting subtest: plane-primary-legacy
[760.235813] Starting dynamic subtest: pipe-A-eDP-1
[760.650060] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.416s)
[760.652458] Subtest plane-primary-legacy: SUCCESS (0.417s)
[761.459599] [149/155] (262s left) gem_pxp (reject-modify-context-protection-off-1)
[761.582424] Starting subtest: reject-modify-context-protection-off-1
[761.585090] Subtest reject-modify-context-protection-off-1: SUCCESS (0.002s)
[761.698557] [150/155] (262s left) gem_ringfill (engines-basic)
[767.290262] Starting subtest: engines-basic
[767.292788] Starting dynamic subtest: rcs0
[767.354933] Dynamic subtest rcs0: SUCCESS (0.065s)
[767.367420] Starting dynamic subtest: bcs0
[767.401328] Dynamic subtest bcs0: SUCCESS (0.044s)
[767.412846] Starting dynamic subtest: vcs0
[767.444416] Dynamic subtest vcs0: SUCCESS (0.041s)
[767.456344] Starting dynamic subtest: vcs1
[767.487429] Dynamic subtest vcs1: SUCCESS (0.041s)
[767.498907] Starting dynamic subtest: vecs0
[767.531330] Dynamic subtest vecs0: SUCCESS (0.042s)
[767.542611] Starting dynamic subtest: ccs0
[767.576320] Dynamic subtest ccs0: SUCCESS (0.043s)
[767.578798] Subtest engines-basic: SUCCESS (0.288s)
[767.658896] [151/155] (256s left) kms_properties (colorop-properties-legacy)
[767.762766] Starting subtest: colorop-properties-legacy
[767.765039] Starting dynamic subtest: pipe-A-eDP-1
[768.135109] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.371s)
[768.147146] Starting dynamic subtest: pipe-B-eDP-1
[769.238177] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.100s)
[769.250160] Starting dynamic subtest: pipe-C-eDP-1
[770.282928] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.041s)
[770.294050] Starting dynamic subtest: pipe-D-eDP-1
[771.326879] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.044s)
[771.329325] Subtest colorop-properties-legacy: SUCCESS (3.563s)
[772.226917] [152/155] (252s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[772.318569] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[772.320838] Starting dynamic subtest: pipe-A-eDP-1
[772.330067] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[772.343562] Starting dynamic subtest: pipe-B-eDP-1
[772.352603] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[772.363285] Starting dynamic subtest: pipe-C-eDP-1
[772.372078] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[772.383078] Starting dynamic subtest: pipe-D-eDP-1
[772.391765] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[772.396208] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[774.597288] [153/155] (249s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[774.690539] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[774.704056] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[774.789078] [154/155] (249s left) gem_exec_reloc (basic-write-gtt)
[774.839034] Subtest basic-write-gtt: SKIP (0.000s)
[774.906754] [155/155] (249s left) gem_create (busy-create)
[774.962634] Starting subtest: busy-create
[774.964788] Starting dynamic subtest: smem0
[808.301875] Dynamic subtest smem0: SUCCESS (33.335s)
[808.304572] Subtest busy-create: SUCCESS (33.337s)
[808.484906] Closing watchdogs
results: parsing output: 0/ for test: gem_softpin
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: syncobj_timeline
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_psr2_sf
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_async_flips
results: parsing output: 8/ for test: gem_exec_balancer
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gem_userptr_blits
results: parsing output: 11/ for test: kms_plane_alpha_blend
results: parsing output: 12/ for test: kms_plane
results: parsing output: 13/ for test: tools_test
results: parsing output: 14/ for test: kms_rotation_crc
results: parsing output: 15/ for test: fbdev
results: parsing output: 16/ for test: gem_userptr_blits
results: parsing output: 17/ for test: kms_flip
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_exec_schedule
results: parsing output: 20/ for test: kms_ccs
results: parsing output: 21/ for test: kms_cursor_legacy
results: parsing output: 22/ for test: perf_pmu
results: parsing output: 23/ for test: kms_lease
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_content_protection
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_cursor_legacy
results: parsing output: 29/ for test: prime_vgem
results: parsing output: 30/ for test: i915_pm_rpm
results: parsing output: 31/ for test: gem_mmap_gtt
results: parsing output: 32/ for test: perf
results: parsing output: 33/ for test: kms_cursor_crc
results: parsing output: 34/ for test: kms_cursor_crc
results: parsing output: 35/ for test: kms_dsc
results: parsing output: 36/ for test: gem_exec_schedule
results: parsing output: 37/ for test: kms_plane_scaling
results: parsing output: 38/ for test: kms_flip
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: syncobj_timeline
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: gem_exec_params
results: parsing output: 45/ for test: gem_exec_fence
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_ccs
results: parsing output: 52/ for test: gem_mmap_wc
results: parsing output: 53/ for test: syncobj_timeline
results: parsing output: 54/ for test: perf
results: parsing output: 55/ for test: gem_eio
results: parsing output: 56/ for test: kms_flip_scaled_crc
results: parsing output: 57/ for test: gem_fence_thrash
results: parsing output: 58/ for test: kms_psr
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: gem_ctx_persistence
results: parsing output: 61/ for test: gem_ppgtt
results: parsing output: 62/ for test: kms_plane
results: parsing output: 63/ for test: kms_pipe_b_c_ivb
results: parsing output: 64/ for test: api_intel_bb
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: i915_query
results: parsing output: 67/ for test: gem_ctx_exec
results: parsing output: 68/ for test: gem_softpin
results: parsing output: 69/ for test: kms_atomic_transition
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_mmap_gtt
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_fenced_exec_thrash
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_vblank
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: kms_pm_rpm
results: parsing output: 80/ for test: kms_color
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: kms_dp_linktrain_fallback
results: parsing output: 85/ for test: gem_lmem_swapping
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_exec_balancer
results: parsing output: 88/ for test: kms_addfb_basic
results: parsing output: 89/ for test: syncobj_wait
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: perf
results: parsing output: 92/ for test: gem_exec_schedule
results: parsing output: 93/ for test: kms_prop_blob
results: parsing output: 94/ for test: kms_cdclk
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_addfb_basic
results: parsing output: 97/ for test: gem_userptr_blits
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: gem_eio
results: parsing output: 100/ for test: i915_drm_fdinfo
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: gem_exec_schedule
results: parsing output: 103/ for test: gem_mmap_gtt
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_chamelium_edid
results: parsing output: 106/ for test: gem_lmem_swapping
results: parsing output: 107/ for test: kms_flip
results: parsing output: 108/ for test: vgem_basic
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_ctx_sseu
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: kms_cursor_crc
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: prime_mmap
results: parsing output: 120/ for test: gem_caching
results: parsing output: 121/ for test: i915_hangman
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_exec_reloc
results: parsing output: 127/ for test: gem_spin_batch
results: parsing output: 128/ for test: api_intel_allocator
results: parsing output: 129/ for test: i915_query
results: parsing output: 130/ for test: kms_chamelium_hpd
results: parsing output: 131/ for test: gen7_exec_parse
results: parsing output: 132/ for test: kms_joiner
results: parsing output: 133/ for test: kms_frontbuffer_tracking
results: parsing output: 134/ for test: syncobj_basic
results: parsing output: 135/ for test: kms_flip
results: parsing output: 136/ for test: kms_flip
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: kms_plane_scaling
results: parsing output: 139/ for test: gem_exec_params
results: parsing output: 140/ for test: syncobj_timeline
results: parsing output: 141/ for test: kms_frontbuffer_tracking
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: core_setmaster
results: parsing output: 144/ for test: kms_frontbuffer_tracking
results: parsing output: 145/ for test: kms_vblank
results: parsing output: 146/ for test: kms_frontbuffer_tracking
results: parsing output: 147/ for test: kms_atomic
results: parsing output: 148/ for test: gem_pxp
results: parsing output: 149/ for test: gem_ringfill
results: parsing output: 150/ for test: kms_properties
results: parsing output: 151/ for test: kms_ccs
results: parsing output: 152/ for test: kms_flip
results: parsing output: 153/ for test: gem_exec_reloc
results: parsing output: 154/ for test: gem_create
Done.