[57.779452] Initializing watchdogs
[57.779598]   /dev/watchdog0
[57.795320] [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.799714] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.801964] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.805627] [001/133] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[57.922395] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[57.926826] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[58.027763] [002/133] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[58.127349] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[58.131875] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[58.224630] [003/133] (960s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[58.324369] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[59.332037] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.011s)
[59.461419] [004/133] (958s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[59.565636] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[66.270219] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.719s)
[66.379182] [005/133] (952s left) gem_exec_balancer (noheartbeat)
[66.675079] Starting subtest: noheartbeat
[66.679830] Subtest noheartbeat: SKIP (0.000s)
[66.822438] [006/133] (951s left) syncobj_wait (multi-wait-submitted-signaled)
[66.877835] Starting subtest: multi-wait-submitted-signaled
[66.880224] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[67.262215] [007/133] (951s left) gen7_exec_parse (batch-without-end)
[67.537551] Subtest batch-without-end: SKIP (0.000s)
[67.757274] [008/133] (950s left) gem_pread (exhaustion)
[67.898986] Subtest exhaustion: SKIP (0.000s)
[68.025166] [009/133] (950s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[68.172742] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[68.177302] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[68.276344] [010/133] (950s left) kms_cursor_crc (cursor-sliding-max-size)
[68.573125] Starting subtest: cursor-sliding-max-size
[68.579813] Subtest cursor-sliding-max-size: SKIP (0.000s)
[68.681282] [011/133] (950s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[68.783495] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[68.786920] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[68.875662] [012/133] (949s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[68.966471] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[68.968454] Starting dynamic subtest: pipe-A-eDP-1
[74.937051] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.975s)
[74.947159] Starting dynamic subtest: pipe-B-eDP-1
[81.571658] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.634s)
[81.574182] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.611s)
[82.456907] [013/133] (936s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[82.555452] Starting subtest: fbc-rgb565-draw-blt
[86.687580] Subtest fbc-rgb565-draw-blt: SUCCESS (4.132s)
[87.844385] [014/133] (931s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[87.936859] Starting subtest: plane-upscale-20x20-with-rotation
[87.939232] Starting dynamic subtest: pipe-A
[88.161063] Dynamic subtest pipe-A: SUCCESS (0.226s)
[88.170448] Starting dynamic subtest: pipe-B
[89.410620] Dynamic subtest pipe-B: SUCCESS (1.249s)
[89.420433] Starting dynamic subtest: pipe-C
[90.747948] Dynamic subtest pipe-C: SUCCESS (1.336s)
[90.757226] Starting dynamic subtest: pipe-D
[92.084552] Dynamic subtest pipe-D: SUCCESS (1.337s)
[92.086832] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.151s)
[93.258581] [015/133] (925s left) gem_exec_flush (basic-wb-ro-before-default)
[93.316797] Starting subtest: basic-wb-ro-before-default
[98.784691] Subtest basic-wb-ro-before-default: SUCCESS (5.468s)
[98.969082] [016/133] (919s left) gem_eio (in-flight-internal-immediate)
[99.191681] Starting subtest: in-flight-internal-immediate
[100.960092] Subtest in-flight-internal-immediate: SUCCESS (1.768s)
[101.073794] [017/133] (917s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping)
[101.168027] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping
[101.193866] Starting dynamic subtest: pipe-A-plane-0
[101.482781] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[101.492588] Starting dynamic subtest: pipe-A-plane-3
[101.715722] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s)
[102.851957] Starting dynamic subtest: pipe-B-plane-0
[103.146797] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[103.156633] Starting dynamic subtest: pipe-B-plane-3
[103.377590] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s)
[103.685834] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.520s)
[104.527891] [018/133] (914s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[104.765124] Starting subtest: cursor-rapid-movement-256x256
[104.770644] Starting dynamic subtest: pipe-A-eDP-1
[105.317118] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.547s)
[105.341974] Starting dynamic subtest: pipe-D-eDP-1
[106.523591] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.187s)
[106.525812] Subtest cursor-rapid-movement-256x256: SUCCESS (1.758s)
[107.368586] [019/133] (911s left) kms_psr (psr2-sprite-plane-move)
[107.460277] Starting subtest: psr2-sprite-plane-move
[107.462590] Starting dynamic subtest: eDP-1
[109.201044] Dynamic subtest eDP-1: SUCCESS (1.741s)
[109.203805] Subtest psr2-sprite-plane-move: SUCCESS (1.742s)
[110.040866] [020/133] (909s left) kms_invalid_mode (bad-vsync-start)
[110.134555] Starting subtest: bad-vsync-start
[110.136796] Starting dynamic subtest: pipe-A-eDP-1
[110.415438] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s)
[110.424388] Starting dynamic subtest: pipe-B-eDP-1
[110.426265] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[110.433801] Starting dynamic subtest: pipe-C-eDP-1
[110.435699] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[110.443799] Starting dynamic subtest: pipe-D-eDP-1
[110.445969] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[110.448135] Subtest bad-vsync-start: SUCCESS (0.288s)
[111.271814] [021/133] (907s left) kms_cursor_crc (cursor-size-change)
[111.374271] Starting subtest: cursor-size-change
[111.376623] Starting dynamic subtest: pipe-A-eDP-1
[112.164053] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.786s)
[112.173078] Starting dynamic subtest: pipe-D-eDP-1
[113.631158] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.467s)
[113.633158] Subtest cursor-size-change: SUCCESS (2.255s)
[114.476273] [022/133] (904s left) kms_addfb_basic (legacy-format)
[114.525861] Starting subtest: legacy-format
[114.552215] Subtest legacy-format: SUCCESS (0.021s)
[114.692140] [023/133] (904s left) gem_exec_schedule (promotion)
[114.758047] Starting subtest: promotion
[114.760405] Starting dynamic subtest: rcs0
[114.878832] Dynamic subtest rcs0: SUCCESS (0.126s)
[114.889245] Starting dynamic subtest: vcs0
[114.968690] Dynamic subtest vcs0: SUCCESS (0.087s)
[114.982351] Starting dynamic subtest: vcs1
[115.064834] Dynamic subtest vcs1: SUCCESS (0.096s)
[115.082300] Starting dynamic subtest: vecs0
[115.151047] Dynamic subtest vecs0: SUCCESS (0.086s)
[115.160088] Starting dynamic subtest: ccs0
[115.265378] Dynamic subtest ccs0: SUCCESS (0.113s)
[115.268534] Subtest promotion: SUCCESS (0.513s)
[116.023401] [024/133] (903s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[116.143627] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[116.147878] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[116.247320] [025/133] (903s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[116.639972] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[117.453928] [026/133] (901s left) gem_exec_schedule (fairslice-all)
[117.538109] Starting subtest: fairslice-all
[119.589770] Subtest fairslice-all: SUCCESS (2.054s)
[119.889788] [027/133] (899s left) kms_lease (implicit-plane-lease)
[119.999273] Starting subtest: implicit-plane-lease
[120.001429] Subtest implicit-plane-lease: SUCCESS (0.004s)
[120.110769] [028/133] (899s left) kms_cursor_crc (cursor-alpha-opaque)
[120.198295] Starting subtest: cursor-alpha-opaque
[120.200465] Starting dynamic subtest: pipe-A-eDP-1
[120.803790] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.607s)
[120.813311] Starting dynamic subtest: pipe-D-eDP-1
[122.063611] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.257s)
[122.065745] Subtest cursor-alpha-opaque: SUCCESS (1.867s)
[122.929607] [029/133] (896s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[123.035332] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[123.037651] Starting dynamic subtest: pipe-A-eDP-1
[123.061085] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[123.070235] Starting dynamic subtest: pipe-B-eDP-1
[123.092059] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[123.099908] Starting dynamic subtest: pipe-C-eDP-1
[123.121695] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[123.129709] Starting dynamic subtest: pipe-D-eDP-1
[123.152242] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[123.156294] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.004s)
[125.200712] [030/133] (894s left) syncobj_timeline (reset-signaled)
[125.259960] Starting subtest: reset-signaled
[125.262391] Subtest reset-signaled: SUCCESS (0.000s)
[125.376472] [031/133] (894s left) gem_exec_reloc (basic-cpu-active)
[125.436697] Subtest basic-cpu-active: SKIP (0.000s)
[125.511644] [032/133] (894s left) gem_exec_parallel (fds)
[125.586052] Starting subtest: fds
[125.588184] Starting dynamic subtest: rcs0
[128.732895] Dynamic subtest rcs0: SUCCESS (3.147s)
[128.741655] Starting dynamic subtest: bcs0
[132.678546] Dynamic subtest bcs0: SUCCESS (3.945s)
[132.688553] Starting dynamic subtest: vcs0
[136.185369] Dynamic subtest vcs0: SUCCESS (3.505s)
[136.196860] Starting dynamic subtest: vcs1
[140.216626] Dynamic subtest vcs1: SUCCESS (4.028s)
[140.225813] Starting dynamic subtest: vecs0
[144.185865] Dynamic subtest vecs0: SUCCESS (3.967s)
[144.197195] Starting dynamic subtest: ccs0
[148.224769] Dynamic subtest ccs0: SUCCESS (4.036s)
[148.227428] Subtest fds: SUCCESS (22.640s)
[148.424425] [033/133] (871s left) kms_vblank (wait-busy)
[148.515861] Starting subtest: wait-busy
[148.518036] Starting dynamic subtest: pipe-A-eDP-1
[150.417727] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.902s)
[150.431842] Starting dynamic subtest: pipe-D-eDP-1
[152.975382] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.552s)
[152.977325] Subtest wait-busy: SUCCESS (4.460s)
[153.788269] [034/133] (865s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[153.896818] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[153.901441] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[153.970050] [035/133] (865s left) kms_sequence (queue-busy)
[154.058837] Starting subtest: queue-busy
[154.060696] Starting dynamic subtest: pipe-A-eDP-1
[155.998806] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.941s)
[156.013235] Starting dynamic subtest: pipe-B-eDP-1
[158.549295] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.549s)
[158.558066] Starting dynamic subtest: pipe-C-eDP-1
[161.182449] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.631s)
[161.191261] Starting dynamic subtest: pipe-D-eDP-1
[163.744637] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.562s)
[163.746769] Subtest queue-busy: SUCCESS (9.688s)
[164.538135] [036/133] (855s left) gem_exec_whisper (basic-fds-forked-all)
[164.598793] Starting subtest: basic-fds-forked-all
[186.870385] Subtest basic-fds-forked-all: SUCCESS (22.270s)
[187.059905] [037/133] (832s left) kms_cursor_legacy (torture-bo)
[187.187547] Starting subtest: torture-bo
[187.189675] Starting dynamic subtest: pipe-A
[193.280231] Dynamic subtest pipe-A: SUCCESS (6.090s)
[193.296524] Starting dynamic subtest: pipe-B
[200.116734] Dynamic subtest pipe-B: SUCCESS (6.835s)
[200.127638] Starting dynamic subtest: pipe-C
[207.774074] Dynamic subtest pipe-C: SUCCESS (7.656s)
[207.783157] Starting dynamic subtest: pipe-D
[215.228597] Dynamic subtest pipe-D: SUCCESS (7.450s)
[215.240264] Starting dynamic subtest: all-pipes
[223.554131] Dynamic subtest all-pipes: SUCCESS (8.322s)
[223.556854] Subtest torture-bo: SUCCESS (36.364s)
[223.708376] [038/133] (796s left) perf_pmu (most-busy-idle-check-all)
[223.763513] Starting subtest: most-busy-idle-check-all
[223.765749] Starting dynamic subtest: rcs0
[224.918579] Dynamic subtest rcs0: SUCCESS (1.154s)
[224.929055] Starting dynamic subtest: bcs0
[226.839255] Dynamic subtest bcs0: SUCCESS (1.917s)
[226.852445] Starting dynamic subtest: vcs0
[228.886671] Dynamic subtest vcs0: SUCCESS (2.044s)
[228.899087] Starting dynamic subtest: vcs1
[230.934483] Dynamic subtest vcs1: SUCCESS (2.045s)
[230.947062] Starting dynamic subtest: vecs0
[232.918499] Dynamic subtest vecs0: SUCCESS (1.981s)
[232.930886] Starting dynamic subtest: ccs0
[234.902737] Dynamic subtest ccs0: SUCCESS (1.981s)
[234.905676] Subtest most-busy-idle-check-all: SUCCESS (11.140s)
[234.999751] [039/133] (784s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[235.092068] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[241.739530] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.649s)
[241.860312] [040/133] (778s left) gem_exec_fence (basic-wait)
[242.039018] Starting subtest: basic-wait
[242.041574] Starting dynamic subtest: rcs0
[242.122988] Dynamic subtest rcs0: SUCCESS (0.084s)
[242.134692] Starting dynamic subtest: bcs0
[242.179373] Dynamic subtest bcs0: SUCCESS (0.055s)
[242.195094] Starting dynamic subtest: vcs0
[242.231487] Dynamic subtest vcs0: SUCCESS (0.050s)
[242.241235] Starting dynamic subtest: vcs1
[242.288200] Dynamic subtest vcs1: SUCCESS (0.055s)
[242.297242] Starting dynamic subtest: vecs0
[242.342467] Dynamic subtest vecs0: SUCCESS (0.052s)
[242.354520] Starting dynamic subtest: ccs0
[242.395632] Dynamic subtest ccs0: SUCCESS (0.050s)
[242.398033] Subtest basic-wait: SUCCESS (0.358s)
[243.977470] [FACT gem_exec_fence (basic-wait)] new: kernel.kmod_is_loaded.vgem: true
[243.981062] [041/133] (775s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[244.082528] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[244.084953] Starting dynamic subtest: pipe-A-eDP-1
[244.142264] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[244.152771] Starting dynamic subtest: pipe-B-eDP-1
[244.208210] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[244.218597] Starting dynamic subtest: pipe-C-eDP-1
[244.274478] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[244.284586] Starting dynamic subtest: pipe-D-eDP-1
[244.341818] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[244.346330] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.008s)
[246.327567] [042/133] (773s left) gem_lmem_swapping (verify-ccs)
[246.369579] Subtest verify-ccs: SKIP (0.000s)
[246.420363] [043/133] (773s left) sw_sync (timeline_closed_signaled)
[246.456559] Starting subtest: timeline_closed_signaled
[246.458728] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[246.504717] [044/133] (773s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[246.599524] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[246.603720] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[246.713480] [045/133] (773s left) kms_prop_blob (invalid-set-prop-any)
[246.761885] Starting subtest: invalid-set-prop-any
[246.764475] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[246.904864] [046/133] (773s left) kms_flip (2x-flip-vs-expired-vblank)
[247.007266] Starting subtest: 2x-flip-vs-expired-vblank
[247.015495] Subtest 2x-flip-vs-expired-vblank: SKIP (0.010s)
[247.097452] [047/133] (773s left) gem_lmem_swapping (parallel-random-engines)
[247.139347] Subtest parallel-random-engines: SKIP (0.000s)
[247.181462] [048/133] (773s left) kms_flip (plain-flip-fb-recreate-interruptible)
[247.271589] Starting subtest: plain-flip-fb-recreate-interruptible
[247.273691] Starting dynamic subtest: A-eDP1
[256.118226] Dynamic subtest A-eDP1: SUCCESS (8.845s)
[256.131322] Starting dynamic subtest: B-eDP1
[264.943485] Dynamic subtest B-eDP1: SUCCESS (8.823s)
[264.956287] Starting dynamic subtest: C-eDP1
[273.765166] Dynamic subtest C-eDP1: SUCCESS (8.819s)
[273.775673] Starting dynamic subtest: D-eDP1
[282.586693] Dynamic subtest D-eDP1: SUCCESS (8.818s)
[282.591550] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.320s)
[283.772383] [049/133] (736s left) api_intel_bb (object-reloc-keep-cache)
[283.826092] Starting subtest: object-reloc-keep-cache
[283.830536] Subtest object-reloc-keep-cache: SKIP (0.002s)
[283.938424] [050/133] (736s left) kms_pm_dc (dc5-dpms)
[285.049937] Starting subtest: dc5-dpms
[287.157592] Subtest dc5-dpms: SUCCESS (2.108s)
[287.235856] [051/133] (733s left) kms_plane_cursor (overlay)
[287.325264] Starting subtest: overlay
[287.329721] Starting dynamic subtest: pipe-A-eDP-1-size-64
[289.785726] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.461s)
[289.845453] Starting dynamic subtest: pipe-A-eDP-1-size-128
[292.308513] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.471s)
[292.373478] Starting dynamic subtest: pipe-A-eDP-1-size-256
[294.866856] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.504s)
[295.217903] Starting dynamic subtest: pipe-B-eDP-1-size-64
[298.364754] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.157s)
[298.424897] Starting dynamic subtest: pipe-B-eDP-1-size-128
[300.899138] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.482s)
[300.959166] Starting dynamic subtest: pipe-B-eDP-1-size-256
[303.366647] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.415s)
[303.732787] Starting dynamic subtest: pipe-C-eDP-1-size-64
[306.572033] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.851s)
[306.610999] Starting dynamic subtest: pipe-C-eDP-1-size-128
[308.683677] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.080s)
[308.726300] Starting dynamic subtest: pipe-C-eDP-1-size-256
[310.850271] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.136s)
[311.181235] Starting dynamic subtest: pipe-D-eDP-1-size-64
[313.955246] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.785s)
[313.993238] Starting dynamic subtest: pipe-D-eDP-1-size-128
[316.111460] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.125s)
[316.150774] Starting dynamic subtest: pipe-D-eDP-1-size-256
[318.200327] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.058s)
[318.523065] Subtest overlay: SUCCESS (31.195s)
[319.321765] [052/133] (701s left) gem_exec_reloc (basic-wc-active)
[319.390477] Subtest basic-wc-active: SKIP (0.000s)
[319.465514] [053/133] (701s left) kms_psr (pr-primary-mmap-gtt)
[319.555304] Starting subtest: pr-primary-mmap-gtt
[319.559305] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[319.630835] [054/133] (700s left) gem_exec_schedule (lateslice)
[319.713181] Starting subtest: lateslice
[319.715092] Starting dynamic subtest: rcs0
[319.723047] Dynamic subtest rcs0: SUCCESS (0.019s)
[319.733312] Starting dynamic subtest: bcs0
[319.740339] Dynamic subtest bcs0: SUCCESS (0.017s)
[319.749119] Starting dynamic subtest: vcs0
[319.757784] Dynamic subtest vcs0: SUCCESS (0.017s)
[319.766513] Starting dynamic subtest: vcs1
[319.775682] Dynamic subtest vcs1: SUCCESS (0.017s)
[319.784286] Starting dynamic subtest: vecs0
[319.794602] Dynamic subtest vecs0: SUCCESS (0.018s)
[319.803235] Starting dynamic subtest: ccs0
[319.813909] Dynamic subtest ccs0: SUCCESS (0.018s)
[319.816068] Subtest lateslice: SUCCESS (0.111s)
[320.987936] [055/133] (699s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[321.085762] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[328.488108] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (7.405s)
[328.626997] [056/133] (691s left) kms_color (ctm-max)
[328.714207] Starting subtest: ctm-max
[328.716377] Starting dynamic subtest: pipe-A-eDP-1
[329.414487] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.699s)
[329.423875] Starting dynamic subtest: pipe-B-eDP-1
[330.849934] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.436s)
[330.860960] Starting dynamic subtest: pipe-C-eDP-1
[332.222305] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.372s)
[332.233671] Starting dynamic subtest: pipe-D-eDP-1
[333.558073] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.334s)
[333.560323] Subtest ctm-max: SUCCESS (4.845s)
[334.352128] [057/133] (686s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[334.401797] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[334.404086] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[334.494590] [058/133] (686s left) gem_eio (reset-stress)
[334.725593] Starting subtest: reset-stress
[334.727757] Starting dynamic subtest: render
[339.625815] Dynamic subtest render: SUCCESS (4.898s)
[339.640584] Starting dynamic subtest: bsd1
[357.522258] Dynamic subtest bsd1: SUCCESS (17.895s)
[357.538286] Starting dynamic subtest: bsd2
[375.493920] Dynamic subtest bsd2: SUCCESS (17.970s)
[375.509884] Starting dynamic subtest: blt
[375.513959] Dynamic subtest blt: SKIP (0.000s)
[375.523095] Starting dynamic subtest: vebox
[393.464683] Dynamic subtest vebox: SUCCESS (17.968s)
[393.466794] Subtest reset-stress: SUCCESS (58.736s)
[394.954215] [059/133] (625s left) kms_addfb_basic (bad-pitch-256)
[395.020808] Starting subtest: bad-pitch-256
[395.023611] Subtest bad-pitch-256: SUCCESS (0.000s)
[395.164751] [060/133] (625s left) kms_addfb_basic (bo-too-small)
[395.260300] Starting subtest: bo-too-small
[395.262146] Subtest bo-too-small: SUCCESS (0.000s)
[395.359233] [061/133] (625s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[395.454608] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[395.459085] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[395.556893] [062/133] (625s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[395.644476] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[395.648951] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[395.745954] [063/133] (625s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[395.841505] Starting subtest: disable-crc-after-crtc
[395.843843] Starting dynamic subtest: pipe-A-eDP-1
[397.499980] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.659s)
[397.509849] Starting dynamic subtest: pipe-B-eDP-1
[399.757790] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.256s)
[399.767688] Starting dynamic subtest: pipe-C-eDP-1
[401.986299] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.227s)
[401.996837] Starting dynamic subtest: pipe-D-eDP-1
[404.256535] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.269s)
[404.258733] Subtest disable-crc-after-crtc: SUCCESS (8.418s)
[405.095595] [064/133] (615s left) kms_chamelium_frames (hdmi-crc-multiple)
[405.483388] Subtest hdmi-crc-multiple: SKIP (0.000s)
[406.296917] [065/133] (614s left) perf (oa-formats)
[406.404853] Starting subtest: oa-formats
[406.406790] Starting dynamic subtest: 0-rcs0
[406.420647] Dynamic subtest 0-rcs0: SUCCESS (0.017s)
[406.430316] Starting dynamic subtest: 1-vecs0
[406.442654] Dynamic subtest 1-vecs0: SUCCESS (0.021s)
[406.445046] Subtest oa-formats: SUCCESS (0.040s)
[406.501129] [066/133] (614s left) kms_dsc (dsc-fractional-bpp-with-bpc)
[406.605078] Starting subtest: dsc-fractional-bpp-with-bpc
[406.635837] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.001s)
[406.696734] [067/133] (614s left) syncobj_eventfd (timeline-wait)
[406.759257] Starting subtest: timeline-wait
[406.767988] Subtest timeline-wait: SUCCESS (0.010s)
[406.902895] [068/133] (614s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[407.002323] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[407.004198] Starting dynamic subtest: pipe-A-eDP-1
[423.711016] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.295s)
[423.721393] Starting dynamic subtest: pipe-B-eDP-1
[440.718493] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.474s)
[440.728731] Starting dynamic subtest: pipe-C-eDP-1
[457.690988] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.453s)
[457.700864] Starting dynamic subtest: pipe-D-eDP-1
[474.666306] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.329s)
[474.668792] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (9.555s)
[475.814367] [069/133] (545s left) gem_mmap_offset (isolation)
[475.878405] Starting subtest: isolation
[475.899228] Subtest isolation: SUCCESS (0.006s)
[475.986410] [070/133] (545s left) kms_chamelium_color (ctm-negative)
[476.082180] Subtest ctm-negative: SKIP (0.000s)
[476.131435] [071/133] (545s left) kms_hdmi_inject (inject-audio)
[476.481942] Starting subtest: inject-audio
[476.755147] Subtest inject-audio: SUCCESS (0.277s)
[477.348680] [072/133] (543s left) i915_drm_fdinfo (virtual-idle)
[477.395240] Starting subtest: virtual-idle
[480.426559] Subtest virtual-idle: SUCCESS (3.058s)
[480.506519] [073/133] (540s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[480.612020] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[480.617029] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[480.709328] [074/133] (540s left) gem_set_tiling_vs_gtt
[480.828475] [075/133] (540s left) api_intel_allocator (reopen-fork)
[480.887935] Starting subtest: reopen-fork
[484.294572] Subtest reopen-fork: SUCCESS (3.425s)
[484.376511] [076/133] (537s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[484.481013] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[484.483718] Starting dynamic subtest: pipe-A-default-mode
[487.153062] Dynamic subtest pipe-A-default-mode: SUCCESS (2.679s)
[487.155392] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.681s)
[487.954076] [077/133] (533s left) gem_eio (wait-1us)
[488.183171] Starting subtest: wait-1us
[488.528246] Subtest wait-1us: SUCCESS (0.346s)
[488.677543] [078/133] (532s left) gem_exec_create (forked)
[488.741962] Starting subtest: forked
[488.744817] Starting dynamic subtest: smem
[510.119313] Dynamic subtest smem: SUCCESS (21.397s)
[510.122248] Subtest forked: SUCCESS (21.399s)
[510.314807] [079/133] (511s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[510.369187] Starting subtest: etime-single-wait-all-for-submit-submitted
[510.475892] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.105s)
[510.556379] [080/133] (511s left) gem_exec_params (rel-constants-invalid-ring)
[510.615166] Starting subtest: rel-constants-invalid-ring
[510.618083] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[510.717224] [081/133] (510s left) kms_flip (plain-flip-interruptible)
[510.813272] Starting subtest: plain-flip-interruptible
[510.815966] Starting dynamic subtest: A-eDP1
[512.493775] Dynamic subtest A-eDP1: SUCCESS (1.680s)
[512.505401] Starting dynamic subtest: B-eDP1
[514.191858] Dynamic subtest B-eDP1: SUCCESS (1.697s)
[514.205981] Starting dynamic subtest: C-eDP1
[515.786702] Dynamic subtest C-eDP1: SUCCESS (1.593s)
[515.800235] Starting dynamic subtest: D-eDP1
[517.486651] Dynamic subtest D-eDP1: SUCCESS (1.698s)
[517.492500] Subtest plain-flip-interruptible: SUCCESS (6.678s)
[518.625605] [082/133] (503s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[518.759287] Starting subtest: short-flip-before-cursor-atomic-transitions
[519.717837] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.956s)
[520.526666] [083/133] (501s left) gem_userptr_blits (forbidden-operations)
[520.595389] Starting subtest: forbidden-operations
[520.601042] Subtest forbidden-operations: SKIP (0.000s)
[520.726738] [084/133] (501s left) gem_ctx_engines (invalid-engines)
[520.777868] Starting subtest: invalid-engines
[520.784248] Subtest invalid-engines: SUCCESS (0.008s)
[521.003741] [085/133] (500s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[521.102153] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[521.107389] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[521.216658] [086/133] (500s left) kms_pm_rpm (i2c)
[523.241723] Starting subtest: i2c
[528.563995] Subtest i2c: SUCCESS (5.322s)
[528.665635] [087/133] (493s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[528.769182] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[535.567068] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.805s)
[535.680924] [088/133] (486s left) kms_atomic (plane-overlay-legacy)
[535.769907] Starting subtest: plane-overlay-legacy
[535.772498] Starting dynamic subtest: pipe-A-eDP-1
[536.189198] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.420s)
[536.192099] Subtest plane-overlay-legacy: SUCCESS (0.422s)
[536.998494] [089/133] (485s left) syncobj_timeline (wait-all-for-submit-complex)
[537.046441] Starting subtest: wait-all-for-submit-complex
[537.263981] Subtest wait-all-for-submit-complex: SUCCESS (0.217s)
[537.340394] [090/133] (484s left) gem_request_retire (retire-vma-not-inactive)
[537.393806] Starting subtest: retire-vma-not-inactive
[537.456311] Subtest retire-vma-not-inactive: SUCCESS (0.058s)
[537.591124] [091/133] (484s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[537.652193] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[537.657758] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[537.852030] [092/133] (484s left) gem_pxp (reject-modify-context-protection-on)
[537.978833] Starting subtest: reject-modify-context-protection-on
[537.981897] Subtest reject-modify-context-protection-on: SUCCESS (0.002s)
[538.091304] [093/133] (484s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[538.194069] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[538.196751] Starting dynamic subtest: pipe-A-eDP-1
[538.222784] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[538.234270] Starting dynamic subtest: pipe-B-eDP-1
[538.259837] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[538.270992] Starting dynamic subtest: pipe-C-eDP-1
[538.296914] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[538.306795] Starting dynamic subtest: pipe-D-eDP-1
[538.331532] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[538.335541] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[540.388316] [094/133] (481s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[540.477090] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[540.482049] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[540.553423] [095/133] (481s left) gem_exec_fence (syncobj-export)
[541.028851] Starting subtest: syncobj-export
[541.035761] Subtest syncobj-export: SUCCESS (0.007s)
[542.189364] [096/133] (480s left) dumb_buffer (map-invalid-size)
[542.240063] Starting subtest: map-invalid-size
[542.242836] Subtest map-invalid-size: SUCCESS (0.000s)
[542.342670] [097/133] (480s left) kms_psr (fbc-psr-primary-render)
[542.437170] Starting subtest: fbc-psr-primary-render
[542.439933] Starting dynamic subtest: eDP-1
[542.444953] Dynamic subtest eDP-1: SKIP (0.000s)
[542.450056] Subtest fbc-psr-primary-render: SKIP (0.001s)
[542.524607] [098/133] (479s left) fbdev (eof)
[542.573033] Starting subtest: eof
[542.576109] Subtest eof: SUCCESS (0.000s)
[542.643617] [099/133] (479s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[542.752031] Starting subtest: fbc-rgb101010-draw-pwrite
[548.104502] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.358s)
[549.291331] [100/133] (473s left) kms_vrr (negative-basic)
[549.388134] Starting subtest: negative-basic
[549.396258] Starting dynamic subtest: pipe-A-eDP-1
[554.814864] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.420s)
[555.105800] Subtest negative-basic: SUCCESS (5.720s)
[555.903502] [101/133] (466s left) gem_exec_schedule (smoketest-all)
[555.964311] Starting subtest: smoketest-all
[588.373067] Subtest smoketest-all: SUCCESS (32.353s)
[589.090584] [102/133] (433s left) kms_big_fb (y-tiled-addfb-size-overflow)
[589.199088] Starting subtest: y-tiled-addfb-size-overflow
[589.204012] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[589.306346] [103/133] (433s left) vgem_basic (bad-fence)
[589.353077] Starting subtest: bad-fence
[589.356050] Subtest bad-fence: SUCCESS (0.000s)
[589.410506] [104/133] (433s left) gem_ctx_persistence (engines-hostile)
[589.478915] Starting subtest: engines-hostile
[589.481285] Starting dynamic subtest: rcs0
[589.593156] Dynamic subtest rcs0: SUCCESS (0.114s)
[589.606225] Starting dynamic subtest: bcs0
[589.686446] Dynamic subtest bcs0: SUCCESS (0.091s)
[589.700036] Starting dynamic subtest: vcs0
[589.762254] Dynamic subtest vcs0: SUCCESS (0.074s)
[589.774843] Starting dynamic subtest: vcs1
[589.863332] Dynamic subtest vcs1: SUCCESS (0.099s)
[589.877035] Starting dynamic subtest: vecs0
[589.955686] Dynamic subtest vecs0: SUCCESS (0.090s)
[589.968866] Starting dynamic subtest: ccs0
[590.048241] Dynamic subtest ccs0: SUCCESS (0.091s)
[590.050856] Subtest engines-hostile: SUCCESS (0.571s)
[590.133758] [105/133] (432s left) prime_mmap (test_forked)
[590.186132] Starting subtest: test_forked
[590.188252] Starting dynamic subtest: test_forked-smem
[590.227495] Dynamic subtest test_forked-smem: SUCCESS (0.043s)
[590.230070] Subtest test_forked: SUCCESS (0.044s)
[590.335111] [106/133] (432s left) gem_spin_batch (resubmit-all)
[590.405906] Starting subtest: resubmit-all
[590.407637] Starting dynamic subtest: rcs0
[590.417540] Dynamic subtest rcs0: SUCCESS (0.014s)
[590.429883] Starting dynamic subtest: bcs0
[590.432029] Dynamic subtest bcs0: SUCCESS (0.002s)
[590.441666] Starting dynamic subtest: vcs0
[590.443823] Dynamic subtest vcs0: SUCCESS (0.002s)
[590.453126] Starting dynamic subtest: vcs1
[590.455271] Dynamic subtest vcs1: SUCCESS (0.002s)
[590.465152] Starting dynamic subtest: vecs0
[590.467171] Dynamic subtest vecs0: SUCCESS (0.002s)
[590.477027] Starting dynamic subtest: ccs0
[590.479154] Dynamic subtest ccs0: SUCCESS (0.002s)
[590.481244] Subtest resubmit-all: SUCCESS (0.027s)
[592.159431] [107/133] (430s left) i915_drm_fdinfo (busy-idle)
[592.210257] Starting subtest: busy-idle
[592.213099] Starting dynamic subtest: rcs0
[592.228111] Dynamic subtest rcs0: SKIP (0.015s)
[592.240050] Starting dynamic subtest: bcs0
[592.248892] Dynamic subtest bcs0: SKIP (0.020s)
[592.260183] Starting dynamic subtest: vcs0
[592.265794] Dynamic subtest vcs0: SKIP (0.000s)
[592.275425] Starting dynamic subtest: vcs1
[592.280911] Dynamic subtest vcs1: SKIP (0.000s)
[592.291051] Starting dynamic subtest: vecs0
[592.296006] Dynamic subtest vecs0: SKIP (0.000s)
[592.306005] Starting dynamic subtest: ccs0
[592.311077] Dynamic subtest ccs0: SKIP (0.000s)
[592.316269] Subtest busy-idle: SKIP (0.040s)
[592.356375] [108/133] (430s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[592.463223] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[593.376390] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.915s)
[593.534451] [109/133] (429s left) perf (non-sampling-read-error)
[593.638821] Starting subtest: non-sampling-read-error
[593.648512] Subtest non-sampling-read-error: SUCCESS (0.010s)
[593.699602] [110/133] (429s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[593.793096] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[602.344407] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.554s)
[602.446862] [111/133] (420s left) kms_force_connector_basic (force-load-detect)
[602.528266] Starting subtest: force-load-detect
[602.532971] Subtest force-load-detect: SKIP (0.000s)
[602.643424] [112/133] (420s left) kms_content_protection (lic-type-0-hdcp14)
[602.791716] Starting subtest: lic-type-0-hdcp14
[602.796490] Subtest lic-type-0-hdcp14: SKIP (0.000s)
[602.913259] [113/133] (420s left) gem_ctx_shared (q-in-order)
[602.984088] Starting subtest: Q-in-order
[602.986599] Starting dynamic subtest: rcs0
[603.101019] Dynamic subtest rcs0: SUCCESS (0.115s)
[603.117384] Starting dynamic subtest: vcs0
[603.185807] Dynamic subtest vcs0: SUCCESS (0.085s)
[603.207045] Starting dynamic subtest: vcs1
[603.267722] Dynamic subtest vcs1: SUCCESS (0.081s)
[603.285659] Starting dynamic subtest: vecs0
[603.349503] Dynamic subtest vecs0: SUCCESS (0.080s)
[603.368304] Starting dynamic subtest: ccs0
[603.446014] Dynamic subtest ccs0: SUCCESS (0.096s)
[603.448681] Subtest Q-in-order: SUCCESS (0.462s)
[605.172816] [114/133] (417s left) i915_suspend (basic-s3-without-i915)
[605.207505] Starting subtest: basic-s3-without-i915
[608.410939] Subtest basic-s3-without-i915: SKIP (3.198s)
[610.834326] [115/133] (412s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[610.944024] Starting subtest: yf-tiled-32bpp-rotate-270
[610.949051] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[611.030685] [116/133] (412s left) gem_ctx_persistence (legacy-engines-persistence)
[611.092789] Starting subtest: legacy-engines-persistence
[611.095414] Starting dynamic subtest: render
[611.863563] Dynamic subtest render: SUCCESS (0.769s)
[611.874905] Starting dynamic subtest: bsd1
[612.648555] Dynamic subtest bsd1: SUCCESS (0.782s)
[612.660842] Starting dynamic subtest: bsd2
[613.409541] Dynamic subtest bsd2: SUCCESS (0.758s)
[613.422094] Starting dynamic subtest: blt
[614.191529] Dynamic subtest blt: SUCCESS (0.779s)
[614.206802] Starting dynamic subtest: vebox
[614.947562] Dynamic subtest vebox: SUCCESS (0.753s)
[614.950560] Subtest legacy-engines-persistence: SUCCESS (3.857s)
[615.038172] [117/133] (408s left) kms_rotation_crc (primary-rotation-90)
[615.128414] Starting subtest: primary-rotation-90
[615.133085] Subtest primary-rotation-90: SKIP (0.001s)
[615.213649] [118/133] (408s left) syncobj_wait (multi-wait-all-signaled)
[615.265098] Starting subtest: multi-wait-all-signaled
[615.267857] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[615.362897] [119/133] (408s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[615.466025] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[615.471029] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[615.547442] [120/133] (407s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[615.639668] Starting subtest: fbc-pr-sprite-mmap-gtt
[615.644201] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[615.724567] [121/133] (407s left) kms_force_connector_basic (prune-stale-modes)
[615.794242] Starting subtest: prune-stale-modes
[616.236063] Subtest prune-stale-modes: SUCCESS (0.444s)
[616.370752] [122/133] (407s left) perf (stress-open-close)
[616.514572] Starting subtest: stress-open-close
[616.516587] Starting dynamic subtest: 0-rcs0
[618.681613] Dynamic subtest 0-rcs0: SUCCESS (2.167s)
[618.691929] Starting dynamic subtest: 1-vcs1
[620.844293] Dynamic subtest 1-vcs1: SUCCESS (2.162s)
[620.847102] Subtest stress-open-close: SUCCESS (4.331s)
[620.895505] [123/133] (402s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[620.945836] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[620.947956] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[621.043712] [124/133] (402s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[621.147925] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[621.152075] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[621.246238] [125/133] (402s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[621.342893] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[621.344893] Starting dynamic subtest: pipe-A-eDP-1
[621.487880] Dynamic subtest pipe-A-eDP-1: SKIP (0.148s)
[621.497549] Starting dynamic subtest: pipe-B-eDP-1
[622.686724] Dynamic subtest pipe-B-eDP-1: SKIP (1.193s)
[622.692070] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.345s)
[623.929152] [126/133] (399s left) sw_sync (sync_merge_same)
[623.966567] Starting subtest: sync_merge_same
[623.969168] Subtest sync_merge_same: SUCCESS (0.000s)
[624.015101] [127/133] (399s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[624.114826] Starting subtest: 4-tiled-32bpp-rotate-0
[625.460013] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.345s)
[625.604159] [128/133] (398s left) i915_pm_rc6_residency (media-rc6-accuracy)
[625.666575] Starting subtest: media-rc6-accuracy
[625.670074] Subtest media-rc6-accuracy: SKIP (0.000s)
[625.769366] [129/133] (398s left) kms_psr (psr-primary-render)
[625.850562] Starting subtest: psr-primary-render
[625.852727] Starting dynamic subtest: eDP-1
[627.608422] Dynamic subtest eDP-1: SUCCESS (1.759s)
[627.611103] Subtest psr-primary-render: SUCCESS (1.760s)
[628.432192] [130/133] (395s left) kms_getfb (getfb2-handle-closed)
[628.533794] Starting subtest: getfb2-handle-closed
[628.536255] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[628.633588] [131/133] (395s left) gem_wait (write-busy)
[628.689074] Starting subtest: write-busy
[628.691878] Starting dynamic subtest: all-engines
[629.300560] Dynamic subtest all-engines: SUCCESS (0.611s)
[629.318242] Starting dynamic subtest: rcs0
[629.851858] Dynamic subtest rcs0: SUCCESS (0.549s)
[629.869414] Starting dynamic subtest: bcs0
[630.402858] Dynamic subtest bcs0: SUCCESS (0.550s)
[630.419791] Starting dynamic subtest: vcs0
[632.104287] Dynamic subtest vcs0: SUCCESS (1.700s)
[632.120825] Starting dynamic subtest: vcs1
[634.087048] Dynamic subtest vcs1: SUCCESS (1.980s)
[634.104105] Starting dynamic subtest: vecs0
[636.070597] Dynamic subtest vecs0: SUCCESS (1.980s)
[636.087094] Starting dynamic subtest: ccs0
[636.621995] Dynamic subtest ccs0: SUCCESS (0.550s)
[636.624784] Subtest write-busy: SUCCESS (7.935s)
[636.817068] [132/133] (387s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[636.935721] Starting subtest: cursorB-vs-flipB-legacy
[636.940191] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[637.080624] [133/133] (386s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[637.164182] Starting subtest: primary-x-tiled-reflect-x-0
[644.195762] Subtest primary-x-tiled-reflect-x-0: SUCCESS (7.034s)
[645.343504] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: gem_exec_balancer
results: parsing output: 5/ for test: syncobj_wait
results: parsing output: 6/ for test: gen7_exec_parse
results: parsing output: 7/ for test: gem_pread
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_cursor_crc
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_psr2_sf
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_plane_scaling
results: parsing output: 14/ for test: gem_exec_flush
results: parsing output: 15/ for test: gem_eio
results: parsing output: 16/ for test: kms_plane
results: parsing output: 17/ for test: kms_cursor_crc
results: parsing output: 18/ for test: kms_psr
results: parsing output: 19/ for test: kms_invalid_mode
results: parsing output: 20/ for test: kms_cursor_crc
results: parsing output: 21/ for test: kms_addfb_basic
results: parsing output: 22/ for test: gem_exec_schedule
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: kms_chamelium_hpd
results: parsing output: 25/ for test: gem_exec_schedule
results: parsing output: 26/ for test: kms_lease
results: parsing output: 27/ for test: kms_cursor_crc
results: parsing output: 28/ for test: kms_ccs
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: gem_exec_reloc
results: parsing output: 31/ for test: gem_exec_parallel
results: parsing output: 32/ for test: kms_vblank
results: parsing output: 33/ for test: kms_flip_scaled_crc
results: parsing output: 34/ for test: kms_sequence
results: parsing output: 35/ for test: gem_exec_whisper
results: parsing output: 36/ for test: kms_cursor_legacy
results: parsing output: 37/ for test: perf_pmu
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_exec_fence
results: parsing output: 40/ for test: kms_ccs
results: parsing output: 41/ for test: gem_lmem_swapping
results: parsing output: 42/ for test: sw_sync
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_prop_blob
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: gem_lmem_swapping
results: parsing output: 47/ for test: kms_flip
results: parsing output: 48/ for test: api_intel_bb
results: parsing output: 49/ for test: kms_pm_dc
results: parsing output: 50/ for test: kms_plane_cursor
results: parsing output: 51/ for test: gem_exec_reloc
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: gem_exec_schedule
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_color
results: parsing output: 56/ for test: syncobj_timeline
results: parsing output: 57/ for test: gem_eio
results: parsing output: 58/ for test: kms_addfb_basic
results: parsing output: 59/ for test: kms_addfb_basic
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_plane
results: parsing output: 62/ for test: kms_pipe_crc_basic
results: parsing output: 63/ for test: kms_chamelium_frames
results: parsing output: 64/ for test: perf
results: parsing output: 65/ for test: kms_dsc
results: parsing output: 66/ for test: syncobj_eventfd
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: gem_mmap_offset
results: parsing output: 69/ for test: kms_chamelium_color
results: parsing output: 70/ for test: kms_hdmi_inject
results: parsing output: 71/ for test: i915_drm_fdinfo
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: gem_set_tiling_vs_gtt
results: parsing output: 74/ for test: api_intel_allocator
results: parsing output: 75/ for test: kms_flip_scaled_crc
results: parsing output: 76/ for test: gem_eio
results: parsing output: 77/ for test: gem_exec_create
results: parsing output: 78/ for test: syncobj_timeline
results: parsing output: 79/ for test: gem_exec_params
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: kms_cursor_legacy
results: parsing output: 82/ for test: gem_userptr_blits
results: parsing output: 83/ for test: gem_ctx_engines
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_pm_rpm
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_atomic
results: parsing output: 88/ for test: syncobj_timeline
results: parsing output: 89/ for test: gem_request_retire
results: parsing output: 90/ for test: gem_render_copy
results: parsing output: 91/ for test: gem_pxp
results: parsing output: 92/ for test: kms_ccs
results: parsing output: 93/ for test: kms_flip_scaled_crc
results: parsing output: 94/ for test: gem_exec_fence
results: parsing output: 95/ for test: dumb_buffer
results: parsing output: 96/ for test: kms_psr
results: parsing output: 97/ for test: fbdev
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_vrr
results: parsing output: 100/ for test: gem_exec_schedule
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: vgem_basic
results: parsing output: 103/ for test: gem_ctx_persistence
results: parsing output: 104/ for test: prime_mmap
results: parsing output: 105/ for test: gem_spin_batch
results: parsing output: 106/ for test: i915_drm_fdinfo
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: perf
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_force_connector_basic
results: parsing output: 111/ for test: kms_content_protection
results: parsing output: 112/ for test: gem_ctx_shared
results: parsing output: 113/ for test: i915_suspend
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: gem_ctx_persistence
results: parsing output: 116/ for test: kms_rotation_crc
results: parsing output: 117/ for test: syncobj_wait
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: kms_force_connector_basic
results: parsing output: 121/ for test: perf
results: parsing output: 122/ for test: syncobj_wait
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_psr2_sf
results: parsing output: 125/ for test: sw_sync
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: i915_pm_rc6_residency
results: parsing output: 128/ for test: kms_psr
results: parsing output: 129/ for test: kms_getfb
results: parsing output: 130/ for test: gem_wait
results: parsing output: 131/ for test: kms_cursor_legacy
results: parsing output: 132/ for test: kms_rotation_crc
Done.