[56.525345] Initializing watchdogs
[56.525405]   /dev/watchdog0
[56.539530] [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]
[56.543866] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.546072] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.549197] [001/133] (960s left) syncobj_timeline (invalid-transfer-bad-pad)
[56.618715] Starting subtest: invalid-transfer-bad-pad
[56.621017] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[56.731636] [002/133] (960s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[56.991038] Starting subtest: parallel-dmabuf-import-out-fence
[58.077024] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.096s)
[58.179908] [003/133] (958s left) api_intel_allocator (reloc-allocator)
[58.236903] Starting subtest: reloc-allocator
[58.239457] Starting dynamic subtest: basic
[58.242259] Dynamic subtest basic: SUCCESS (0.006s)
[58.251218] Starting dynamic subtest: parallel-one
[58.253334] Dynamic subtest parallel-one: SUCCESS (0.007s)
[58.260214] Starting dynamic subtest: print
[58.262471] Dynamic subtest print: SUCCESS (0.000s)
[58.269746] Starting dynamic subtest: reuse
[58.271687] Dynamic subtest reuse: SUCCESS (0.000s)
[58.278086] Starting dynamic subtest: fork-reopen-allocator
[58.280101] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s)
[58.281984] Subtest reloc-allocator: SUCCESS (0.026s)
[58.389186] [004/133] (958s left) i915_selftest (live)
[61.644806] Starting subtest: live
[61.647268] Starting dynamic subtest: sanitycheck
[64.315051] Dynamic subtest sanitycheck: SUCCESS (2.683s)
[64.325419] Starting dynamic subtest: uncore
[68.019448] Dynamic subtest uncore: SUCCESS (3.714s)
[68.028211] Starting dynamic subtest: workarounds
[71.081816] Dynamic subtest workarounds: SUCCESS (3.068s)
[71.090388] Starting dynamic subtest: gt_engines
[75.583269] Dynamic subtest gt_engines: SUCCESS (4.506s)
[75.591790] Starting dynamic subtest: gt_timelines
[91.730436] Dynamic subtest gt_timelines: SUCCESS (16.145s)
[91.739556] Starting dynamic subtest: gt_contexts
[96.032475] Dynamic subtest gt_contexts: SUCCESS (4.300s)
[96.043605] Starting dynamic subtest: gt_lrc
[100.355945] Dynamic subtest gt_lrc: SUCCESS (4.322s)
[100.364642] Starting dynamic subtest: gt_mocs
[103.240105] Dynamic subtest gt_mocs: SUCCESS (2.883s)
[103.252923] Starting dynamic subtest: gt_pm
[110.033075] Dynamic subtest gt_pm: SUCCESS (6.792s)
[110.041385] Starting dynamic subtest: gt_heartbeat
[114.382757] Dynamic subtest gt_heartbeat: SUCCESS (4.349s)
[114.390394] Starting dynamic subtest: gt_tlb
[123.683052] Dynamic subtest gt_tlb: SUCCESS (9.298s)
[123.695934] Starting dynamic subtest: requests
[135.268165] Dynamic subtest requests: SUCCESS (11.584s)
[135.279344] Starting dynamic subtest: migrate
[141.111329] Dynamic subtest migrate: SUCCESS (5.842s)
[141.120087] Starting dynamic subtest: active
[145.414218] Dynamic subtest active: SUCCESS (4.302s)
[145.422933] Starting dynamic subtest: objects
[150.036047] Dynamic subtest objects: SUCCESS (4.620s)
[150.044473] Starting dynamic subtest: mman
[154.852891] Dynamic subtest mman: SUCCESS (4.816s)
[154.860592] Starting dynamic subtest: dmabuf
[157.573441] Dynamic subtest dmabuf: SUCCESS (2.719s)
[157.582556] Starting dynamic subtest: vma
[161.881070] Dynamic subtest vma: SUCCESS (4.306s)
[161.888947] Starting dynamic subtest: coherency
[166.797051] Dynamic subtest coherency: SUCCESS (4.914s)
[166.805571] Starting dynamic subtest: gtt
[176.742993] Dynamic subtest gtt: SUCCESS (9.945s)
[176.753771] Starting dynamic subtest: gem
[184.627667] Dynamic subtest gem: SUCCESS (7.882s)
[184.636446] Starting dynamic subtest: evict
[190.138228] Dynamic subtest evict: SUCCESS (5.510s)
[190.147297] Starting dynamic subtest: hugepages
[198.877068] Dynamic subtest hugepages: SUCCESS (8.737s)
[198.885792] Starting dynamic subtest: gem_contexts
[227.536318] Dynamic subtest gem_contexts: SUCCESS (28.657s)
[227.545149] Starting dynamic subtest: client
[231.889265] Dynamic subtest client: SUCCESS (4.352s)
[231.897928] Starting dynamic subtest: gem_migrate
[236.294302] Dynamic subtest gem_migrate: SUCCESS (4.404s)
[236.308270] Starting dynamic subtest: reset
[240.645340] Dynamic subtest reset: SUCCESS (4.349s)
[240.654536] Starting dynamic subtest: memory_region
[244.984786] Dynamic subtest memory_region: SUCCESS (4.337s)
[244.994634] Starting dynamic subtest: hangcheck
[257.815951] Dynamic subtest hangcheck: SUCCESS (12.830s)
[257.824633] Starting dynamic subtest: execlists
[262.124521] Dynamic subtest execlists: SUCCESS (4.307s)
[262.133724] Starting dynamic subtest: ring_submission
[266.437356] Dynamic subtest ring_submission: SUCCESS (4.312s)
[266.445806] Starting dynamic subtest: perf
[270.783288] Dynamic subtest perf: SUCCESS (4.343s)
[270.792347] Starting dynamic subtest: slpc
[282.854052] Dynamic subtest slpc: SUCCESS (12.069s)
[282.862817] Starting dynamic subtest: guc
[286.770907] Dynamic subtest guc: SUCCESS (3.916s)
[286.779068] Starting dynamic subtest: guc_multi_lrc
[291.052993] Dynamic subtest guc_multi_lrc: SUCCESS (4.279s)
[291.061304] Starting dynamic subtest: guc_hang
[295.938476] Dynamic subtest guc_hang: SUCCESS (4.885s)
[295.947130] Starting dynamic subtest: late_gt_pm
[298.663452] Dynamic subtest late_gt_pm: SUCCESS (2.723s)
[298.666195] Subtest live: SUCCESS (237.042s)
[298.692890] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[298.696116] [005/133] (718s left) kms_rotation_crc (multiplane-rotation)
[300.261060] Starting subtest: multiplane-rotation
[317.718942] Subtest multiplane-rotation: SUCCESS (17.461s)
[317.816435] [FACT kms_rotation_crc (multiplane-rotation)] new: kernel.kmod_is_loaded.i915: true
[317.820669] [006/133] (699s left) gem_userptr_blits (create-destroy-sync)
[317.891157] Starting subtest: create-destroy-sync
[322.959711] Subtest create-destroy-sync: SUCCESS (5.014s)
[323.051739] [007/133] (694s left) sw_sync (sync_merge)
[323.092059] Starting subtest: sync_merge
[323.094532] Subtest sync_merge: SUCCESS (0.000s)
[323.152772] [008/133] (694s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[323.263211] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[323.265400] Starting dynamic subtest: pipe-A-eDP-1
[323.285298] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[323.294237] Starting dynamic subtest: pipe-B-eDP-1
[323.313113] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[323.320436] Starting dynamic subtest: pipe-C-eDP-1
[323.340553] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[323.348336] Starting dynamic subtest: pipe-D-eDP-1
[323.368128] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[323.370292] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[325.564273] [009/133] (691s left) gem_exec_schedule (u-submit-golden-slice)
[325.627470] Starting subtest: u-submit-golden-slice
[325.629857] Starting dynamic subtest: rcs0
[325.655192] Dynamic subtest rcs0: SUCCESS (0.035s)
[325.662862] Starting dynamic subtest: bcs0
[325.682611] Dynamic subtest bcs0: SUCCESS (0.027s)
[325.690592] Starting dynamic subtest: vcs0
[325.716573] Dynamic subtest vcs0: SUCCESS (0.033s)
[325.725787] Starting dynamic subtest: vcs1
[325.749864] Dynamic subtest vcs1: SUCCESS (0.032s)
[325.757468] Starting dynamic subtest: vecs0
[325.777971] Dynamic subtest vecs0: SUCCESS (0.027s)
[325.789958] Starting dynamic subtest: ccs0
[325.817435] Dynamic subtest ccs0: SUCCESS (0.038s)
[325.819785] Subtest u-submit-golden-slice: SUCCESS (0.198s)
[327.025223] [010/133] (690s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[327.082336] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[327.160731] [011/133] (690s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[327.267525] Starting subtest: basic-flip-before-cursor-atomic
[328.223588] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.955s)
[329.081899] [012/133] (688s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[329.173109] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[329.177197] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[329.243105] [013/133] (688s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[329.301048] Starting subtest: single-wait-all-for-submit-available-signaled
[329.303283] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[329.415884] [014/133] (688s left) i915_pm_rpm (gem-execbuf-stress)
[331.042715] Starting subtest: gem-execbuf-stress
[331.045329] Starting dynamic subtest: smem0
[343.957477] Dynamic subtest smem0: SUCCESS (12.917s)
[343.967941] Starting dynamic subtest: extra-wait-smem0
[405.661073] Dynamic subtest extra-wait-smem0: SUCCESS (61.696s)
[405.663810] Subtest gem-execbuf-stress: SUCCESS (74.621s)
[406.040560] [015/133] (611s left) kms_dirtyfb (drrs-dirtyfb-ioctl)
[406.136115] Starting subtest: drrs-dirtyfb-ioctl
[406.149162] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s)
[406.229457] [016/133] (611s left) kms_hdr (static-toggle-suspend)
[406.324458] Starting subtest: static-toggle-suspend
[406.330747] Subtest static-toggle-suspend: SKIP (0.000s)
[406.393886] [017/133] (611s left) kms_content_protection (mei-interface)
[406.532958] Starting subtest: mei-interface
[406.537375] Subtest mei-interface: SKIP (0.001s)
[406.640865] [018/133] (611s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[406.739439] Starting subtest: psr-rgb565-draw-mmap-cpu
[413.539931] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.803s)
[413.649860] [019/133] (604s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[413.764610] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[413.769026] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[413.865472] [020/133] (603s left) gem_exec_fence (submit-chain)
[414.037257] Starting subtest: submit-chain
[414.054567] Subtest submit-chain: SUCCESS (0.018s)
[415.945490] [FACT gem_exec_fence (submit-chain)] new: kernel.kmod_is_loaded.vgem: true
[415.949951] [021/133] (601s left) gem_userptr_blits (readonly-pwrite-unsync)
[416.031546] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[416.172566] [022/133] (601s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[416.267067] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[416.271585] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[417.398327] [023/133] (600s left) gem_exec_nop (basic-sequential)
[417.482328] Starting subtest: basic-sequential
[432.413528] Subtest basic-sequential: SUCCESS (14.913s)
[432.612406] [024/133] (585s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[432.716524] Starting subtest: fbc-psr2-cursor-plane-update-sf
[432.718858] Starting dynamic subtest: pipe-A-eDP-1
[432.790052] Dynamic subtest pipe-A-eDP-1: SKIP (0.078s)
[432.799870] Starting dynamic subtest: pipe-B-eDP-1
[433.882225] Dynamic subtest pipe-B-eDP-1: SKIP (1.090s)
[433.886862] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.170s)
[435.066448] [025/133] (582s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[435.125250] Subtest writes-after-reads-uncached: SKIP (0.000s)
[435.203486] [026/133] (582s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[435.300868] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[435.305274] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[435.394197] [027/133] (582s left) kms_flip (modeset-vs-vblank-race-interruptible)
[435.495533] Starting subtest: modeset-vs-vblank-race-interruptible
[435.497823] Starting dynamic subtest: A-eDP1
[440.202565] Dynamic subtest A-eDP1: SUCCESS (4.705s)
[440.216805] Starting dynamic subtest: B-eDP1
[444.946677] Dynamic subtest B-eDP1: SUCCESS (4.741s)
[444.956215] Starting dynamic subtest: C-eDP1
[449.475063] Dynamic subtest C-eDP1: SUCCESS (4.526s)
[449.483622] Starting dynamic subtest: D-eDP1
[454.087590] Dynamic subtest D-eDP1: SUCCESS (4.612s)
[454.092457] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.597s)
[455.253516] [028/133] (562s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[455.354819] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[462.123197] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.772s)
[462.248197] [029/133] (555s left) kms_pm_rpm (legacy-planes-dpms)
[464.004628] Starting subtest: legacy-planes-dpms
[464.006812] Starting dynamic subtest: plane-65
[472.599344] Dynamic subtest plane-65: SUCCESS (8.597s)
[472.610248] Starting dynamic subtest: plane-95
[480.942677] Dynamic subtest plane-95: SUCCESS (8.340s)
[480.954733] Starting dynamic subtest: plane-125
[489.232496] Dynamic subtest plane-125: SUCCESS (8.287s)
[489.242659] Starting dynamic subtest: plane-135
[497.537632] Dynamic subtest plane-135: SUCCESS (8.302s)
[497.540554] Subtest legacy-planes-dpms: SUCCESS (33.536s)
[497.914208] [030/133] (520s left) perf (sysctl-defaults)
[497.977168] Starting subtest: sysctl-defaults
[497.979657] Subtest sysctl-defaults: SUCCESS (0.000s)
[498.070124] [031/133] (520s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[498.124673] Starting subtest: multi-wait-available-unsubmitted-signaled
[498.127092] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[498.227168] [032/133] (520s left) kms_getfb (getfb-handle-closed)
[498.318904] Starting subtest: getfb-handle-closed
[498.321171] Subtest getfb-handle-closed: SUCCESS (0.000s)
[498.435885] [033/133] (519s left) gem_exec_reloc (basic-gtt-active)
[498.491663] Subtest basic-gtt-active: SKIP (0.000s)
[498.572810] [034/133] (519s left) gem_exec_fence (syncobj-timeline-wait)
[499.113325] Starting subtest: syncobj-timeline-wait
[500.913527] Subtest syncobj-timeline-wait: SUCCESS (1.801s)
[503.008311] [035/133] (515s left) kms_getfb (getfb2-handle-protection)
[503.109706] Starting subtest: getfb2-handle-protection
[503.129226] Subtest getfb2-handle-protection: SUCCESS (0.021s)
[503.238856] [036/133] (515s left) kms_cursor_crc (cursor-onscreen-512x512)
[503.545398] Starting subtest: cursor-onscreen-512x512
[503.549606] Subtest cursor-onscreen-512x512: SKIP (0.002s)
[503.719810] [037/133] (514s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[503.815268] Starting subtest: coverage-vs-premult-vs-constant
[504.115707] Starting dynamic subtest: pipe-A-eDP-1
[504.739691] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.621s)
[504.748491] Starting dynamic subtest: pipe-D-eDP-1
[506.027528] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.288s)
[506.029919] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.214s)
[506.878476] [038/133] (511s left) gem_exec_schedule (preempt-user)
[506.946816] Starting subtest: preempt-user
[506.949165] Starting dynamic subtest: rcs0
[506.962058] Dynamic subtest rcs0: SUCCESS (0.023s)
[506.971349] Starting dynamic subtest: bcs0
[506.987813] Dynamic subtest bcs0: SUCCESS (0.025s)
[506.996662] Starting dynamic subtest: vcs0
[507.012060] Dynamic subtest vcs0: SUCCESS (0.024s)
[507.021712] Starting dynamic subtest: vcs1
[507.036300] Dynamic subtest vcs1: SUCCESS (0.023s)
[507.046611] Starting dynamic subtest: vecs0
[507.062750] Dynamic subtest vecs0: SUCCESS (0.026s)
[507.071405] Starting dynamic subtest: ccs0
[507.090796] Dynamic subtest ccs0: SUCCESS (0.027s)
[507.093104] Subtest preempt-user: SUCCESS (0.153s)
[508.976877] [039/133] (509s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[509.078402] Starting subtest: plane-lut1d-ctm3x4
[509.247015] Starting dynamic subtest: pipe-A-plane-0
[509.402219] Dynamic subtest pipe-A-plane-0: SUCCESS (0.155s)
[509.411325] Starting dynamic subtest: pipe-A-plane-1
[509.558594] Dynamic subtest pipe-A-plane-1: SUCCESS (0.155s)
[509.573294] Starting dynamic subtest: pipe-A-plane-2
[509.758212] Dynamic subtest pipe-A-plane-2: SUCCESS (0.199s)
[510.976346] Starting dynamic subtest: pipe-B-plane-0
[511.170774] Dynamic subtest pipe-B-plane-0: SUCCESS (0.200s)
[511.179691] Starting dynamic subtest: pipe-B-plane-1
[511.303375] Dynamic subtest pipe-B-plane-1: SUCCESS (0.132s)
[511.311799] Starting dynamic subtest: pipe-B-plane-2
[511.469565] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[512.691254] Starting dynamic subtest: pipe-C-plane-0
[512.837200] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s)
[512.845758] Starting dynamic subtest: pipe-C-plane-1
[512.981680] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[512.990924] Starting dynamic subtest: pipe-C-plane-2
[513.126286] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[514.312384] Starting dynamic subtest: pipe-D-plane-0
[514.449987] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[514.458695] Starting dynamic subtest: pipe-D-plane-1
[514.616603] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[514.625589] Starting dynamic subtest: pipe-D-plane-2
[514.783304] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[515.074671] Subtest plane-lut1d-ctm3x4: SUCCESS (5.996s)
[515.894494] [040/133] (502s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[516.001372] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[522.572096] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.573s)
[522.697805] [041/133] (495s left) kms_hdmi_inject (inject-audio)
[523.039575] Starting subtest: inject-audio
[523.320367] Subtest inject-audio: SUCCESS (0.282s)
[523.903293] [042/133] (494s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[524.000585] Starting subtest: y-tiled-16bpp-rotate-270
[524.005054] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[524.098509] [043/133] (494s left) gem_render_copy (y-tiled-to-vebox-linear)
[524.157816] Starting subtest: y-tiled-to-vebox-linear
[524.161728] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[524.337891] [044/133] (494s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[524.430386] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[524.432728] Starting dynamic subtest: pipe-A
[524.493145] Dynamic subtest pipe-A: SUCCESS (0.065s)
[524.502512] Starting dynamic subtest: pipe-B
[525.650178] Dynamic subtest pipe-B: SUCCESS (1.156s)
[525.661209] Starting dynamic subtest: pipe-C
[526.728373] Dynamic subtest pipe-C: SUCCESS (1.078s)
[526.737644] Starting dynamic subtest: pipe-D
[527.829166] Dynamic subtest pipe-D: SUCCESS (1.100s)
[527.831551] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.402s)
[528.972677] [045/133] (489s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[529.067151] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[529.069437] Starting dynamic subtest: pipe-A-eDP-1
[529.600954] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.506s)
[529.611537] Starting dynamic subtest: pipe-B-eDP-1
[531.095938] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.492s)
[531.107425] Starting dynamic subtest: pipe-C-eDP-1
[532.501996] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.407s)
[532.512940] Starting dynamic subtest: pipe-D-eDP-1
[533.943802] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.439s)
[533.945813] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.849s)
[535.076257] [046/133] (483s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[535.171299] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[535.175917] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[535.243075] [047/133] (483s left) i915_hangman (hangcheck-unterminated)
[535.315026] Starting subtest: hangcheck-unterminated
[546.869391] Subtest hangcheck-unterminated: SUCCESS (11.554s)
[546.989543] [048/133] (471s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[547.375415] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[548.148044] [049/133] (470s left) kms_properties (crtc-properties-atomic)
[548.235683] Starting subtest: crtc-properties-atomic
[548.238062] Starting dynamic subtest: pipe-A-eDP-1
[548.678989] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.443s)
[548.688330] Starting dynamic subtest: pipe-B-eDP-1
[549.878698] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.195s)
[549.896331] Starting dynamic subtest: pipe-C-eDP-1
[551.074793] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.196s)
[551.085051] Starting dynamic subtest: pipe-D-eDP-1
[552.283777] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.206s)
[552.286049] Subtest crtc-properties-atomic: SUCCESS (4.048s)
[553.154830] [050/133] (465s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[553.268367] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[559.939214] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.674s)
[560.063825] [051/133] (459s left) gem_mmap_gtt (big-bo-tiledx)
[560.120449] Subtest big-bo-tiledX: SKIP (0.000s)
[560.177150] [052/133] (458s left) kms_plane_cursor (viewport)
[560.257981] Starting subtest: viewport
[560.262100] Starting dynamic subtest: pipe-A-eDP-1-size-64
[562.824532] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.566s)
[562.884336] Starting dynamic subtest: pipe-A-eDP-1-size-128
[565.470077] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.593s)
[565.529932] Starting dynamic subtest: pipe-A-eDP-1-size-256
[568.070721] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.549s)
[568.426101] Starting dynamic subtest: pipe-B-eDP-1-size-64
[571.741677] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.327s)
[571.801851] Starting dynamic subtest: pipe-B-eDP-1-size-128
[574.353780] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.559s)
[574.413504] Starting dynamic subtest: pipe-B-eDP-1-size-256
[577.032866] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.626s)
[577.401734] Starting dynamic subtest: pipe-C-eDP-1-size-64
[580.376488] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.985s)
[580.413608] Starting dynamic subtest: pipe-C-eDP-1-size-128
[582.598198] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.191s)
[582.636037] Starting dynamic subtest: pipe-C-eDP-1-size-256
[584.810196] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.180s)
[585.141873] Starting dynamic subtest: pipe-D-eDP-1-size-64
[587.991416] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.859s)
[588.027697] Starting dynamic subtest: pipe-D-eDP-1-size-128
[590.211996] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.191s)
[590.249500] Starting dynamic subtest: pipe-D-eDP-1-size-256
[592.381466] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.137s)
[592.703220] Subtest viewport: SUCCESS (32.444s)
[593.554336] [053/133] (425s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[593.651954] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[598.130946] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.482s)
[599.268793] [054/133] (419s left) gem_mmap_gtt (bad-object)
[599.317391] Subtest bad-object: SKIP (0.000s)
[599.371701] [055/133] (419s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[599.462776] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[599.467281] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[599.563091] [056/133] (419s left) gem_vm_create (invalid-destroy)
[599.628403] Starting subtest: invalid-destroy
[599.630788] Subtest invalid-destroy: SUCCESS (0.002s)
[599.724430] [057/133] (419s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[599.810503] Starting subtest: modeset-transition-nonblocking-fencing
[599.812775] Starting dynamic subtest: 1x-outputs
[610.924288] Dynamic subtest 1x-outputs: SUCCESS (11.114s)
[610.926960] Subtest modeset-transition-nonblocking-fencing: SUCCESS (11.116s)
[611.763785] [058/133] (407s left) syncobj_basic (bad-destroy)
[611.827210] Starting subtest: bad-destroy
[611.829213] Subtest bad-destroy: SUCCESS (0.000s)
[611.926287] [059/133] (407s left) kms_psr (fbc-psr-primary-mmap-cpu)
[612.021184] Starting subtest: fbc-psr-primary-mmap-cpu
[612.023403] Starting dynamic subtest: eDP-1
[612.027497] Dynamic subtest eDP-1: SKIP (0.000s)
[612.031639] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[612.114262] [060/133] (407s left) kms_draw_crc (draw-method-render)
[612.209205] Starting subtest: draw-method-render
[612.211391] Starting dynamic subtest: xrgb8888-untiled
[612.465300] Dynamic subtest xrgb8888-untiled: SUCCESS (0.255s)
[612.474223] Starting dynamic subtest: rgb565-untiled
[612.707066] Dynamic subtest rgb565-untiled: SUCCESS (0.242s)
[612.717734] Starting dynamic subtest: xrgb2101010-untiled
[612.940052] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.231s)
[612.951059] Starting dynamic subtest: xbgr16161616f-untiled
[613.185468] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.242s)
[613.196239] Starting dynamic subtest: xrgb8888-xtiled
[613.318196] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.130s)
[613.327477] Starting dynamic subtest: rgb565-xtiled
[613.440483] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s)
[613.449217] Starting dynamic subtest: xrgb2101010-xtiled
[613.562449] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s)
[613.571139] Starting dynamic subtest: xbgr16161616f-xtiled
[613.695836] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[613.704849] Starting dynamic subtest: xrgb8888-4tiled
[613.818511] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.121s)
[613.827296] Starting dynamic subtest: rgb565-4tiled
[613.929167] Dynamic subtest rgb565-4tiled: SUCCESS (0.110s)
[613.937684] Starting dynamic subtest: xrgb2101010-4tiled
[614.051377] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.121s)
[614.060165] Starting dynamic subtest: xbgr16161616f-4tiled
[614.184944] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s)
[614.186970] Subtest draw-method-render: SUCCESS (1.978s)
[614.302117] [061/133] (405s left) kms_flip (2x-flip-vs-modeset)
[614.391487] Starting subtest: 2x-flip-vs-modeset
[614.402988] Subtest 2x-flip-vs-modeset: SKIP (0.011s)
[614.484920] [062/133] (405s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[614.539289] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[614.642893] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.102s)
[614.731480] [063/133] (404s left) kms_sequence (get-forked-busy)
[614.823292] Starting subtest: get-forked-busy
[614.825457] Starting dynamic subtest: pipe-A-eDP-1
[616.756511] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.934s)
[616.766898] Starting dynamic subtest: pipe-B-eDP-1
[619.321922] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.565s)
[619.334579] Starting dynamic subtest: pipe-C-eDP-1
[621.913099] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.587s)
[621.923022] Starting dynamic subtest: pipe-D-eDP-1
[624.500534] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.586s)
[624.502452] Subtest get-forked-busy: SUCCESS (9.678s)
[625.348149] [064/133] (394s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[625.419127] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[625.499068] [065/133] (394s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[625.601188] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[625.603373] Starting dynamic subtest: pipe-A-eDP-1
[625.626253] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[625.636725] Starting dynamic subtest: pipe-B-eDP-1
[625.658205] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[625.666593] Starting dynamic subtest: pipe-C-eDP-1
[625.688068] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[625.696464] Starting dynamic subtest: pipe-D-eDP-1
[625.717945] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[625.722265] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.010s)
[627.845579] [066/133] (391s left) kms_lease (lease-invalid-crtc)
[627.944968] Starting subtest: lease-invalid-crtc
[627.947254] Starting dynamic subtest: pipe-A-eDP-1
[627.949434] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[627.958174] Starting dynamic subtest: pipe-B-eDP-1
[627.960087] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[627.971731] Starting dynamic subtest: pipe-C-eDP-1
[627.973928] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[627.981793] Starting dynamic subtest: pipe-D-eDP-1
[627.983681] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[627.985566] Subtest lease-invalid-crtc: SUCCESS (0.005s)
[628.024195] [067/133] (391s left) gem_exec_await (wide-contexts)
[628.258173] Starting subtest: wide-contexts
[651.951402] Subtest wide-contexts: SUCCESS (23.677s)
[652.146719] [068/133] (367s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[652.293343] Starting subtest: fbc-psr2-primary-mmap-gtt
[652.295701] Starting dynamic subtest: eDP-1
[652.299963] Dynamic subtest eDP-1: SKIP (0.000s)
[652.305031] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s)
[652.383929] [069/133] (367s left) gem_tiled_pread_pwrite
[652.490412] [070/133] (367s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[652.589157] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[652.593245] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[652.686747] [071/133] (367s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[653.088658] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[653.919705] [072/133] (366s left) perf (invalid-oa-metric-set-id)
[654.053236] Starting subtest: invalid-oa-metric-set-id
[654.067778] Subtest invalid-oa-metric-set-id: SUCCESS (0.014s)
[654.131089] [073/133] (365s left) i915_drm_fdinfo (busy)
[654.174267] Starting subtest: busy
[654.176447] Starting dynamic subtest: rcs0
[654.206253] Dynamic subtest rcs0: SKIP (0.031s)
[654.217367] Starting dynamic subtest: bcs0
[654.221450] Dynamic subtest bcs0: SKIP (0.000s)
[654.230493] Starting dynamic subtest: vcs0
[654.234909] Dynamic subtest vcs0: SKIP (0.000s)
[654.245182] Starting dynamic subtest: vcs1
[654.249163] Dynamic subtest vcs1: SKIP (0.000s)
[654.257632] Starting dynamic subtest: vecs0
[654.261626] Dynamic subtest vecs0: SKIP (0.000s)
[654.270051] Starting dynamic subtest: ccs0
[654.274143] Dynamic subtest ccs0: SKIP (0.000s)
[654.278363] Subtest busy: SKIP (0.037s)
[654.317795] [074/133] (365s left) gem_exec_flush (basic-wb-pro-default)
[654.370426] Starting subtest: basic-wb-pro-default
[659.859482] Subtest basic-wb-pro-default: SUCCESS (5.455s)
[660.017461] [075/133] (360s left) perf_pmu (semaphore-busy)
[660.056930] Starting subtest: semaphore-busy
[660.059224] Starting dynamic subtest: rcs0
[661.702742] Dynamic subtest rcs0: SUCCESS (1.642s)
[661.715077] Starting dynamic subtest: bcs0
[663.337894] Dynamic subtest bcs0: SUCCESS (1.632s)
[663.349831] Starting dynamic subtest: vcs0
[667.409879] Dynamic subtest vcs0: SUCCESS (4.069s)
[667.422319] Starting dynamic subtest: vcs1
[673.425936] Dynamic subtest vcs1: SUCCESS (6.012s)
[673.438188] Starting dynamic subtest: vecs0
[679.494166] Dynamic subtest vecs0: SUCCESS (6.012s)
[679.506644] Starting dynamic subtest: ccs0
[682.518329] Dynamic subtest ccs0: SUCCESS (3.074s)
[682.520558] Subtest semaphore-busy: SUCCESS (22.459s)
[682.636060] [076/133] (337s left) gem_userptr_blits (usage-restrictions)
[682.698578] Starting subtest: usage-restrictions
[682.700506] Subtest usage-restrictions: SUCCESS (0.000s)
[682.808951] [077/133] (337s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[682.905805] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[689.971201] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.068s)
[690.122392] [078/133] (330s left) kms_addfb_basic (bad-pitch-128)
[690.172039] Starting subtest: bad-pitch-128
[690.173850] Subtest bad-pitch-128: SUCCESS (0.000s)
[690.310328] [079/133] (329s left) intel_hwmon (hwmon-read)
[690.370479] Subtest hwmon-read: SKIP (0.000s)
[690.429760] [080/133] (329s left) device_reset (unbind-reset-rebind)
[690.482099] Starting subtest: unbind-reset-rebind
[695.218083] Subtest unbind-reset-rebind: SUCCESS (4.731s)
[695.263479] [081/133] (325s left) fbdev (nullptr)
[695.302666] Starting subtest: nullptr
[695.304555] Subtest nullptr: SUCCESS (0.000s)
[695.361131] [082/133] (325s left) kms_pm_backlight (fade-with-dpms)
[695.450046] Starting subtest: fade-with-dpms
[697.649644] Starting dynamic subtest: eDP-1
[700.131711] Dynamic subtest eDP-1: SUCCESS (2.481s)
[700.133934] Subtest fade-with-dpms: SUCCESS (4.682s)
[700.948533] [083/133] (319s left) syncobj_timeline (etime-single-wait-submitted)
[701.013271] Starting subtest: etime-single-wait-submitted
[701.123207] Subtest etime-single-wait-submitted: SUCCESS (0.108s)
[701.203371] [084/133] (319s left) api_intel_bb (render)
[701.264288] Starting subtest: render
[701.266659] Starting dynamic subtest: render-none-512
[701.363666] Dynamic subtest render-none-512: SUCCESS (0.099s)
[701.376483] Starting dynamic subtest: render-none-1024
[701.745487] Dynamic subtest render-none-1024: SUCCESS (0.380s)
[701.759658] Starting dynamic subtest: render-x-512
[701.829784] Dynamic subtest render-x-512: SUCCESS (0.085s)
[701.840312] Starting dynamic subtest: render-x-1024
[702.170530] Dynamic subtest render-x-1024: SUCCESS (0.339s)
[702.185683] Starting dynamic subtest: render-y-512
[702.265819] Dynamic subtest render-y-512: SUCCESS (0.094s)
[702.279180] Starting dynamic subtest: render-y-1024
[702.610091] Dynamic subtest render-y-1024: SUCCESS (0.342s)
[702.613794] Subtest render: SUCCESS (1.345s)
[702.733436] [085/133] (317s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[702.830203] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[702.834131] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[702.935964] [086/133] (317s left) gem_render_copy (yf-tiled)
[702.992776] Starting subtest: yf-tiled
[702.997075] Subtest yf-tiled: SKIP (0.000s)
[703.173529] [087/133] (317s left) gem_exec_balancer (full-late-pulse)
[703.243556] Starting subtest: full-late-pulse
[707.806777] Subtest full-late-pulse: SUCCESS (4.566s)
[708.121159] [088/133] (312s left) gem_exec_schedule (pi-distinct-iova)
[708.307550] Starting subtest: pi-distinct-iova
[708.310079] Starting dynamic subtest: rcs0
[708.447830] Dynamic subtest rcs0: SUCCESS (0.142s)
[708.466643] Starting dynamic subtest: vcs0
[708.532077] Dynamic subtest vcs0: SUCCESS (0.084s)
[708.545107] Starting dynamic subtest: vcs1
[708.623768] Dynamic subtest vcs1: SUCCESS (0.089s)
[708.640670] Starting dynamic subtest: vecs0
[708.706853] Dynamic subtest vecs0: SUCCESS (0.082s)
[708.719809] Starting dynamic subtest: ccs0
[708.808967] Dynamic subtest ccs0: SUCCESS (0.101s)
[708.811523] Subtest pi-distinct-iova: SUCCESS (0.505s)
[710.047841] [089/133] (310s left) kms_psr (pr-cursor-mmap-cpu)
[710.138847] Starting subtest: pr-cursor-mmap-cpu
[710.143439] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[710.225202] [090/133] (310s left) gem_request_retire (retire-vma-not-inactive)
[710.279727] Starting subtest: retire-vma-not-inactive
[710.340310] Subtest retire-vma-not-inactive: SUCCESS (0.057s)
[710.470045] [091/133] (310s left) gem_ctx_create (basic-files)
[710.531685] Starting subtest: basic-files
[712.540613] Subtest basic-files: SUCCESS (2.008s)
[714.010414] [092/133] (306s left) kms_flip (2x-blocking-wf_vblank)
[714.115672] Starting subtest: 2x-blocking-wf_vblank
[714.124355] Subtest 2x-blocking-wf_vblank: SKIP (0.011s)
[714.203431] [093/133] (306s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[714.293149] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[714.295471] Starting dynamic subtest: pipe-A-default-mode
[715.510159] Dynamic subtest pipe-A-default-mode: SKIP (1.213s)
[715.514563] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.215s)
[715.652603] [094/133] (305s left) gem_ctx_persistence (engines-hostile)
[715.717858] Starting subtest: engines-hostile
[715.719931] Starting dynamic subtest: rcs0
[715.794510] Dynamic subtest rcs0: SUCCESS (0.079s)
[715.807073] Starting dynamic subtest: bcs0
[715.891955] Dynamic subtest bcs0: SUCCESS (0.096s)
[715.904415] Starting dynamic subtest: vcs0
[715.979537] Dynamic subtest vcs0: SUCCESS (0.086s)
[715.992304] Starting dynamic subtest: vcs1
[716.074609] Dynamic subtest vcs1: SUCCESS (0.093s)
[716.086991] Starting dynamic subtest: vecs0
[716.181910] Dynamic subtest vecs0: SUCCESS (0.105s)
[716.194083] Starting dynamic subtest: ccs0
[716.290321] Dynamic subtest ccs0: SUCCESS (0.107s)
[716.292533] Subtest engines-hostile: SUCCESS (0.577s)
[716.370338] [095/133] (304s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[716.469016] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[716.472396] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[716.570152] [096/133] (304s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[716.674028] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[716.677915] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[716.777755] [097/133] (304s left) gem_lmem_swapping (parallel-random)
[716.821090] Subtest parallel-random: SKIP (0.000s)
[716.877861] [098/133] (304s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[716.970396] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[721.551041] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.584s)
[722.674629] [099/133] (298s left) perf_pmu (init-wait)
[722.714116] Starting subtest: init-wait
[722.716542] Starting dynamic subtest: rcs0
[722.718942] Dynamic subtest rcs0: SUCCESS (0.001s)
[722.731812] Starting dynamic subtest: bcs0
[722.734295] Dynamic subtest bcs0: SUCCESS (0.000s)
[722.744217] Starting dynamic subtest: vcs0
[722.746188] Dynamic subtest vcs0: SUCCESS (0.001s)
[722.755517] Starting dynamic subtest: vcs1
[722.757563] Dynamic subtest vcs1: SUCCESS (0.001s)
[722.766972] Starting dynamic subtest: vecs0
[722.769037] Dynamic subtest vecs0: SUCCESS (0.001s)
[722.778509] Starting dynamic subtest: ccs0
[722.780995] Dynamic subtest ccs0: SUCCESS (0.000s)
[722.783049] Subtest init-wait: SUCCESS (0.008s)
[722.830468] [100/133] (298s left) vgem_basic (dmabuf-fence)
[722.873957] Starting subtest: dmabuf-fence
[722.876341] Subtest dmabuf-fence: SUCCESS (0.001s)
[722.933848] [101/133] (298s left) gem_fence_thrash (bo-copy)
[722.967488] Starting subtest: bo-copy
[722.995779] Subtest bo-copy: SKIP (0.025s)
[723.062418] [102/133] (298s left) kms_psr (psr2-cursor-plane-move)
[723.160045] Starting subtest: psr2-cursor-plane-move
[723.162491] Starting dynamic subtest: eDP-1
[724.852882] Dynamic subtest eDP-1: SUCCESS (1.693s)
[724.855182] Subtest psr2-cursor-plane-move: SUCCESS (1.694s)
[725.648373] [103/133] (295s left) kms_vblank (ts-continuation-dpms-suspend)
[725.754120] Starting subtest: ts-continuation-dpms-suspend
[725.756388] Starting dynamic subtest: pipe-A-eDP-1
[742.725739] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.019s)
[742.742376] Starting dynamic subtest: pipe-D-eDP-1
[760.701922] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.496s)
[760.704642] Subtest ts-continuation-dpms-suspend: SUCCESS (4.521s)
[761.507977] [104/133] (259s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[761.607513] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[761.633555] Starting dynamic subtest: pipe-A-plane-0
[761.945388] Dynamic subtest pipe-A-plane-0: SUCCESS (0.311s)
[761.957308] Starting dynamic subtest: pipe-A-plane-3
[762.178926] Dynamic subtest pipe-A-plane-3: SUCCESS (0.230s)
[763.294936] Starting dynamic subtest: pipe-B-plane-0
[763.608628] Dynamic subtest pipe-B-plane-0: SUCCESS (0.322s)
[763.621521] Starting dynamic subtest: pipe-B-plane-3
[763.864753] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[764.193277] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.586s)
[764.998547] [105/133] (256s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[765.107653] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[765.112391] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[765.192891] [106/133] (256s left) gen9_exec_parse (bb-oversize)
[765.258299] Subtest bb-oversize: SKIP (0.000s)
[765.328336] [107/133] (256s left) gem_mmap_gtt (basic-write-gtt)
[765.382734] Subtest basic-write-gtt: SKIP (0.000s)
[765.456649] [108/133] (256s left) kms_panel_fitting (legacy)
[765.543413] Starting subtest: legacy
[765.546088] Starting dynamic subtest: pipe-A-eDP-1
[766.101435] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.560s)
[766.129458] Starting dynamic subtest: pipe-B-eDP-1
[767.692172] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.570s)
[767.720244] Starting dynamic subtest: pipe-C-eDP-1
[769.282477] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.570s)
[769.308171] Starting dynamic subtest: pipe-D-eDP-1
[770.825939] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.525s)
[770.829081] Subtest legacy: SUCCESS (5.283s)
[772.025550] [109/133] (249s left) syncobj_timeline (wait-delayed-signal)
[772.082431] Starting subtest: wait-delayed-signal
[772.184903] Subtest wait-delayed-signal: SUCCESS (0.103s)
[772.279887] [110/133] (249s left) perf_pmu (busy-accuracy-2)
[772.320968] Starting subtest: busy-accuracy-2
[772.323626] Starting dynamic subtest: rcs0
[775.370618] Dynamic subtest rcs0: SUCCESS (3.046s)
[775.383674] Starting dynamic subtest: bcs0
[778.476638] Dynamic subtest bcs0: SUCCESS (3.051s)
[778.489487] Starting dynamic subtest: vcs0
[781.521548] Dynamic subtest vcs0: SUCCESS (3.043s)
[781.534815] Starting dynamic subtest: vcs1
[784.566630] Dynamic subtest vcs1: SUCCESS (3.042s)
[784.579500] Starting dynamic subtest: vecs0
[787.612356] Dynamic subtest vecs0: SUCCESS (3.043s)
[787.627155] Starting dynamic subtest: ccs0
[790.668906] Dynamic subtest ccs0: SUCCESS (3.053s)
[790.671763] Subtest busy-accuracy-2: SUCCESS (18.294s)
[790.750905] [111/133] (230s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[790.855297] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[790.857600] Starting dynamic subtest: pipe-A-eDP-1
[792.134188] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.261s)
[792.146471] Starting dynamic subtest: pipe-B-eDP-1
[794.453447] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.335s)
[794.465392] Starting dynamic subtest: pipe-C-eDP-1
[796.798371] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.343s)
[796.809270] Starting dynamic subtest: pipe-D-eDP-1
[799.117245] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.318s)
[799.120331] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.265s)
[800.256985] [112/133] (221s left) gem_ctx_persistence (heartbeat-close)
[800.311438] Starting subtest: heartbeat-close
[800.317035] Subtest heartbeat-close: SKIP (0.000s)
[800.412611] [113/133] (221s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[800.513760] Starting subtest: x-tiled-64bpp-rotate-180
[802.206161] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.693s)
[802.418416] [114/133] (219s left) gem_ctx_param (invalid-ctx-get)
[802.470648] Starting subtest: invalid-ctx-get
[802.473448] Subtest invalid-ctx-get: SUCCESS (0.000s)
[802.545687] [115/133] (219s left) kms_cursor_crc (cursor-random-32x32)
[802.693295] Starting subtest: cursor-random-32x32
[802.737628] Subtest cursor-random-32x32: SKIP (0.042s)
[803.024277] [116/133] (218s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[803.146069] Starting subtest: basic-flip-before-cursor-varying-size
[804.070069] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.924s)
[804.890968] [117/133] (217s left) gem_userptr_blits (relocations)
[804.961302] Starting subtest: relocations
[804.966326] Subtest relocations: SKIP (0.000s)
[805.080999] [118/133] (216s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[805.182514] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[806.273659] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.091s)
[806.428297] [119/133] (215s left) gem_spin_batch (user-each)
[806.508602] Starting subtest: user-each
[809.786555] Subtest user-each: SUCCESS (3.268s)
[810.431419] [120/133] (211s left) kms_cursor_edge_walk (256x256-top-edge)
[810.529864] Starting subtest: 256x256-top-edge
[810.532341] Starting dynamic subtest: pipe-A-eDP-1
[813.948389] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.418s)
[813.961786] Starting dynamic subtest: pipe-D-eDP-1
[817.068676] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.119s)
[817.071592] Subtest 256x256-top-edge: SUCCESS (6.539s)
[817.903154] [121/133] (204s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[818.003611] Starting subtest: 4-tiled-32bpp-rotate-180
[819.460498] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.457s)
[819.582886] [122/133] (202s left) gem_mmap_offset (clear-via-pagefault)
[819.634613] Starting subtest: clear-via-pagefault
[819.636868] Starting dynamic subtest: smem0
[854.567485] Dynamic subtest smem0: SUCCESS (34.924s)
[854.570234] Subtest clear-via-pagefault: SUCCESS (34.925s)
[854.689518] [123/133] (167s left) gem_userptr_blits (invalid-null-pointer)
[854.758015] Starting subtest: invalid-null-pointer
[854.760384] Subtest invalid-null-pointer: SUCCESS (0.001s)
[854.880076] [124/133] (167s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[854.983656] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[854.988817] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[855.078094] [125/133] (167s left) gem_ctx_shared (detached-shared-gtt)
[855.160342] Starting subtest: detached-shared-gtt
[857.309340] Subtest detached-shared-gtt: SUCCESS (2.151s)
[857.711461] [126/133] (164s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[857.823046] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[858.977005] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: FAIL (0.513s)
[859.019204] [127/133] (163s left) kms_psr (fbc-pr-no-drrs)
[859.107928] Starting subtest: fbc-pr-no-drrs
[859.112434] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[859.176691] [128/133] (163s left) gem_create (create-ext-placement-sanity-check)
[859.337598] Starting subtest: create-ext-placement-sanity-check
[859.344298] Subtest create-ext-placement-sanity-check: SUCCESS (0.005s)
[859.432253] [129/133] (163s left) kms_properties (colorop-properties-legacy)
[859.527191] Starting subtest: colorop-properties-legacy
[859.529472] Starting dynamic subtest: pipe-A-eDP-1
[859.901493] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.375s)
[859.912885] Starting dynamic subtest: pipe-B-eDP-1
[860.953210] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.049s)
[860.965229] Starting dynamic subtest: pipe-C-eDP-1
[861.997910] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.041s)
[862.009488] Starting dynamic subtest: pipe-D-eDP-1
[863.043086] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.046s)
[863.045470] Subtest colorop-properties-legacy: SUCCESS (3.519s)
[863.848838] [130/133] (158s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[863.951397] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[868.406158] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.460s)
[869.549910] [131/133] (153s left) gem_ppgtt (shrink-vs-evict-pinned)
[869.620298] Starting subtest: shrink-vs-evict-pinned
[875.385906] Subtest shrink-vs-evict-pinned: SUCCESS (5.715s)
[875.435994] [132/133] (147s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[875.546887] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[875.551947] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[875.644705] [133/133] (147s left) kms_plane (plane-panning-bottom-right-suspend)
[875.728864] Starting subtest: plane-panning-bottom-right-suspend
[875.731445] Starting dynamic subtest: pipe-A
[893.532316] Dynamic subtest pipe-A: SUCCESS (3.559s)
[893.543505] Starting dynamic subtest: pipe-B
[911.559374] Dynamic subtest pipe-B: SUCCESS (3.522s)
[911.562066] Subtest plane-panning-bottom-right-suspend: SUCCESS (7.084s)
[912.365940] 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.