[56.308040] Initializing watchdogs
[56.308088]   /dev/watchdog0
[56.322132] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[56.325987] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.328489] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.331924] [001/133] (960s left) syncobj_timeline (invalid-transfer-bad-pad)
[56.400834] Starting subtest: invalid-transfer-bad-pad
[56.403287] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[56.519618] [002/133] (960s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[56.772788] Starting subtest: parallel-dmabuf-import-out-fence
[57.831543] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.059s)
[57.933144] [003/133] (958s left) api_intel_allocator (reloc-allocator)
[57.989835] Starting subtest: reloc-allocator
[57.992203] Starting dynamic subtest: basic
[57.996888] Dynamic subtest basic: SUCCESS (0.007s)
[58.004167] Starting dynamic subtest: parallel-one
[58.007321] Dynamic subtest parallel-one: SUCCESS (0.007s)
[58.014617] Starting dynamic subtest: print
[58.016857] Dynamic subtest print: SUCCESS (0.000s)
[58.025234] Starting dynamic subtest: reuse
[58.027116] Dynamic subtest reuse: SUCCESS (0.000s)
[58.033466] Starting dynamic subtest: fork-reopen-allocator
[58.035423] Dynamic subtest fork-reopen-allocator: SUCCESS (0.017s)
[58.037339] Subtest reloc-allocator: SUCCESS (0.033s)
[58.157393] [004/133] (958s left) i915_selftest (live)
[59.818950] Starting subtest: live
[59.821410] Starting dynamic subtest: sanitycheck
[64.080811] Dynamic subtest sanitycheck: SUCCESS (4.264s)
[64.090728] Starting dynamic subtest: uncore
[68.377365] Dynamic subtest uncore: SUCCESS (4.296s)
[68.386042] Starting dynamic subtest: workarounds
[71.461050] Dynamic subtest workarounds: SUCCESS (3.083s)
[71.468593] Starting dynamic subtest: gt_engines
[75.943486] Dynamic subtest gt_engines: SUCCESS (4.481s)
[75.950611] Starting dynamic subtest: gt_timelines
[90.913740] Dynamic subtest gt_timelines: SUCCESS (14.968s)
[90.921716] Starting dynamic subtest: gt_contexts
[95.265874] Dynamic subtest gt_contexts: SUCCESS (4.351s)
[95.274762] Starting dynamic subtest: gt_lrc
[101.300954] Dynamic subtest gt_lrc: SUCCESS (6.034s)
[101.309133] Starting dynamic subtest: gt_mocs
[104.278558] Dynamic subtest gt_mocs: SUCCESS (2.977s)
[104.286335] Starting dynamic subtest: gt_pm
[109.044354] Dynamic subtest gt_pm: SUCCESS (4.765s)
[109.057709] Starting dynamic subtest: gt_heartbeat
[113.312812] Dynamic subtest gt_heartbeat: SUCCESS (4.268s)
[113.321596] Starting dynamic subtest: gt_tlb
[122.661045] Dynamic subtest gt_tlb: SUCCESS (9.347s)
[122.669568] Starting dynamic subtest: requests
[134.116818] Dynamic subtest requests: SUCCESS (11.456s)
[134.125140] Starting dynamic subtest: migrate
[141.828066] Dynamic subtest migrate: SUCCESS (7.710s)
[141.836783] Starting dynamic subtest: active
[144.509380] Dynamic subtest active: SUCCESS (2.680s)
[144.518441] Starting dynamic subtest: objects
[147.677996] Dynamic subtest objects: SUCCESS (3.167s)
[147.686515] Starting dynamic subtest: mman
[150.951219] Dynamic subtest mman: SUCCESS (3.272s)
[150.960183] Starting dynamic subtest: dmabuf
[155.282032] Dynamic subtest dmabuf: SUCCESS (4.329s)
[155.290063] Starting dynamic subtest: vma
[159.533765] Dynamic subtest vma: SUCCESS (4.251s)
[159.542447] Starting dynamic subtest: coherency
[163.080455] Dynamic subtest coherency: SUCCESS (3.546s)
[163.089265] Starting dynamic subtest: gtt
[174.409787] Dynamic subtest gtt: SUCCESS (11.328s)
[174.421400] Starting dynamic subtest: gem
[180.513332] Dynamic subtest gem: SUCCESS (6.102s)
[180.520688] Starting dynamic subtest: evict
[185.860910] Dynamic subtest evict: SUCCESS (5.346s)
[185.869829] Starting dynamic subtest: hugepages
[196.606134] Dynamic subtest hugepages: SUCCESS (10.743s)
[196.614089] Starting dynamic subtest: gem_contexts
[223.035469] Dynamic subtest gem_contexts: SUCCESS (26.428s)
[223.043423] Starting dynamic subtest: client
[227.349428] Dynamic subtest client: SUCCESS (4.312s)
[227.358508] Starting dynamic subtest: gem_migrate
[231.657209] Dynamic subtest gem_migrate: SUCCESS (4.307s)
[231.666048] Starting dynamic subtest: reset
[235.954596] Dynamic subtest reset: SUCCESS (4.296s)
[235.963373] Starting dynamic subtest: memory_region
[240.247931] Dynamic subtest memory_region: SUCCESS (4.291s)
[240.256499] Starting dynamic subtest: hangcheck
[253.628222] Dynamic subtest hangcheck: SUCCESS (13.378s)
[253.637311] Starting dynamic subtest: execlists
[257.921997] Dynamic subtest execlists: SUCCESS (4.292s)
[257.930720] Starting dynamic subtest: ring_submission
[260.547041] Dynamic subtest ring_submission: SUCCESS (2.624s)
[260.556020] Starting dynamic subtest: perf
[264.792964] Dynamic subtest perf: SUCCESS (4.243s)
[264.804711] Starting dynamic subtest: slpc
[276.632108] Dynamic subtest slpc: SUCCESS (11.836s)
[276.646772] Starting dynamic subtest: guc
[280.371048] Dynamic subtest guc: SUCCESS (3.736s)
[280.378043] Starting dynamic subtest: guc_multi_lrc
[284.647312] Dynamic subtest guc_multi_lrc: SUCCESS (4.273s)
[284.656314] Starting dynamic subtest: guc_hang
[289.389354] Dynamic subtest guc_hang: SUCCESS (4.740s)
[289.397333] Starting dynamic subtest: late_gt_pm
[292.126591] Dynamic subtest late_gt_pm: SUCCESS (2.735s)
[292.129632] Subtest live: SUCCESS (232.303s)
[292.156194] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[292.159540] [005/133] (724s left) kms_rotation_crc (multiplane-rotation)
[293.653105] Starting subtest: multiplane-rotation
[311.069420] Subtest multiplane-rotation: SUCCESS (17.416s)
[311.166815] [FACT kms_rotation_crc (multiplane-rotation)] new: kernel.kmod_is_loaded.i915: true
[311.170672] [006/133] (705s left) gem_userptr_blits (create-destroy-sync)
[311.242021] Starting subtest: create-destroy-sync
[316.261384] Subtest create-destroy-sync: SUCCESS (5.019s)
[316.391513] [007/133] (700s left) sw_sync (sync_merge)
[316.426469] Starting subtest: sync_merge
[316.428747] Subtest sync_merge: SUCCESS (0.000s)
[316.478345] [008/133] (700s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[316.566797] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[316.569084] Starting dynamic subtest: pipe-A-eDP-1
[316.588864] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[316.598510] Starting dynamic subtest: pipe-B-eDP-1
[316.619810] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[316.626901] Starting dynamic subtest: pipe-C-eDP-1
[316.646398] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[316.653278] Starting dynamic subtest: pipe-D-eDP-1
[316.672625] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[316.674817] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[318.771781] [009/133] (698s left) gem_exec_schedule (u-submit-golden-slice)
[318.839068] Starting subtest: u-submit-golden-slice
[318.840959] Starting dynamic subtest: rcs0
[318.866247] Dynamic subtest rcs0: SUCCESS (0.034s)
[318.873891] Starting dynamic subtest: bcs0
[318.895297] Dynamic subtest bcs0: SUCCESS (0.028s)
[318.903507] Starting dynamic subtest: vcs0
[318.929906] Dynamic subtest vcs0: SUCCESS (0.034s)
[318.937410] Starting dynamic subtest: vcs1
[318.958534] Dynamic subtest vcs1: SUCCESS (0.028s)
[318.966039] Starting dynamic subtest: vecs0
[318.989744] Dynamic subtest vecs0: SUCCESS (0.030s)
[318.997380] Starting dynamic subtest: ccs0
[319.019278] Dynamic subtest ccs0: SUCCESS (0.029s)
[319.021568] Subtest u-submit-golden-slice: SUCCESS (0.187s)
[320.926701] [010/133] (696s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[320.984305] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[321.049758] [011/133] (696s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[321.145601] Starting subtest: basic-flip-before-cursor-atomic
[322.086279] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.940s)
[322.913767] [012/133] (694s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[323.012582] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[323.017104] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[323.091125] [013/133] (694s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[323.147964] Starting subtest: single-wait-all-for-submit-available-signaled
[323.150311] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[323.235545] [014/133] (694s left) i915_pm_rpm (gem-execbuf-stress)
[324.947517] Starting subtest: gem-execbuf-stress
[324.949747] Starting dynamic subtest: smem0
[337.765069] Dynamic subtest smem0: SUCCESS (12.818s)
[337.776234] Starting dynamic subtest: extra-wait-smem0
[399.411616] Dynamic subtest extra-wait-smem0: SUCCESS (61.640s)
[399.414598] Subtest gem-execbuf-stress: SUCCESS (74.464s)
[399.771612] [015/133] (617s left) kms_dirtyfb (drrs-dirtyfb-ioctl)
[399.862156] Starting subtest: drrs-dirtyfb-ioctl
[399.875447] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s)
[399.965483] [016/133] (617s left) kms_hdr (static-toggle-suspend)
[400.049338] Starting subtest: static-toggle-suspend
[400.055916] Subtest static-toggle-suspend: SKIP (0.000s)
[400.137650] [017/133] (617s left) kms_content_protection (mei-interface)
[400.269919] Starting subtest: mei-interface
[400.274280] Subtest mei-interface: SKIP (0.001s)
[400.393900] [018/133] (617s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[400.471426] Starting subtest: psr-rgb565-draw-mmap-cpu
[407.242892] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.775s)
[407.340513] [019/133] (610s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[407.423792] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[407.427821] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[407.511543] [020/133] (610s left) gem_exec_fence (submit-chain)
[407.693678] Starting subtest: submit-chain
[407.713884] Subtest submit-chain: SUCCESS (0.021s)
[409.954583] [FACT gem_exec_fence (submit-chain)] new: kernel.kmod_is_loaded.vgem: true
[409.958175] [021/133] (607s left) gem_userptr_blits (readonly-pwrite-unsync)
[410.032222] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[410.144409] [022/133] (607s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[410.224060] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[410.228649] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[411.318361] [023/133] (606s left) gem_exec_nop (basic-sequential)
[411.386269] Starting subtest: basic-sequential
[426.331091] Subtest basic-sequential: SUCCESS (14.952s)
[426.560384] [024/133] (591s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[426.647618] Starting subtest: fbc-psr2-cursor-plane-update-sf
[426.649949] Starting dynamic subtest: pipe-A-eDP-1
[426.719761] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[426.728630] Starting dynamic subtest: pipe-B-eDP-1
[427.899207] Dynamic subtest pipe-B-eDP-1: SKIP (1.177s)
[427.903895] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.257s)
[429.090865] [025/133] (588s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[429.155313] Subtest writes-after-reads-uncached: SKIP (0.000s)
[429.228615] [026/133] (588s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[429.312253] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[429.316794] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[429.424484] [027/133] (588s left) kms_flip (modeset-vs-vblank-race-interruptible)
[429.493894] Starting subtest: modeset-vs-vblank-race-interruptible
[429.496253] Starting dynamic subtest: A-eDP1
[434.220649] Dynamic subtest A-eDP1: SUCCESS (4.725s)
[434.231248] Starting dynamic subtest: B-eDP1
[438.850823] Dynamic subtest B-eDP1: SUCCESS (4.628s)
[438.866112] Starting dynamic subtest: C-eDP1
[443.359986] Dynamic subtest C-eDP1: SUCCESS (4.506s)
[443.368049] Starting dynamic subtest: D-eDP1
[447.893863] Dynamic subtest D-eDP1: SUCCESS (4.532s)
[447.899623] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.403s)
[449.053320] [028/133] (568s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[449.133491] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[455.920178] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.789s)
[456.024754] [029/133] (561s left) kms_pm_rpm (legacy-planes-dpms)
[458.037659] Starting subtest: legacy-planes-dpms
[458.040026] Starting dynamic subtest: plane-65
[466.341941] Dynamic subtest plane-65: SUCCESS (8.308s)
[466.352252] Starting dynamic subtest: plane-95
[474.643881] Dynamic subtest plane-95: SUCCESS (8.299s)
[474.655463] Starting dynamic subtest: plane-125
[482.942807] Dynamic subtest plane-125: SUCCESS (8.295s)
[482.954509] Starting dynamic subtest: plane-135
[491.252969] Dynamic subtest plane-135: SUCCESS (8.308s)
[491.255777] Subtest legacy-planes-dpms: SUCCESS (33.221s)
[491.628891] [030/133] (526s left) perf (sysctl-defaults)
[491.701158] Starting subtest: sysctl-defaults
[491.703517] Subtest sysctl-defaults: SUCCESS (0.000s)
[491.806439] [031/133] (526s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[491.866440] Starting subtest: multi-wait-available-unsubmitted-signaled
[491.868316] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.001s)
[491.969260] [032/133] (526s left) kms_getfb (getfb-handle-closed)
[492.050097] Starting subtest: getfb-handle-closed
[492.052301] Subtest getfb-handle-closed: SUCCESS (0.000s)
[492.165608] [033/133] (525s left) gem_exec_reloc (basic-gtt-active)
[492.219407] Subtest basic-gtt-active: SKIP (0.000s)
[492.288521] [034/133] (525s left) gem_exec_fence (syncobj-timeline-wait)
[492.820741] Starting subtest: syncobj-timeline-wait
[493.847263] Subtest syncobj-timeline-wait: SUCCESS (1.026s)
[495.883161] [035/133] (522s left) kms_getfb (getfb2-handle-protection)
[495.958860] Starting subtest: getfb2-handle-protection
[495.987170] Subtest getfb2-handle-protection: SUCCESS (0.028s)
[496.103569] [036/133] (522s left) kms_cursor_crc (cursor-onscreen-512x512)
[496.365933] Starting subtest: cursor-onscreen-512x512
[496.370301] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[496.508878] [037/133] (521s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[496.573322] Starting subtest: coverage-vs-premult-vs-constant
[496.856269] Starting dynamic subtest: pipe-A-eDP-1
[497.443834] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.585s)
[497.453505] Starting dynamic subtest: pipe-D-eDP-1
[498.727740] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.281s)
[498.730142] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.153s)
[499.575901] [038/133] (518s left) gem_exec_schedule (preempt-user)
[499.650599] Starting subtest: preempt-user
[499.652885] Starting dynamic subtest: rcs0
[499.666652] Dynamic subtest rcs0: SUCCESS (0.025s)
[499.676066] Starting dynamic subtest: bcs0
[499.688137] Dynamic subtest bcs0: SUCCESS (0.021s)
[499.699794] Starting dynamic subtest: vcs0
[499.708337] Dynamic subtest vcs0: SUCCESS (0.020s)
[499.716459] Starting dynamic subtest: vcs1
[499.727780] Dynamic subtest vcs1: SUCCESS (0.019s)
[499.736654] Starting dynamic subtest: vecs0
[499.747469] Dynamic subtest vecs0: SUCCESS (0.019s)
[499.759648] Starting dynamic subtest: ccs0
[499.770934] Dynamic subtest ccs0: SUCCESS (0.023s)
[499.773455] Subtest preempt-user: SUCCESS (0.130s)
[500.898408] [039/133] (517s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[500.974172] Starting subtest: plane-lut1d-ctm3x4
[501.121520] Starting dynamic subtest: pipe-A-plane-0
[501.265355] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s)
[501.274224] Starting dynamic subtest: pipe-A-plane-1
[501.398227] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[501.406817] Starting dynamic subtest: pipe-A-plane-2
[501.576075] Dynamic subtest pipe-A-plane-2: SUCCESS (0.177s)
[502.797236] Starting dynamic subtest: pipe-B-plane-0
[502.967647] Dynamic subtest pipe-B-plane-0: SUCCESS (0.178s)
[502.977169] Starting dynamic subtest: pipe-B-plane-1
[503.112195] Dynamic subtest pipe-B-plane-1: SUCCESS (0.144s)
[503.120239] Starting dynamic subtest: pipe-B-plane-2
[503.300771] Dynamic subtest pipe-B-plane-2: SUCCESS (0.186s)
[504.556479] Starting dynamic subtest: pipe-C-plane-0
[504.693825] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[504.702572] Starting dynamic subtest: pipe-C-plane-1
[504.827102] Dynamic subtest pipe-C-plane-1: SUCCESS (0.132s)
[504.838783] Starting dynamic subtest: pipe-C-plane-2
[504.971610] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[506.175787] Starting dynamic subtest: pipe-D-plane-0
[506.302053] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s)
[506.310315] Starting dynamic subtest: pipe-D-plane-1
[506.446252] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[506.455675] Starting dynamic subtest: pipe-D-plane-2
[506.579850] Dynamic subtest pipe-D-plane-2: SUCCESS (0.133s)
[506.871964] Subtest plane-lut1d-ctm3x4: SUCCESS (5.899s)
[507.720162] [040/133] (510s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[507.793648] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[514.378955] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.588s)
[514.491658] [041/133] (503s left) kms_hdmi_inject (inject-audio)
[514.561782] Subtest inject-audio: SKIP (0.000s)
[514.621519] [042/133] (503s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[514.706127] Starting subtest: y-tiled-16bpp-rotate-270
[514.710149] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[514.797123] [043/133] (503s left) gem_render_copy (y-tiled-to-vebox-linear)
[514.858364] Starting subtest: y-tiled-to-vebox-linear
[514.862845] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[515.040253] [044/133] (503s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[515.125864] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[515.128192] Starting dynamic subtest: pipe-A
[515.190114] Dynamic subtest pipe-A: SUCCESS (0.065s)
[515.200418] Starting dynamic subtest: pipe-B
[516.298590] Dynamic subtest pipe-B: SUCCESS (1.107s)
[516.310092] Starting dynamic subtest: pipe-C
[517.412868] Dynamic subtest pipe-C: SUCCESS (1.110s)
[517.422905] Starting dynamic subtest: pipe-D
[518.535751] Dynamic subtest pipe-D: SUCCESS (1.125s)
[518.538185] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.412s)
[519.705631] [045/133] (498s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[519.772635] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[519.775200] Starting dynamic subtest: pipe-A-eDP-1
[520.219859] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.417s)
[520.230527] Starting dynamic subtest: pipe-B-eDP-1
[521.614368] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.394s)
[521.624904] Starting dynamic subtest: pipe-C-eDP-1
[523.017967] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.403s)
[523.033471] Starting dynamic subtest: pipe-D-eDP-1
[524.372789] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.357s)
[524.374717] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.576s)
[525.512557] [046/133] (493s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[525.587081] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[525.591796] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[525.658524] [047/133] (492s left) i915_hangman (hangcheck-unterminated)
[525.738304] Starting subtest: hangcheck-unterminated
[535.799073] Subtest hangcheck-unterminated: SUCCESS (10.060s)
[535.937571] [048/133] (482s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[536.330260] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[537.119125] [049/133] (481s left) kms_properties (crtc-properties-atomic)
[537.197172] Starting subtest: crtc-properties-atomic
[537.199498] Starting dynamic subtest: pipe-A-eDP-1
[537.644773] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.446s)
[537.653680] Starting dynamic subtest: pipe-B-eDP-1
[538.802057] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.156s)
[538.817177] Starting dynamic subtest: pipe-C-eDP-1
[539.912624] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.109s)
[539.921703] Starting dynamic subtest: pipe-D-eDP-1
[541.048057] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.133s)
[541.050333] Subtest crtc-properties-atomic: SUCCESS (3.850s)
[541.849063] [050/133] (476s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[541.930516] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[548.647431] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.719s)
[548.784696] [051/133] (469s left) gem_mmap_gtt (big-bo-tiledx)
[548.842529] Subtest big-bo-tiledX: SKIP (0.000s)
[548.905797] [052/133] (469s left) kms_plane_cursor (viewport)
[548.988971] Starting subtest: viewport
[548.993503] Starting dynamic subtest: pipe-A-eDP-1-size-64
[551.636825] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.646s)
[551.695294] Starting dynamic subtest: pipe-A-eDP-1-size-128
[554.146546] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.460s)
[554.207211] Starting dynamic subtest: pipe-A-eDP-1-size-256
[556.624925] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.426s)
[556.978395] Starting dynamic subtest: pipe-B-eDP-1-size-64
[560.146876] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.178s)
[560.204898] Starting dynamic subtest: pipe-B-eDP-1-size-128
[562.658734] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.460s)
[562.718286] Starting dynamic subtest: pipe-B-eDP-1-size-256
[565.170665] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.460s)
[565.526801] Starting dynamic subtest: pipe-C-eDP-1-size-64
[568.303464] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.789s)
[568.341406] Starting dynamic subtest: pipe-C-eDP-1-size-128
[570.437560] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.102s)
[570.474208] Starting dynamic subtest: pipe-C-eDP-1-size-256
[572.570826] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.103s)
[572.908604] Starting dynamic subtest: pipe-D-eDP-1-size-64
[575.681771] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.783s)
[575.717708] Starting dynamic subtest: pipe-D-eDP-1-size-128
[577.769290] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.058s)
[577.808473] Starting dynamic subtest: pipe-D-eDP-1-size-256
[579.914364] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.114s)
[580.233694] Subtest viewport: SUCCESS (31.243s)
[581.026873] [053/133] (437s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[581.111326] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[585.608919] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.502s)
[586.812412] [054/133] (432s left) gem_mmap_gtt (bad-object)
[586.863979] Subtest bad-object: SKIP (0.000s)
[586.919568] [055/133] (431s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[586.996304] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[587.000637] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[587.092641] [056/133] (431s left) gem_vm_create (invalid-destroy)
[587.154452] Starting subtest: invalid-destroy
[587.156856] Subtest invalid-destroy: SUCCESS (0.002s)
[587.263510] [057/133] (431s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[587.331308] Starting subtest: modeset-transition-nonblocking-fencing
[587.333641] Starting dynamic subtest: 1x-outputs
[598.383949] Dynamic subtest 1x-outputs: SUCCESS (11.050s)
[598.386911] Subtest modeset-transition-nonblocking-fencing: SUCCESS (11.053s)
[599.247159] [058/133] (419s left) syncobj_basic (bad-destroy)
[599.315778] Starting subtest: bad-destroy
[599.318192] Subtest bad-destroy: SUCCESS (0.000s)
[599.423375] [059/133] (419s left) kms_psr (fbc-psr-primary-mmap-cpu)
[599.510136] Starting subtest: fbc-psr-primary-mmap-cpu
[599.512371] Starting dynamic subtest: eDP-1
[599.516819] Dynamic subtest eDP-1: SKIP (0.000s)
[599.521202] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[599.579563] [060/133] (419s left) kms_draw_crc (draw-method-render)
[599.666234] Starting subtest: draw-method-render
[599.668467] Starting dynamic subtest: xrgb8888-untiled
[599.943720] Dynamic subtest xrgb8888-untiled: SUCCESS (0.278s)
[599.955190] Starting dynamic subtest: rgb565-untiled
[600.199553] Dynamic subtest rgb565-untiled: SUCCESS (0.255s)
[600.208112] Starting dynamic subtest: xrgb2101010-untiled
[600.431936] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.232s)
[600.440950] Starting dynamic subtest: xbgr16161616f-untiled
[600.676268] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.243s)
[600.685298] Starting dynamic subtest: xrgb8888-xtiled
[600.809609] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.132s)
[600.820563] Starting dynamic subtest: rgb565-xtiled
[600.920693] Dynamic subtest rgb565-xtiled: SUCCESS (0.109s)
[600.929180] Starting dynamic subtest: xrgb2101010-xtiled
[601.031773] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s)
[601.042737] Starting dynamic subtest: xbgr16161616f-xtiled
[601.165330] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.131s)
[601.174136] Starting dynamic subtest: xrgb8888-4tiled
[601.287465] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.122s)
[601.298818] Starting dynamic subtest: rgb565-4tiled
[601.398376] Dynamic subtest rgb565-4tiled: SUCCESS (0.110s)
[601.408547] Starting dynamic subtest: xrgb2101010-4tiled
[601.520549] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.121s)
[601.529095] Starting dynamic subtest: xbgr16161616f-4tiled
[601.654495] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s)
[601.656527] Subtest draw-method-render: SUCCESS (1.989s)
[601.769679] [061/133] (417s left) kms_flip (2x-flip-vs-modeset)
[601.836941] Starting subtest: 2x-flip-vs-modeset
[601.843702] Subtest 2x-flip-vs-modeset: SKIP (0.008s)
[601.920834] [062/133] (417s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[601.969247] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[602.076868] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.106s)
[602.153784] [063/133] (417s left) kms_sequence (get-forked-busy)
[602.222530] Starting subtest: get-forked-busy
[602.224673] Starting dynamic subtest: pipe-A-eDP-1
[604.150903] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.929s)
[604.160176] Starting dynamic subtest: pipe-B-eDP-1
[606.733051] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.580s)
[606.742777] Starting dynamic subtest: pipe-C-eDP-1
[609.351275] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.617s)
[609.360697] Starting dynamic subtest: pipe-D-eDP-1
[611.912507] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.559s)
[611.914802] Subtest get-forked-busy: SUCCESS (9.689s)
[612.775364] [064/133] (406s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[612.836637] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[612.907514] [065/133] (406s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[613.003191] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[613.005344] Starting dynamic subtest: pipe-A-eDP-1
[613.026944] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[613.036130] Starting dynamic subtest: pipe-B-eDP-1
[613.056866] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[613.064522] Starting dynamic subtest: pipe-C-eDP-1
[613.085118] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[613.092613] Starting dynamic subtest: pipe-D-eDP-1
[613.113533] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[613.117706] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s)
[615.248542] [066/133] (404s left) kms_lease (lease-invalid-crtc)
[615.321019] Starting subtest: lease-invalid-crtc
[615.323237] Starting dynamic subtest: pipe-A-eDP-1
[615.325349] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[615.334496] Starting dynamic subtest: pipe-B-eDP-1
[615.336576] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[615.344689] Starting dynamic subtest: pipe-C-eDP-1
[615.346538] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[615.354719] Starting dynamic subtest: pipe-D-eDP-1
[615.356845] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[615.358982] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[615.394725] [067/133] (403s left) gem_exec_await (wide-contexts)
[615.615506] Starting subtest: wide-contexts
[638.887956] Subtest wide-contexts: SUCCESS (23.272s)
[639.090877] [068/133] (380s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[639.206247] Starting subtest: fbc-psr2-primary-mmap-gtt
[639.208587] Starting dynamic subtest: eDP-1
[639.212721] Dynamic subtest eDP-1: SKIP (0.000s)
[639.216900] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s)
[639.283510] [069/133] (380s left) gem_tiled_pread_pwrite
[639.405193] [070/133] (380s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[639.490065] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[639.494205] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[639.583426] [071/133] (379s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[639.959349] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[640.762949] [072/133] (378s left) perf (invalid-oa-metric-set-id)
[640.871804] Starting subtest: invalid-oa-metric-set-id
[640.883752] Subtest invalid-oa-metric-set-id: SUCCESS (0.014s)
[640.928543] [073/133] (378s left) i915_drm_fdinfo (busy)
[640.971302] Starting subtest: busy
[640.973499] Starting dynamic subtest: rcs0
[641.007987] Dynamic subtest rcs0: SKIP (0.038s)
[641.018630] Starting dynamic subtest: bcs0
[641.022764] Dynamic subtest bcs0: SKIP (0.000s)
[641.031557] Starting dynamic subtest: vcs0
[641.035559] Dynamic subtest vcs0: SKIP (0.000s)
[641.044232] Starting dynamic subtest: vcs1
[641.048344] Dynamic subtest vcs1: SKIP (0.000s)
[641.056847] Starting dynamic subtest: vecs0
[641.061107] Dynamic subtest vecs0: SKIP (0.000s)
[641.069551] Starting dynamic subtest: ccs0
[641.073694] Dynamic subtest ccs0: SKIP (0.000s)
[641.077902] Subtest busy: SKIP (0.044s)
[641.113454] [074/133] (378s left) gem_exec_flush (basic-wb-pro-default)
[641.190089] Starting subtest: basic-wb-pro-default
[646.650728] Subtest basic-wb-pro-default: SUCCESS (5.460s)
[646.850602] [075/133] (372s left) perf_pmu (semaphore-busy)
[646.895802] Starting subtest: semaphore-busy
[646.898210] Starting dynamic subtest: rcs0
[648.553037] Dynamic subtest rcs0: SUCCESS (1.654s)
[648.567667] Starting dynamic subtest: bcs0
[650.191915] Dynamic subtest bcs0: SUCCESS (1.636s)
[650.203575] Starting dynamic subtest: vcs0
[654.356482] Dynamic subtest vcs0: SUCCESS (4.162s)
[654.369198] Starting dynamic subtest: vcs1
[660.372381] Dynamic subtest vcs1: SUCCESS (6.013s)
[660.384691] Starting dynamic subtest: vecs0
[666.324157] Dynamic subtest vecs0: SUCCESS (5.949s)
[666.336492] Starting dynamic subtest: ccs0
[669.464591] Dynamic subtest ccs0: SUCCESS (3.138s)
[669.467382] Subtest semaphore-busy: SUCCESS (22.567s)
[669.599420] [076/133] (350s left) gem_userptr_blits (usage-restrictions)
[669.664895] Starting subtest: usage-restrictions
[669.667387] Subtest usage-restrictions: SUCCESS (0.000s)
[669.779641] [077/133] (350s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[669.859839] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[676.989846] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.132s)
[677.140890] [078/133] (342s left) kms_addfb_basic (bad-pitch-128)
[677.196588] Starting subtest: bad-pitch-128
[677.199087] Subtest bad-pitch-128: SUCCESS (0.000s)
[677.337980] [079/133] (342s left) intel_hwmon (hwmon-read)
[677.400292] Subtest hwmon-read: SKIP (0.000s)
[677.463476] [080/133] (342s left) device_reset (unbind-reset-rebind)
[677.513585] Starting subtest: unbind-reset-rebind
[682.083389] Subtest unbind-reset-rebind: SUCCESS (4.565s)
[682.126362] [081/133] (337s left) fbdev (nullptr)
[682.167967] Starting subtest: nullptr
[682.170229] Subtest nullptr: SUCCESS (0.000s)
[682.227264] [082/133] (337s left) kms_pm_backlight (fade-with-dpms)
[682.301050] Starting subtest: fade-with-dpms
[684.507284] Starting dynamic subtest: eDP-1
[686.994317] Dynamic subtest eDP-1: SUCCESS (2.487s)
[686.996688] Subtest fade-with-dpms: SUCCESS (4.692s)
[687.790763] [083/133] (332s left) syncobj_timeline (etime-single-wait-submitted)
[687.847254] Starting subtest: etime-single-wait-submitted
[687.947782] Subtest etime-single-wait-submitted: SUCCESS (0.101s)
[688.025174] [084/133] (332s left) api_intel_bb (render)
[688.081170] Starting subtest: render
[688.083425] Starting dynamic subtest: render-none-512
[688.192645] Dynamic subtest render-none-512: SUCCESS (0.111s)
[688.204997] Starting dynamic subtest: render-none-1024
[688.557322] Dynamic subtest render-none-1024: SUCCESS (0.364s)
[688.570206] Starting dynamic subtest: render-x-512
[688.655761] Dynamic subtest render-x-512: SUCCESS (0.098s)
[688.667429] Starting dynamic subtest: render-x-1024
[688.986103] Dynamic subtest render-x-1024: SUCCESS (0.328s)
[688.997264] Starting dynamic subtest: render-y-512
[689.081736] Dynamic subtest render-y-512: SUCCESS (0.096s)
[689.093469] Starting dynamic subtest: render-y-1024
[689.512583] Dynamic subtest render-y-1024: SUCCESS (0.429s)
[689.515266] Subtest render: SUCCESS (1.432s)
[689.605996] [085/133] (330s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[689.680504] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[689.684798] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[689.773395] [086/133] (330s left) gem_render_copy (yf-tiled)
[689.829019] Starting subtest: yf-tiled
[689.833346] Subtest yf-tiled: SKIP (0.000s)
[690.011923] [087/133] (330s left) gem_exec_balancer (full-late-pulse)
[690.060325] Starting subtest: full-late-pulse
[694.916809] Subtest full-late-pulse: SUCCESS (4.856s)
[695.225769] [088/133] (325s left) gem_exec_schedule (pi-distinct-iova)
[695.404751] Starting subtest: pi-distinct-iova
[695.407171] Starting dynamic subtest: rcs0
[695.530998] Dynamic subtest rcs0: SUCCESS (0.128s)
[695.541842] Starting dynamic subtest: vcs0
[695.613771] Dynamic subtest vcs0: SUCCESS (0.083s)
[695.627539] Starting dynamic subtest: vcs1
[695.694055] Dynamic subtest vcs1: SUCCESS (0.079s)
[695.707570] Starting dynamic subtest: vecs0
[695.773877] Dynamic subtest vecs0: SUCCESS (0.079s)
[695.784917] Starting dynamic subtest: ccs0
[695.901259] Dynamic subtest ccs0: SUCCESS (0.126s)
[695.903669] Subtest pi-distinct-iova: SUCCESS (0.500s)
[696.942552] [089/133] (323s left) kms_psr (pr-cursor-mmap-cpu)
[697.015534] Starting subtest: pr-cursor-mmap-cpu
[697.020094] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[697.087526] [090/133] (323s left) gem_request_retire (retire-vma-not-inactive)
[697.141397] Starting subtest: retire-vma-not-inactive
[697.203942] Subtest retire-vma-not-inactive: SUCCESS (0.058s)
[697.323882] [091/133] (323s left) gem_ctx_create (basic-files)
[697.376826] Starting subtest: basic-files
[699.386159] Subtest basic-files: SUCCESS (2.009s)
[700.869771] [092/133] (319s left) kms_flip (2x-blocking-wf_vblank)
[700.954284] Starting subtest: 2x-blocking-wf_vblank
[700.962044] Subtest 2x-blocking-wf_vblank: SKIP (0.008s)
[701.054581] [093/133] (319s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[701.131424] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[701.133608] Starting dynamic subtest: pipe-A-default-mode
[702.249615] Dynamic subtest pipe-A-default-mode: SKIP (1.114s)
[702.254084] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.115s)
[702.381228] [094/133] (318s left) gem_ctx_persistence (engines-hostile)
[702.447732] Starting subtest: engines-hostile
[702.450209] Starting dynamic subtest: rcs0
[702.573958] Dynamic subtest rcs0: SUCCESS (0.125s)
[702.586941] Starting dynamic subtest: bcs0
[702.669587] Dynamic subtest bcs0: SUCCESS (0.094s)
[702.681830] Starting dynamic subtest: vcs0
[702.761752] Dynamic subtest vcs0: SUCCESS (0.090s)
[702.773466] Starting dynamic subtest: vcs1
[702.854768] Dynamic subtest vcs1: SUCCESS (0.091s)
[702.867426] Starting dynamic subtest: vecs0
[702.943861] Dynamic subtest vecs0: SUCCESS (0.087s)
[702.956264] Starting dynamic subtest: ccs0
[703.053901] Dynamic subtest ccs0: SUCCESS (0.108s)
[703.056523] Subtest engines-hostile: SUCCESS (0.607s)
[703.133992] [095/133] (317s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[703.211566] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[703.215371] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[703.323182] [096/133] (317s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[703.406766] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[703.410515] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[703.498782] [097/133] (317s left) gem_lmem_swapping (parallel-random)
[703.542474] Subtest parallel-random: SKIP (0.000s)
[703.589186] [098/133] (317s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[703.670739] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[708.198686] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.533s)
[709.319764] [099/133] (311s left) perf_pmu (init-wait)
[709.376012] Starting subtest: init-wait
[709.378331] Starting dynamic subtest: rcs0
[709.380712] Dynamic subtest rcs0: SUCCESS (0.001s)
[709.392780] Starting dynamic subtest: bcs0
[709.394906] Dynamic subtest bcs0: SUCCESS (0.000s)
[709.404108] Starting dynamic subtest: vcs0
[709.406245] Dynamic subtest vcs0: SUCCESS (0.001s)
[709.415253] Starting dynamic subtest: vcs1
[709.417386] Dynamic subtest vcs1: SUCCESS (0.001s)
[709.426636] Starting dynamic subtest: vecs0
[709.428560] Dynamic subtest vecs0: SUCCESS (0.001s)
[709.437646] Starting dynamic subtest: ccs0
[709.439878] Dynamic subtest ccs0: SUCCESS (0.001s)
[709.442144] Subtest init-wait: SUCCESS (0.008s)
[709.482944] [100/133] (311s left) vgem_basic (dmabuf-fence)
[709.533023] Starting subtest: dmabuf-fence
[709.535389] Subtest dmabuf-fence: SUCCESS (0.000s)
[709.589979] [101/133] (311s left) gem_fence_thrash (bo-copy)
[709.627084] Starting subtest: bo-copy
[709.640619] Subtest bo-copy: SKIP (0.013s)
[709.704765] [102/133] (311s left) kms_psr (psr2-cursor-plane-move)
[709.769616] Starting subtest: psr2-cursor-plane-move
[709.772649] Starting dynamic subtest: eDP-1
[711.495547] Dynamic subtest eDP-1: SUCCESS (1.726s)
[711.497981] Subtest psr2-cursor-plane-move: SUCCESS (1.727s)
[712.289622] [103/133] (308s left) kms_vblank (ts-continuation-dpms-suspend)
[712.372066] Starting subtest: ts-continuation-dpms-suspend
[712.374312] Starting dynamic subtest: pipe-A-eDP-1
[729.334548] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.079s)
[729.352119] Starting dynamic subtest: pipe-D-eDP-1
[747.314511] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.515s)
[747.316915] Subtest ts-continuation-dpms-suspend: SUCCESS (4.598s)
[748.119799] [104/133] (272s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[748.216279] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[748.243229] Starting dynamic subtest: pipe-A-plane-0
[748.531975] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[748.542692] Starting dynamic subtest: pipe-A-plane-3
[748.765447] Dynamic subtest pipe-A-plane-3: SUCCESS (0.231s)
[749.903032] Starting dynamic subtest: pipe-B-plane-0
[750.205303] Dynamic subtest pipe-B-plane-0: SUCCESS (0.311s)
[750.216233] Starting dynamic subtest: pipe-B-plane-3
[750.439048] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[750.749997] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.530s)
[751.579039] [105/133] (269s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[751.667036] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[751.671273] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[751.750211] [106/133] (269s left) gen9_exec_parse (bb-oversize)
[751.816365] Subtest bb-oversize: SKIP (0.000s)
[751.882337] [107/133] (269s left) gem_mmap_gtt (basic-write-gtt)
[751.941687] Subtest basic-write-gtt: SKIP (0.000s)
[752.004186] [108/133] (269s left) kms_panel_fitting (legacy)
[752.082182] Starting subtest: legacy
[752.084561] Starting dynamic subtest: pipe-A-eDP-1
[752.628100] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.548s)
[752.657682] Starting dynamic subtest: pipe-B-eDP-1
[754.246228] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.595s)
[754.273985] Starting dynamic subtest: pipe-C-eDP-1
[755.859293] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.592s)
[755.886562] Starting dynamic subtest: pipe-D-eDP-1
[757.369401] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.489s)
[757.371960] Subtest legacy: SUCCESS (5.285s)
[758.577575] [109/133] (262s left) syncobj_timeline (wait-delayed-signal)
[758.632067] Starting subtest: wait-delayed-signal
[758.732820] Subtest wait-delayed-signal: SUCCESS (0.102s)
[758.815655] [110/133] (262s left) perf_pmu (busy-accuracy-2)
[758.858952] Starting subtest: busy-accuracy-2
[758.861391] Starting dynamic subtest: rcs0
[761.903188] Dynamic subtest rcs0: SUCCESS (3.040s)
[761.916316] Starting dynamic subtest: bcs0
[764.959350] Dynamic subtest bcs0: SUCCESS (3.053s)
[764.971885] Starting dynamic subtest: vcs0
[768.005089] Dynamic subtest vcs0: SUCCESS (3.042s)
[768.017030] Starting dynamic subtest: vcs1
[771.054554] Dynamic subtest vcs1: SUCCESS (3.046s)
[771.067089] Starting dynamic subtest: vecs0
[774.100364] Dynamic subtest vecs0: SUCCESS (3.043s)
[774.111584] Starting dynamic subtest: ccs0
[777.157064] Dynamic subtest ccs0: SUCCESS (3.053s)
[777.159715] Subtest busy-accuracy-2: SUCCESS (18.292s)
[777.293347] [111/133] (243s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[777.377183] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[777.379590] Starting dynamic subtest: pipe-A-eDP-1
[778.584782] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.208s)
[778.596247] Starting dynamic subtest: pipe-B-eDP-1
[780.867343] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.281s)
[780.878101] Starting dynamic subtest: pipe-C-eDP-1
[783.113255] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.245s)
[783.124130] Starting dynamic subtest: pipe-D-eDP-1
[785.328742] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.214s)
[785.330941] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (7.953s)
[786.515067] [112/133] (234s left) gem_ctx_persistence (heartbeat-close)
[786.576903] Starting subtest: heartbeat-close
[786.581806] Subtest heartbeat-close: SKIP (0.000s)
[786.676342] [113/133] (234s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[786.764114] Starting subtest: x-tiled-64bpp-rotate-180
[788.231955] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.468s)
[788.399344] [114/133] (232s left) gem_ctx_param (invalid-ctx-get)
[788.458980] Starting subtest: invalid-ctx-get
[788.461461] Subtest invalid-ctx-get: SUCCESS (0.000s)
[788.534446] [115/133] (232s left) kms_cursor_crc (cursor-random-32x32)
[788.671254] Starting subtest: cursor-random-32x32
[788.724305] Subtest cursor-random-32x32: SKIP (0.048s)
[789.002422] [116/133] (232s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[789.102466] Starting subtest: basic-flip-before-cursor-varying-size
[790.031423] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.927s)
[790.830854] [117/133] (230s left) gem_userptr_blits (relocations)
[790.906548] Starting subtest: relocations
[790.910791] Subtest relocations: SKIP (0.000s)
[791.023878] [118/133] (230s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[791.109788] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[792.099364] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (0.990s)
[792.223214] [119/133] (229s left) gem_spin_batch (user-each)
[792.284254] Starting subtest: user-each
[795.555793] Subtest user-each: SUCCESS (3.264s)
[797.265915] [120/133] (224s left) kms_cursor_edge_walk (256x256-top-edge)
[797.348769] Starting subtest: 256x256-top-edge
[797.351195] Starting dynamic subtest: pipe-A-eDP-1
[800.805652] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.455s)
[800.817306] Starting dynamic subtest: pipe-D-eDP-1
[803.935608] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.127s)
[803.937813] Subtest 256x256-top-edge: SUCCESS (6.585s)
[804.731387] [121/133] (216s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[804.828700] Starting subtest: 4-tiled-32bpp-rotate-180
[806.184055] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.354s)
[806.292703] [122/133] (215s left) gem_mmap_offset (clear-via-pagefault)
[806.356461] Starting subtest: clear-via-pagefault
[806.358803] Starting dynamic subtest: smem0
[832.878213] Dynamic subtest smem0: SUCCESS (26.512s)
[832.880316] Subtest clear-via-pagefault: SUCCESS (26.513s)
[832.986765] [123/133] (188s left) gem_userptr_blits (invalid-null-pointer)
[833.053838] Starting subtest: invalid-null-pointer
[833.055992] Subtest invalid-null-pointer: SUCCESS (0.001s)
[833.175289] [124/133] (188s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[833.254878] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[833.259099] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[833.356114] [125/133] (188s left) gem_ctx_shared (detached-shared-gtt)
[833.407479] Starting subtest: detached-shared-gtt
[835.561153] Subtest detached-shared-gtt: SUCCESS (2.152s)
[835.959962] [126/133] (185s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[836.056804] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[836.990831] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.934s)
[837.127567] [127/133] (184s left) kms_psr (fbc-pr-no-drrs)
[837.200328] Starting subtest: fbc-pr-no-drrs
[837.204880] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[837.273324] [128/133] (184s left) gem_create (create-ext-placement-sanity-check)
[837.436024] Starting subtest: create-ext-placement-sanity-check
[837.438705] Subtest create-ext-placement-sanity-check: SUCCESS (0.004s)
[837.524694] [129/133] (184s left) kms_properties (colorop-properties-legacy)
[837.596769] Starting subtest: colorop-properties-legacy
[837.599270] Starting dynamic subtest: pipe-A-eDP-1
[837.955266] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.357s)
[837.967195] Starting dynamic subtest: pipe-B-eDP-1
[839.030419] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.075s)
[839.042491] Starting dynamic subtest: pipe-C-eDP-1
[840.122615] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.091s)
[840.133705] Starting dynamic subtest: pipe-D-eDP-1
[841.144181] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.019s)
[841.146868] Subtest colorop-properties-legacy: SUCCESS (3.548s)
[841.950556] [130/133] (180s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[842.035627] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[846.514765] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.484s)
[847.637192] [131/133] (174s left) gem_ppgtt (shrink-vs-evict-pinned)
[847.705597] Starting subtest: shrink-vs-evict-pinned
[853.181032] Subtest shrink-vs-evict-pinned: SUCCESS (5.474s)
[853.275017] [132/133] (168s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[853.358951] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[853.363155] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[853.463522] [133/133] (168s left) kms_plane (plane-panning-bottom-right-suspend)
[853.550164] Starting subtest: plane-panning-bottom-right-suspend
[853.552469] Starting dynamic subtest: pipe-A
[871.141487] Dynamic subtest pipe-A: SUCCESS (2.935s)
[871.153937] Starting dynamic subtest: pipe-B
[890.156960] Dynamic subtest pipe-B: SUCCESS (3.525s)
[890.159554] Subtest plane-panning-bottom-right-suspend: SUCCESS (6.463s)
[890.960623] Closing watchdogs
results: parsing output: 0/ for test: syncobj_timeline
results: parsing output: 1/ for test: gem_exec_balancer
results: parsing output: 2/ for test: api_intel_allocator
results: parsing output: 3/ for test: i915_selftest
results: parsing output: 4/ for test: kms_rotation_crc
results: parsing output: 5/ for test: gem_userptr_blits
results: parsing output: 6/ for test: sw_sync
results: parsing output: 7/ for test: kms_ccs
results: parsing output: 8/ for test: gem_exec_schedule
results: parsing output: 9/ for test: gem_exec_reloc
results: parsing output: 10/ for test: kms_cursor_legacy
results: parsing output: 11/ for test: kms_flip_scaled_crc
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: i915_pm_rpm
results: parsing output: 14/ for test: kms_dirtyfb
results: parsing output: 15/ for test: kms_hdr
results: parsing output: 16/ for test: kms_content_protection
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_exec_fence
results: parsing output: 20/ for test: gem_userptr_blits
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: gem_exec_nop
results: parsing output: 23/ for test: kms_psr2_sf
results: parsing output: 24/ for test: gem_partial_pwrite_pread
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_flip
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_pm_rpm
results: parsing output: 29/ for test: perf
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: kms_getfb
results: parsing output: 32/ for test: gem_exec_reloc
results: parsing output: 33/ for test: gem_exec_fence
results: parsing output: 34/ for test: kms_getfb
results: parsing output: 35/ for test: kms_cursor_crc
results: parsing output: 36/ for test: kms_plane_alpha_blend
results: parsing output: 37/ for test: gem_exec_schedule
results: parsing output: 38/ for test: kms_color_pipeline
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_hdmi_inject
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: gem_render_copy
results: parsing output: 43/ for test: kms_plane_scaling
results: parsing output: 44/ for test: kms_ccs
results: parsing output: 45/ for test: kms_flip_scaled_crc
results: parsing output: 46/ for test: i915_hangman
results: parsing output: 47/ for test: kms_chamelium_edid
results: parsing output: 48/ for test: kms_properties
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_mmap_gtt
results: parsing output: 51/ for test: kms_plane_cursor
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: gem_mmap_gtt
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: gem_vm_create
results: parsing output: 56/ for test: kms_atomic_transition
results: parsing output: 57/ for test: syncobj_basic
results: parsing output: 58/ for test: kms_psr
results: parsing output: 59/ for test: kms_draw_crc
results: parsing output: 60/ for test: kms_flip
results: parsing output: 61/ for test: syncobj_timeline
results: parsing output: 62/ for test: kms_sequence
results: parsing output: 63/ for test: gem_exec_reloc
results: parsing output: 64/ for test: kms_ccs
results: parsing output: 65/ for test: kms_lease
results: parsing output: 66/ for test: gem_exec_await
results: parsing output: 67/ for test: kms_psr
results: parsing output: 68/ for test: gem_tiled_pread_pwrite
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_chamelium_hpd
results: parsing output: 71/ for test: perf
results: parsing output: 72/ for test: i915_drm_fdinfo
results: parsing output: 73/ for test: gem_exec_flush
results: parsing output: 74/ for test: perf_pmu
results: parsing output: 75/ for test: gem_userptr_blits
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_addfb_basic
results: parsing output: 78/ for test: intel_hwmon
results: parsing output: 79/ for test: device_reset
results: parsing output: 80/ for test: fbdev
results: parsing output: 81/ for test: kms_pm_backlight
results: parsing output: 82/ for test: syncobj_timeline
results: parsing output: 83/ for test: api_intel_bb
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: gem_render_copy
results: parsing output: 86/ for test: gem_exec_balancer
results: parsing output: 87/ for test: gem_exec_schedule
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: gem_request_retire
results: parsing output: 90/ for test: gem_ctx_create
results: parsing output: 91/ for test: kms_flip
results: parsing output: 92/ for test: kms_flip_scaled_crc
results: parsing output: 93/ for test: gem_ctx_persistence
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_lmem_swapping
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: perf_pmu
results: parsing output: 99/ for test: vgem_basic
results: parsing output: 100/ for test: gem_fence_thrash
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: kms_vblank
results: parsing output: 103/ for test: kms_plane
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: gen9_exec_parse
results: parsing output: 106/ for test: gem_mmap_gtt
results: parsing output: 107/ for test: kms_panel_fitting
results: parsing output: 108/ for test: syncobj_timeline
results: parsing output: 109/ for test: perf_pmu
results: parsing output: 110/ for test: kms_ccs
results: parsing output: 111/ for test: gem_ctx_persistence
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: gem_ctx_param
results: parsing output: 114/ for test: kms_cursor_crc
results: parsing output: 115/ for test: kms_cursor_legacy
results: parsing output: 116/ for test: gem_userptr_blits
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: gem_spin_batch
results: parsing output: 119/ for test: kms_cursor_edge_walk
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: gem_mmap_offset
results: parsing output: 122/ for test: gem_userptr_blits
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_ctx_shared
results: parsing output: 125/ for test: kms_big_fb
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: gem_create
results: parsing output: 128/ for test: kms_properties
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: gem_ppgtt
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_plane
Done.