[58.361962] Initializing watchdogs
[58.362167]   /dev/watchdog0
[58.376606] [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]
[58.380623] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.382928] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.386226] [001/131] (960s left) api_intel_allocator (fork-simple-stress-signal)
[58.508145] Starting subtest: fork-simple-stress-signal
[63.928568] Subtest fork-simple-stress-signal: SUCCESS (5.412s)
[64.040394] [002/131] (954s left) kms_psr (psr2-primary-blt)
[64.146419] Starting subtest: psr2-primary-blt
[64.148799] Starting dynamic subtest: eDP-1
[65.865470] Dynamic subtest eDP-1: SUCCESS (1.715s)
[65.867709] Subtest psr2-primary-blt: SUCCESS (1.716s)
[66.726561] [003/131] (952s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[66.832159] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[66.836275] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[66.951134] [004/131] (952s left) gem_exec_params (invalid-bsd-ring)
[67.015074] Starting subtest: invalid-bsd-ring
[67.017535] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[67.127106] [005/131] (951s left) kms_chamelium_hpd (dp-hpd-storm)
[67.516993] Subtest dp-hpd-storm: SKIP (0.000s)
[68.333130] [006/131] (950s left) gem_exec_balancer (parallel-keep-in-fence)
[68.570453] Starting subtest: parallel-keep-in-fence
[69.574081] Subtest parallel-keep-in-fence: SUCCESS (1.003s)
[69.674199] [007/131] (949s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[69.741753] Starting subtest: multi-wait-available-submitted-signaled
[69.744092] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s)
[69.824777] [008/131] (949s left) i915_hangman (error-state-basic)
[69.882119] Starting subtest: error-state-basic
[70.000899] Subtest error-state-basic: SUCCESS (0.118s)
[70.063454] [009/131] (949s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[70.169046] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[70.173216] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[70.277361] [010/131] (948s left) kms_plane_multiple (tiling-4)
[70.365865] Starting subtest: tiling-4
[70.368280] Starting dynamic subtest: pipe-A-eDP-1
[74.054446] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.685s)
[74.062807] Starting dynamic subtest: pipe-B-eDP-1
[78.463915] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.405s)
[78.472639] Starting dynamic subtest: pipe-C-eDP-1
[82.734498] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.271s)
[82.742906] Starting dynamic subtest: pipe-D-eDP-1
[87.052950] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.316s)
[87.055431] Subtest tiling-4: SUCCESS (16.680s)
[87.863916] [011/131] (931s left) gem_exec_reloc (basic-write-cpu-active)
[87.931141] Subtest basic-write-cpu-active: SKIP (0.000s)
[87.986683] [012/131] (931s left) syncobj_wait (invalid-signal-bad-pad)
[88.042043] Starting subtest: invalid-signal-bad-pad
[88.044185] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[88.124665] [013/131] (931s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[88.190994] Starting subtest: mixed-tiled-to-y-tiled-ccs
[88.195443] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[88.364195] [014/131] (930s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[88.469622] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[88.474141] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[88.578192] [015/131] (930s left) kms_universal_plane (disable-primary-vs-flip)
[88.668055] Starting subtest: disable-primary-vs-flip
[88.670292] Starting dynamic subtest: pipe-A-eDP-1
[90.233346] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.563s)
[90.240623] Starting dynamic subtest: pipe-B-eDP-1
[92.391658] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.155s)
[92.399709] Starting dynamic subtest: pipe-C-eDP-1
[94.531356] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.139s)
[94.539668] Starting dynamic subtest: pipe-D-eDP-1
[96.670388] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.137s)
[96.672843] Subtest disable-primary-vs-flip: SUCCESS (7.998s)
[97.456103] [016/131] (921s left) gem_exec_balancer (bonded-sync)
[97.520201] Starting subtest: bonded-sync
[97.524960] Subtest bonded-sync: SKIP (0.000s)
[97.794251] [017/131] (921s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[97.903055] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[97.907107] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[98.007299] [018/131] (921s left) kms_pm_backlight (fade-with-dpms)
[98.111182] Starting subtest: fade-with-dpms
[100.376409] Starting dynamic subtest: eDP-1
[103.043679] Dynamic subtest eDP-1: SUCCESS (2.668s)
[103.046173] Subtest fade-with-dpms: SUCCESS (4.931s)
[103.848878] [019/131] (915s left) gem_busy (semaphore)
[104.044951] Subtest semaphore: SKIP (0.000s)
[104.273555] [020/131] (915s left) sysfs_heartbeat_interval (precise)
[104.324860] Starting subtest: precise
[104.327198] Starting dynamic subtest: vecs0
[111.943740] Dynamic subtest vecs0: SUCCESS (7.615s)
[111.957682] Starting dynamic subtest: ccs0
[113.101455] Dynamic subtest ccs0: SUCCESS (1.159s)
[113.108610] Starting dynamic subtest: vcs0
[120.939096] Dynamic subtest vcs0: SUCCESS (7.836s)
[120.947900] Starting dynamic subtest: bcs0
[123.901877] Dynamic subtest bcs0: SUCCESS (2.961s)
[123.909727] Starting dynamic subtest: rcs0
[125.098251] Dynamic subtest rcs0: SUCCESS (1.195s)
[125.108714] Starting dynamic subtest: vcs1
[132.921341] Dynamic subtest vcs1: SUCCESS (7.821s)
[132.923832] Subtest precise: SUCCESS (28.592s)
[132.990832] [021/131] (886s left) gem_exec_fence (syncobj-timeline-repeat)
[133.560114] Starting subtest: syncobj-timeline-repeat
[133.810116] Subtest syncobj-timeline-repeat: SUCCESS (0.219s)
[135.051079] [FACT gem_exec_fence (syncobj-timeline-repeat)] new: kernel.kmod_is_loaded.vgem: true
[135.054069] [022/131] (884s left) kms_psr (psr2-primary-render)
[135.162068] Starting subtest: psr2-primary-render
[135.164268] Starting dynamic subtest: eDP-1
[136.868651] Dynamic subtest eDP-1: SUCCESS (1.704s)
[136.870882] Subtest psr2-primary-render: SUCCESS (1.705s)
[137.712638] [023/131] (881s left) kms_rmfb (rmfb-ioctl)
[137.800897] Starting subtest: rmfb-ioctl
[137.803159] Starting dynamic subtest: pipe-A-eDP-1
[137.914688] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.113s)
[137.924687] Starting dynamic subtest: pipe-B-eDP-1
[139.070753] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.155s)
[139.080633] Starting dynamic subtest: pipe-C-eDP-1
[140.183390] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.112s)
[140.192279] Starting dynamic subtest: pipe-D-eDP-1
[141.310364] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.126s)
[141.312747] Subtest rmfb-ioctl: SUCCESS (3.509s)
[142.423909] [024/131] (877s left) kms_properties (plane-properties-legacy)
[142.515976] Starting subtest: plane-properties-legacy
[142.518300] Starting dynamic subtest: pipe-A-eDP-1
[143.074675] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.556s)
[143.084127] Starting dynamic subtest: pipe-B-eDP-1
[144.297653] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.221s)
[144.305709] Starting dynamic subtest: pipe-C-eDP-1
[145.514809] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.217s)
[145.527344] Starting dynamic subtest: pipe-D-eDP-1
[146.743448] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.228s)
[146.745781] Subtest plane-properties-legacy: SUCCESS (4.226s)
[147.534359] [025/131] (872s left) gem_exec_whisper (basic-queues)
[147.601520] Starting subtest: basic-queues
[153.206067] Subtest basic-queues: SUCCESS (5.604s)
[153.385083] [026/131] (866s left) gem_readwrite (new-obj)
[153.450462] Subtest new-obj: SKIP (0.000s)
[153.504756] [027/131] (866s left) gem_ctx_persistence (engines-hang)
[153.571812] Starting subtest: engines-hang
[153.574117] Starting dynamic subtest: rcs0
[153.683670] Dynamic subtest rcs0: SUCCESS (0.112s)
[153.694566] Starting dynamic subtest: bcs0
[153.764769] Dynamic subtest bcs0: SUCCESS (0.080s)
[153.773463] Starting dynamic subtest: vcs0
[153.931856] Dynamic subtest vcs0: SUCCESS (0.166s)
[153.942381] Starting dynamic subtest: vcs1
[154.054355] Dynamic subtest vcs1: SUCCESS (0.121s)
[154.064933] Starting dynamic subtest: vecs0
[154.180210] Dynamic subtest vecs0: SUCCESS (0.125s)
[154.190726] Starting dynamic subtest: ccs0
[154.298057] Dynamic subtest ccs0: SUCCESS (0.117s)
[154.300726] Subtest engines-hang: SUCCESS (0.726s)
[154.371915] [028/131] (865s left) gem_eio (banned)
[154.610528] Starting subtest: banned
[155.313044] Subtest banned: SUCCESS (0.705s)
[155.513173] [029/131] (864s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[155.608419] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[155.611872] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[155.720035] [030/131] (864s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[155.822071] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[155.825676] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[155.920555] [031/131] (863s left) kms_vrr (seamless-rr-switch-virtual)
[156.016644] Starting subtest: seamless-rr-switch-virtual
[156.022309] Subtest seamless-rr-switch-virtual: SKIP (0.000s)
[156.085864] [032/131] (863s left) kms_invalid_mode (bad-vsync-start)
[156.189335] Starting subtest: bad-vsync-start
[156.191232] Starting dynamic subtest: pipe-A-eDP-1
[156.468748] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.280s)
[156.478121] Starting dynamic subtest: pipe-B-eDP-1
[156.480245] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[156.487535] Starting dynamic subtest: pipe-C-eDP-1
[156.489632] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[156.497088] Starting dynamic subtest: pipe-D-eDP-1
[156.499322] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[156.501531] Subtest bad-vsync-start: SUCCESS (0.284s)
[157.256887] [033/131] (862s left) drm_fdinfo (idle)
[157.294127] Starting subtest: idle
[157.296415] Starting dynamic subtest: rcs0
[157.889900] Dynamic subtest rcs0: SUCCESS (0.596s)
[157.904393] Starting dynamic subtest: bcs0
[158.399945] Dynamic subtest bcs0: SUCCESS (0.503s)
[158.413610] Starting dynamic subtest: vcs0
[158.901392] Dynamic subtest vcs0: SUCCESS (0.503s)
[158.912512] Starting dynamic subtest: vcs1
[159.406083] Dynamic subtest vcs1: SUCCESS (0.503s)
[159.416084] Starting dynamic subtest: vecs0
[159.910756] Dynamic subtest vecs0: SUCCESS (0.503s)
[159.920360] Starting dynamic subtest: ccs0
[160.415935] Dynamic subtest ccs0: SUCCESS (0.503s)
[160.418726] Subtest idle: SUCCESS (3.121s)
[160.485298] [034/131] (859s left) syncobj_timeline (invalid-signal-zero-handles)
[160.541826] Starting subtest: invalid-signal-zero-handles
[160.544161] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[160.641160] [035/131] (859s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[160.737109] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[160.739433] Starting dynamic subtest: pipe-A-eDP-1
[160.762263] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[160.771308] Starting dynamic subtest: pipe-B-eDP-1
[160.793081] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[160.800373] Starting dynamic subtest: pipe-C-eDP-1
[160.821714] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[160.829261] Starting dynamic subtest: pipe-D-eDP-1
[160.851613] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[160.855810] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[162.913043] [036/131] (857s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[163.019510] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[163.023678] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[163.142863] [037/131] (856s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[163.247338] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[163.252092] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[164.336274] [038/131] (855s left) sw_sync (sync_multi_producer_single_consumer)
[164.375252] Starting subtest: sync_multi_producer_single_consumer
[165.448176] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s)
[165.502761] [039/131] (854s left) drm_fdinfo (most-busy-idle-check-all)
[165.542813] Starting subtest: most-busy-idle-check-all
[165.545120] Starting dynamic subtest: rcs0
[165.549622] Dynamic subtest rcs0: SKIP (0.006s)
[165.557198] Starting dynamic subtest: bcs0
[165.561482] Dynamic subtest bcs0: SKIP (0.000s)
[165.569086] Starting dynamic subtest: vcs0
[165.573124] Dynamic subtest vcs0: SKIP (0.000s)
[165.580012] Starting dynamic subtest: vcs1
[165.583993] Dynamic subtest vcs1: SKIP (0.000s)
[165.592070] Starting dynamic subtest: vecs0
[165.596083] Dynamic subtest vecs0: SKIP (0.000s)
[165.603219] Starting dynamic subtest: ccs0
[165.607188] Dynamic subtest ccs0: SKIP (0.000s)
[165.611067] Subtest most-busy-idle-check-all: SKIP (0.009s)
[165.640446] [040/131] (854s left) gem_exec_schedule (lateslice)
[165.733040] Starting subtest: lateslice
[165.735437] Starting dynamic subtest: rcs0
[165.746800] Dynamic subtest rcs0: SUCCESS (0.019s)
[165.756392] Starting dynamic subtest: bcs0
[165.763021] Dynamic subtest bcs0: SUCCESS (0.016s)
[165.770951] Starting dynamic subtest: vcs0
[165.778909] Dynamic subtest vcs0: SUCCESS (0.016s)
[165.789103] Starting dynamic subtest: vcs1
[165.795237] Dynamic subtest vcs1: SUCCESS (0.016s)
[165.803072] Starting dynamic subtest: vecs0
[165.812079] Dynamic subtest vecs0: SUCCESS (0.016s)
[165.820348] Starting dynamic subtest: ccs0
[165.828228] Dynamic subtest ccs0: SUCCESS (0.016s)
[165.830524] Subtest lateslice: SUCCESS (0.101s)
[167.049093] [041/131] (853s left) gem_exec_schedule (preempt-queue-contexts-chain)
[167.127776] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[167.417065] [042/131] (852s left) gem_ctx_param (invalid-param-set)
[167.477126] Starting subtest: invalid-param-set
[167.479498] Subtest invalid-param-set: SUCCESS (0.000s)
[167.551228] [043/131] (852s left) gem_eio (wait-wedge-10ms)
[167.794938] Starting subtest: wait-wedge-10ms
[169.033505] Subtest wait-wedge-10ms: SUCCESS (1.237s)
[169.185650] [044/131] (851s left) sw_sync (sync_multi_timeline_wait)
[169.223277] Starting subtest: sync_multi_timeline_wait
[169.225724] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[169.269399] [045/131] (851s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[169.369288] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[169.373541] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[169.478803] [046/131] (850s left) kms_flip (2x-flip-vs-expired-vblank)
[169.576219] Starting subtest: 2x-flip-vs-expired-vblank
[169.586724] Subtest 2x-flip-vs-expired-vblank: SKIP (0.010s)
[169.658103] [047/131] (850s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[169.759216] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[169.763452] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[169.851928] [048/131] (850s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[169.898228] Starting subtest: single-wait-all-for-submit-available-signaled
[169.900610] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[169.972481] [049/131] (850s left) api_intel_bb (purge-bb)
[170.023204] Starting subtest: purge-bb
[170.025483] Subtest purge-bb: SUCCESS (0.004s)
[170.141582] [050/131] (850s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[170.237615] Starting subtest: basic-max-pipe-crc-check
[170.241534] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[170.278713] [051/131] (850s left) syncobj_eventfd (invalid-illegal-handle)
[170.338817] Starting subtest: invalid-illegal-handle
[170.340878] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[170.446344] [052/131] (850s left) prime_vgem (shrink)
[170.532222] Starting subtest: shrink
[170.547512] Subtest shrink: SUCCESS (0.013s)
[170.665537] [053/131] (849s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[175.688664] Starting subtest: fbc-pr-overlay-plane-move-continuous-sf
[175.694232] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.002s)
[176.541629] [054/131] (844s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[176.649429] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[179.599070] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (2.954s)
[179.746103] [055/131] (840s left) kms_flip (busy-flip)
[179.843623] Starting subtest: busy-flip
[179.845724] Starting dynamic subtest: A-eDP1
[181.581229] Dynamic subtest A-eDP1: SUCCESS (1.736s)
[181.590673] Starting dynamic subtest: B-eDP1
[183.303210] Dynamic subtest B-eDP1: SUCCESS (1.721s)
[183.313872] Starting dynamic subtest: C-eDP1
[185.012114] Dynamic subtest C-eDP1: SUCCESS (1.708s)
[185.022523] Starting dynamic subtest: D-eDP1
[186.733616] Dynamic subtest D-eDP1: SUCCESS (1.719s)
[186.735987] Subtest busy-flip: SUCCESS (6.892s)
[187.880727] [056/131] (832s left) gem_softpin (allocator-basic)
[187.942810] Starting subtest: allocator-basic
[188.002902] Subtest allocator-basic: SUCCESS (0.059s)
[188.140343] [057/131] (832s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[188.246456] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[188.250821] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[188.360851] [058/131] (832s left) kms_pm_rpm (modeset-non-lpsp)
[190.097227] Starting subtest: modeset-non-lpsp
[191.264712] Subtest modeset-non-lpsp: SKIP (1.165s)
[191.625758] [059/131] (829s left) gem_lmem_swapping (heavy-multi)
[191.670227] Subtest heavy-multi: SKIP (0.000s)
[191.702961] [060/131] (829s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[191.794081] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[191.796363] Starting dynamic subtest: pipe-A
[191.805395] Dynamic subtest pipe-A: SKIP (0.004s)
[191.817543] Starting dynamic subtest: pipe-B
[191.827221] Dynamic subtest pipe-B: SKIP (0.014s)
[191.836538] Starting dynamic subtest: pipe-C
[191.846114] Dynamic subtest pipe-C: SKIP (0.014s)
[191.855477] Starting dynamic subtest: pipe-D
[191.863906] Dynamic subtest pipe-D: SKIP (0.015s)
[191.868122] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.049s)
[191.928237] [061/131] (828s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[191.994533] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[192.054184] [062/131] (828s left) kms_psr (fbc-psr-cursor-plane-onoff)
[192.156349] Starting subtest: fbc-psr-cursor-plane-onoff
[192.158758] Starting dynamic subtest: eDP-1
[192.163253] Dynamic subtest eDP-1: SKIP (0.000s)
[192.167784] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.001s)
[192.222951] [063/131] (828s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[192.316604] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[192.321017] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[192.408355] [064/131] (828s left) gen9_exec_parse (bb-start-out)
[192.464579] Subtest bb-start-out: SKIP (0.000s)
[192.545517] [065/131] (828s left) kms_dp_link_training (uhbr-mst)
[192.633575] Starting subtest: uhbr-mst
[192.640754] Subtest uhbr-mst: SKIP (0.000s)
[192.699170] [066/131] (828s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[192.805501] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[192.809110] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[192.909367] [067/131] (828s left) kms_flip (modeset-vs-vblank-race)
[192.999320] Starting subtest: modeset-vs-vblank-race
[193.001358] Starting dynamic subtest: A-eDP1
[197.717790] Dynamic subtest A-eDP1: SUCCESS (4.717s)
[197.728323] Starting dynamic subtest: B-eDP1
[202.408402] Dynamic subtest B-eDP1: SUCCESS (4.688s)
[202.418003] Starting dynamic subtest: C-eDP1
[206.897260] Dynamic subtest C-eDP1: SUCCESS (4.489s)
[206.905407] Starting dynamic subtest: D-eDP1
[211.511779] Dynamic subtest D-eDP1: SUCCESS (4.614s)
[211.514306] Subtest modeset-vs-vblank-race: SUCCESS (18.515s)
[212.757757] [068/131] (808s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[212.870963] Starting subtest: x-tiled-64bpp-rotate-270
[212.889231] Subtest x-tiled-64bpp-rotate-270: SKIP (0.018s)
[213.007888] [069/131] (808s left) perf_pmu (busy-idle)
[213.048156] Starting subtest: busy-idle
[213.050045] Starting dynamic subtest: rcs0
[213.749366] Dynamic subtest rcs0: SUCCESS (0.702s)
[213.760069] Starting dynamic subtest: bcs0
[214.421524] Dynamic subtest bcs0: SUCCESS (0.671s)
[214.432186] Starting dynamic subtest: vcs0
[215.913940] Dynamic subtest vcs0: SUCCESS (1.489s)
[215.924789] Starting dynamic subtest: vcs1
[217.897401] Dynamic subtest vcs1: SUCCESS (1.981s)
[217.906222] Starting dynamic subtest: vecs0
[219.945984] Dynamic subtest vecs0: SUCCESS (2.047s)
[219.957980] Starting dynamic subtest: ccs0
[220.609700] Dynamic subtest ccs0: SUCCESS (0.663s)
[220.612339] Subtest busy-idle: SUCCESS (7.563s)
[220.732213] [070/131] (800s left) kms_cursor_crc (cursor-onscreen-64x64)
[220.892269] Starting subtest: cursor-onscreen-64x64
[220.897358] Starting dynamic subtest: pipe-A-eDP-1
[223.215815] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.318s)
[223.247678] Starting dynamic subtest: pipe-D-eDP-1
[226.237608] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.996s)
[226.239537] Subtest cursor-onscreen-64x64: SUCCESS (5.343s)
[227.016136] [071/131] (794s left) gem_softpin (full)
[227.074702] Starting subtest: full
[227.081727] Subtest full: SUCCESS (0.007s)
[227.207767] [072/131] (794s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[227.310639] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[227.314851] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[227.411773] [073/131] (793s left) perf_pmu (pmu-read)
[227.453368] Starting subtest: pmu-read
[227.455630] Subtest pmu-read: SUCCESS (0.002s)
[227.558259] [074/131] (793s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[227.670096] Starting subtest: basic-busy-flip-before-cursor-atomic
[227.674670] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[227.764752] [075/131] (793s left) kms_async_flips (alternate-sync-async-flip)
[227.862403] Starting subtest: alternate-sync-async-flip
[228.243888] Starting dynamic subtest: pipe-A-eDP-1
[231.012210] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.769s)
[231.392647] Starting dynamic subtest: pipe-B-eDP-1
[234.142546] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.759s)
[234.509725] Starting dynamic subtest: pipe-C-eDP-1
[237.265149] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.765s)
[237.631086] Starting dynamic subtest: pipe-D-eDP-1
[240.389748] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.767s)
[240.391749] Subtest alternate-sync-async-flip: SUCCESS (12.528s)
[241.553602] [076/131] (779s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[241.658409] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[241.752370] [077/131] (779s left) gem_exec_store (dword)
[241.825175] Starting subtest: dword
[241.827518] Starting dynamic subtest: rcs0
[241.903520] Dynamic subtest rcs0: SUCCESS (0.078s)
[241.914799] Starting dynamic subtest: bcs0
[241.944784] Dynamic subtest bcs0: SUCCESS (0.040s)
[241.954474] Starting dynamic subtest: vcs0
[241.985635] Dynamic subtest vcs0: SUCCESS (0.039s)
[241.995957] Starting dynamic subtest: vcs1
[242.026088] Dynamic subtest vcs1: SUCCESS (0.039s)
[242.035045] Starting dynamic subtest: vecs0
[242.068197] Dynamic subtest vecs0: SUCCESS (0.040s)
[242.077856] Starting dynamic subtest: ccs0
[242.110453] Dynamic subtest ccs0: SUCCESS (0.040s)
[242.112867] Subtest dword: SUCCESS (0.287s)
[242.289789] [078/131] (779s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[242.388854] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[262.221052] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (19.835s)
[262.337482] [079/131] (759s left) gem_mmap_gtt (basic-read-write-distinct)
[262.400488] Subtest basic-read-write-distinct: SKIP (0.000s)
[262.457489] [080/131] (759s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[267.439434] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[267.441786] Starting dynamic subtest: pipe-A-eDP-1
[273.960391] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.519s)
[273.969313] Starting dynamic subtest: pipe-B-eDP-1
[280.480236] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.517s)
[280.482605] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (13.040s)
[281.261911] [081/131] (740s left) gem_exec_suspend (basic)
[281.318371] Starting subtest: basic
[281.320762] Starting dynamic subtest: smem
[282.922994] Dynamic subtest smem: SUCCESS (1.602s)
[282.925691] Subtest basic: SUCCESS (1.604s)
[283.103669] [082/131] (738s left) kms_flip (blocking-absolute-wf_vblank)
[283.200086] Starting subtest: blocking-absolute-wf_vblank
[283.202333] Starting dynamic subtest: A-eDP1
[291.924789] Dynamic subtest A-eDP1: SUCCESS (8.723s)
[291.935471] Starting dynamic subtest: B-eDP1
[300.642665] Dynamic subtest B-eDP1: SUCCESS (8.717s)
[300.652401] Starting dynamic subtest: C-eDP1
[309.360063] Dynamic subtest C-eDP1: SUCCESS (8.715s)
[309.373990] Starting dynamic subtest: D-eDP1
[318.083234] Dynamic subtest D-eDP1: SUCCESS (8.720s)
[318.088421] Subtest blocking-absolute-wf_vblank: SUCCESS (34.887s)
[319.277904] [083/131] (702s left) gem_mmap_offset (oob-read)
[319.330011] Starting subtest: oob-read
[319.331963] Subtest oob-read: SUCCESS (0.000s)
[319.425157] [084/131] (702s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[319.525344] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[319.527774] Starting dynamic subtest: pipe-A-default-mode
[319.810374] Dynamic subtest pipe-A-default-mode: SKIP (0.282s)
[319.814790] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.283s)
[320.605527] [085/131] (701s left) kms_getfb (getfb2-handle-closed)
[320.664561] Starting subtest: getfb2-handle-closed
[320.666847] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[320.767569] [086/131] (700s left) kms_panel_fitting (atomic-fastset)
[320.870107] Starting subtest: atomic-fastset
[320.872457] Starting dynamic subtest: pipe-A-eDP-1
[320.992105] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.120s)
[321.000624] Starting dynamic subtest: pipe-B-eDP-1
[322.166014] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.175s)
[322.175671] Starting dynamic subtest: pipe-C-eDP-1
[323.347045] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.179s)
[323.354726] Starting dynamic subtest: pipe-D-eDP-1
[324.567471] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.220s)
[324.569709] Subtest atomic-fastset: SUCCESS (3.696s)
[325.714617] [087/131] (696s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[325.778998] Subtest tiled-to-tiled: SKIP (0.000s)
[325.859290] [088/131] (695s left) kms_psr (fbc-pr-cursor-render)
[325.953381] Starting subtest: fbc-pr-cursor-render
[325.957993] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[326.019947] [089/131] (695s left) kms_cursor_crc (cursor-offscreen-512x170)
[326.291398] Starting subtest: cursor-offscreen-512x170
[326.295639] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[326.442283] [090/131] (695s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[326.541204] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[326.545635] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[327.641969] [091/131] (694s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[327.748294] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[329.005451] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (1.259s)
[329.228345] [092/131] (692s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[329.291204] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[329.397956] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.106s)
[329.468187] [093/131] (692s left) gem_create (create-ext-placement-all)
[329.643751] Starting subtest: create-ext-placement-all
[329.646139] Subtest create-ext-placement-all: SUCCESS (0.000s)
[329.750283] [094/131] (692s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[329.899723] Starting subtest: cursor-rapid-movement-32x10
[329.935944] Subtest cursor-rapid-movement-32x10: SKIP (0.032s)
[330.186889] [095/131] (691s left) gem_ppgtt (shrink-vs-evict-any)
[330.254807] Starting subtest: shrink-vs-evict-any
[335.880568] Subtest shrink-vs-evict-any: SUCCESS (5.623s)
[335.982218] [096/131] (686s left) gem_softpin (evict-active-interruptible)
[336.044534] Starting subtest: evict-active-interruptible
[336.058590] Subtest evict-active-interruptible: SUCCESS (0.014s)
[336.144640] [097/131] (685s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[336.240093] Starting subtest: primary-4-tiled-reflect-x-180
[343.328080] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.086s)
[344.493927] [098/131] (677s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[344.605268] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[344.609256] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[344.696037] [099/131] (677s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[344.799617] Starting subtest: 4-tiled-16bpp-rotate-180
[346.052571] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.255s)
[346.205987] [100/131] (676s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[346.330858] Starting subtest: flip-vs-cursor-atomic
[352.836349] Subtest flip-vs-cursor-atomic: SUCCESS (6.506s)
[353.623098] [101/131] (668s left) i915_pm_rpm (gem-idle)
[355.162618] Starting subtest: gem-idle
[361.371406] Subtest gem-idle: SUCCESS (6.210s)
[361.681585] [102/131] (660s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[362.932120] Starting subtest: sprite-rotation-90-pos-100-0
[362.936696] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[363.037548] [103/131] (659s left) kms_psr (fbc-psr2-sprite-blt)
[363.138499] Starting subtest: fbc-psr2-sprite-blt
[363.141068] Starting dynamic subtest: eDP-1
[363.145412] Dynamic subtest eDP-1: SKIP (0.000s)
[363.149812] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[363.205548] [104/131] (659s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[363.305679] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[363.309816] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[363.401657] [105/131] (658s left) gem_sync (basic-store-all)
[363.471861] Starting subtest: basic-store-all
[367.429965] Subtest basic-store-all: SUCCESS (3.967s)
[367.610965] [106/131] (654s left) kms_addfb_basic (bad-pitch-256)
[367.679814] Starting subtest: bad-pitch-256
[367.682106] Subtest bad-pitch-256: SUCCESS (0.000s)
[367.839509] [107/131] (654s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[367.942093] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[368.886101] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (0.944s)
[369.011252] [108/131] (653s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[369.116708] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[369.119052] Starting dynamic subtest: A-eDP1
[372.587330] Dynamic subtest A-eDP1: SUCCESS (3.467s)
[372.596389] Starting dynamic subtest: B-eDP1
[375.658766] Dynamic subtest B-eDP1: SUCCESS (3.070s)
[375.668134] Starting dynamic subtest: C-eDP1
[378.726324] Dynamic subtest C-eDP1: SUCCESS (3.068s)
[378.735030] Starting dynamic subtest: D-eDP1
[381.812734] Dynamic subtest D-eDP1: SUCCESS (3.086s)
[381.815073] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.697s)
[382.608681] [109/131] (639s left) gem_exec_balancer (sequential)
[382.670470] Starting subtest: sequential
[385.571144] Subtest sequential: SUCCESS (2.901s)
[385.881269] [110/131] (636s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[385.988154] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[385.990378] Starting dynamic subtest: pipe-A-default-mode
[387.162809] Dynamic subtest pipe-A-default-mode: SKIP (1.168s)
[387.167308] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.170s)
[387.310668] [111/131] (635s left) syncobj_wait (reset-signaled)
[387.373490] Starting subtest: reset-signaled
[387.375739] Subtest reset-signaled: SUCCESS (0.000s)
[387.470688] [112/131] (635s left) gem_mmap_gtt (hang-user)
[387.526140] Subtest hang-user: SKIP (0.000s)
[387.586330] [113/131] (635s left) kms_plane_alpha_blend (alpha-basic)
[387.679300] Starting subtest: alpha-basic
[388.078841] Starting dynamic subtest: pipe-A-eDP-1
[390.009061] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.929s)
[390.031727] Starting dynamic subtest: pipe-D-eDP-1
[392.689550] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.662s)
[392.691767] Subtest alpha-basic: SUCCESS (5.008s)
[393.476921] [114/131] (629s left) kms_chamelium_edid (hdmi-mode-timings)
[393.857893] Subtest hdmi-mode-timings: SKIP (0.000s)
[394.675673] [115/131] (628s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[394.786860] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[398.470693] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (3.688s)
[398.611114] [116/131] (624s left) kms_color (ctm-max)
[398.704976] Starting subtest: ctm-max
[398.706859] Starting dynamic subtest: pipe-A-eDP-1
[399.401068] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.694s)
[399.410993] Starting dynamic subtest: pipe-B-eDP-1
[400.802765] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.402s)
[400.811970] Starting dynamic subtest: pipe-C-eDP-1
[402.106966] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.302s)
[402.117486] Starting dynamic subtest: pipe-D-eDP-1
[403.402607] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.295s)
[403.405015] Subtest ctm-max: SUCCESS (4.697s)
[404.234334] [117/131] (618s left) gem_pipe_control_store_loop (reused-buffer)
[404.300533] Starting subtest: reused-buffer
[406.454872] Subtest reused-buffer: SUCCESS (2.153s)
[406.592447] [118/131] (616s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[406.698242] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[411.499554] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.804s)
[411.608452] [119/131] (611s left) gem_ctx_shared (create-shared-gtt)
[411.666973] Starting subtest: create-shared-gtt
[413.820949] Subtest create-shared-gtt: SUCCESS (2.152s)
[414.138031] [120/131] (608s left) gem_userptr_blits (map-fixed-invalidate-busy)
[414.211699] Starting subtest: map-fixed-invalidate-busy
[414.216263] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[414.342142] [121/131] (608s left) kms_pm_lpsp (screens-disabled)
[415.453479] Starting subtest: screens-disabled
[415.457998] Subtest screens-disabled: SKIP (0.000s)
[415.519387] [122/131] (607s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[415.619234] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[415.624171] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[416.709337] [123/131] (606s left) gem_exec_params (invalid-ring)
[416.767066] Starting subtest: invalid-ring
[416.769411] Subtest invalid-ring: SUCCESS (0.000s)
[416.879781] [124/131] (606s left) gem_ctx_param (get-priority-new-ctx)
[416.941966] Starting subtest: get-priority-new-ctx
[416.944315] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[417.037536] [125/131] (606s left) gem_wait (busy)
[417.107525] Starting subtest: busy
[417.110075] Starting dynamic subtest: all-engines
[418.942742] Dynamic subtest all-engines: SUCCESS (1.812s)
[418.953078] Starting dynamic subtest: rcs0
[419.464980] Dynamic subtest rcs0: SUCCESS (0.542s)
[419.476815] Starting dynamic subtest: bcs0
[420.005414] Dynamic subtest bcs0: SUCCESS (0.540s)
[420.016344] Starting dynamic subtest: vcs0
[421.930218] Dynamic subtest vcs0: SUCCESS (1.922s)
[421.941979] Starting dynamic subtest: vcs1
[423.913924] Dynamic subtest vcs1: SUCCESS (1.981s)
[423.925140] Starting dynamic subtest: vecs0
[425.897161] Dynamic subtest vecs0: SUCCESS (1.981s)
[425.906808] Starting dynamic subtest: ccs0
[426.439421] Dynamic subtest ccs0: SUCCESS (0.542s)
[426.441854] Subtest busy: SUCCESS (9.332s)
[426.633825] [126/131] (596s left) kms_cursor_legacy (forked-move)
[426.750844] Starting subtest: forked-move
[426.753115] Starting dynamic subtest: pipe-A
[432.261206] Dynamic subtest pipe-A: SUCCESS (5.509s)
[432.272801] Starting dynamic subtest: pipe-B
[437.748533] Dynamic subtest pipe-B: SUCCESS (5.485s)
[437.758944] Starting dynamic subtest: pipe-C
[443.259269] Dynamic subtest pipe-C: SUCCESS (5.508s)
[443.270768] Starting dynamic subtest: pipe-D
[448.789217] Dynamic subtest pipe-D: SUCCESS (5.495s)
[448.800680] Starting dynamic subtest: all-pipes
[454.296492] Dynamic subtest all-pipes: SUCCESS (5.537s)
[454.298705] Subtest forked-move: SUCCESS (27.542s)
[454.427181] [127/131] (568s left) gem_mmap_wc (write)
[454.480592] Subtest write: SKIP (0.000s)
[454.547560] [128/131] (568s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[454.652568] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[459.215948] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (4.566s)
[459.342600] [129/131] (563s left) kms_busy (extended-pageflip-hang-newfb)
[459.443157] Starting subtest: extended-pageflip-hang-newfb
[459.445510] Starting dynamic subtest: pipe-A
[485.681424] Dynamic subtest pipe-A: SUCCESS (26.235s)
[485.690244] Starting dynamic subtest: pipe-D
[500.727545] Dynamic subtest pipe-D: SUCCESS (15.044s)
[500.729886] Subtest extended-pageflip-hang-newfb: SUCCESS (41.283s)
[501.598909] [130/131] (521s left) perf (invalid-open-flags)
[501.703508] Starting subtest: invalid-open-flags
[501.705800] Subtest invalid-open-flags: SUCCESS (0.000s)
[501.755896] [131/131] (521s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[501.874601] Starting subtest: fbcpsr-slowdraw
[524.824261] Subtest fbcpsr-slowdraw: SUCCESS (22.952s)
[524.964342] Closing watchdogs
results: parsing output: 0/ for test: api_intel_allocator
results: parsing output: 1/ for test: kms_psr
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_exec_params
results: parsing output: 4/ for test: kms_chamelium_hpd
results: parsing output: 5/ for test: gem_exec_balancer
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: i915_hangman
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_plane_multiple
results: parsing output: 10/ for test: gem_exec_reloc
results: parsing output: 11/ for test: syncobj_wait
results: parsing output: 12/ for test: gem_render_copy
results: parsing output: 13/ for test: kms_big_fb
results: parsing output: 14/ for test: kms_universal_plane
results: parsing output: 15/ for test: gem_exec_balancer
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_pm_backlight
results: parsing output: 18/ for test: gem_busy
results: parsing output: 19/ for test: sysfs_heartbeat_interval
results: parsing output: 20/ for test: gem_exec_fence
results: parsing output: 21/ for test: kms_psr
results: parsing output: 22/ for test: kms_rmfb
results: parsing output: 23/ for test: kms_properties
results: parsing output: 24/ for test: gem_exec_whisper
results: parsing output: 25/ for test: gem_readwrite
results: parsing output: 26/ for test: gem_ctx_persistence
results: parsing output: 27/ for test: gem_eio
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_vrr
results: parsing output: 31/ for test: kms_invalid_mode
results: parsing output: 32/ for test: drm_fdinfo
results: parsing output: 33/ for test: syncobj_timeline
results: parsing output: 34/ for test: kms_ccs
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_ccs
results: parsing output: 37/ for test: sw_sync
results: parsing output: 38/ for test: drm_fdinfo
results: parsing output: 39/ for test: gem_exec_schedule
results: parsing output: 40/ for test: gem_exec_schedule
results: parsing output: 41/ for test: gem_ctx_param
results: parsing output: 42/ for test: gem_eio
results: parsing output: 43/ for test: sw_sync
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: syncobj_timeline
results: parsing output: 48/ for test: api_intel_bb
results: parsing output: 49/ for test: kms_multipipe_modeset
results: parsing output: 50/ for test: syncobj_eventfd
results: parsing output: 51/ for test: prime_vgem
results: parsing output: 52/ for test: kms_psr2_sf
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_flip
results: parsing output: 55/ for test: gem_softpin
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_pm_rpm
results: parsing output: 58/ for test: gem_lmem_swapping
results: parsing output: 59/ for test: kms_plane_scaling
results: parsing output: 60/ for test: kms_pipe_b_c_ivb
results: parsing output: 61/ for test: kms_psr
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: gen9_exec_parse
results: parsing output: 64/ for test: kms_dp_link_training
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: perf_pmu
results: parsing output: 69/ for test: kms_cursor_crc
results: parsing output: 70/ for test: gem_softpin
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: perf_pmu
results: parsing output: 73/ for test: kms_cursor_legacy
results: parsing output: 74/ for test: kms_async_flips
results: parsing output: 75/ for test: kms_addfb_basic
results: parsing output: 76/ for test: gem_exec_store
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_mmap_gtt
results: parsing output: 79/ for test: kms_psr2_sf
results: parsing output: 80/ for test: gem_exec_suspend
results: parsing output: 81/ for test: kms_flip
results: parsing output: 82/ for test: gem_mmap_offset
results: parsing output: 83/ for test: kms_flip_scaled_crc
results: parsing output: 84/ for test: kms_getfb
results: parsing output: 85/ for test: kms_panel_fitting
results: parsing output: 86/ for test: gem_set_tiling_vs_blt
results: parsing output: 87/ for test: kms_psr
results: parsing output: 88/ for test: kms_cursor_crc
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: syncobj_timeline
results: parsing output: 92/ for test: gem_create
results: parsing output: 93/ for test: kms_cursor_crc
results: parsing output: 94/ for test: gem_ppgtt
results: parsing output: 95/ for test: gem_softpin
results: parsing output: 96/ for test: kms_rotation_crc
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: kms_cursor_legacy
results: parsing output: 100/ for test: i915_pm_rpm
results: parsing output: 101/ for test: kms_rotation_crc
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_sync
results: parsing output: 105/ for test: kms_addfb_basic
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: kms_flip
results: parsing output: 108/ for test: gem_exec_balancer
results: parsing output: 109/ for test: kms_flip_scaled_crc
results: parsing output: 110/ for test: syncobj_wait
results: parsing output: 111/ for test: gem_mmap_gtt
results: parsing output: 112/ for test: kms_plane_alpha_blend
results: parsing output: 113/ for test: kms_chamelium_edid
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_color
results: parsing output: 116/ for test: gem_pipe_control_store_loop
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: gem_ctx_shared
results: parsing output: 119/ for test: gem_userptr_blits
results: parsing output: 120/ for test: kms_pm_lpsp
results: parsing output: 121/ for test: kms_ccs
results: parsing output: 122/ for test: gem_exec_params
results: parsing output: 123/ for test: gem_ctx_param
results: parsing output: 124/ for test: gem_wait
results: parsing output: 125/ for test: kms_cursor_legacy
results: parsing output: 126/ for test: gem_mmap_wc
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_busy
results: parsing output: 129/ for test: perf
results: parsing output: 130/ for test: kms_frontbuffer_tracking
Done.