[59.290867] Initializing watchdogs
[59.291025]   /dev/watchdog0
[59.307142] [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]
[59.311440] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.314410] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.317849] [001/133] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[59.453262] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[59.457780] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[59.553217] [002/133] (960s left) syncobj_wait (multi-wait-for-submit-signaled)
[59.612972] Starting subtest: multi-wait-for-submit-signaled
[59.615377] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[59.697187] [003/133] (960s left) gem_media_vme
[59.814739] [004/133] (960s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[59.902884] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[59.905178] Starting dynamic subtest: pipe-A-eDP-1
[59.929381] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[59.939529] Starting dynamic subtest: pipe-B-eDP-1
[59.960897] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[59.967801] Starting dynamic subtest: pipe-C-eDP-1
[59.989872] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[59.997603] Starting dynamic subtest: pipe-D-eDP-1
[60.019522] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[60.023908] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.003s)
[62.155394] [005/133] (957s left) i915_pm_rps (min-max-config-idle)
[62.219112] Starting subtest: min-max-config-idle
[62.223732] Subtest min-max-config-idle: SKIP (0.001s)
[62.326405] [006/133] (957s left) sw_sync (timeline_closed)
[62.364431] Starting subtest: timeline_closed
[62.366364] Subtest timeline_closed: SUCCESS (0.000s)
[62.416039] [007/133] (957s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[62.513572] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[62.517709] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[62.620715] [008/133] (957s left) i915_pm_freq_api (freq-reset-multiple)
[62.690492] Starting subtest: freq-reset-multiple
[62.692860] Starting dynamic subtest: gt0
[70.158507] Dynamic subtest gt0: SUCCESS (7.458s)
[70.167810] Starting dynamic subtest: gt1
[76.785823] Dynamic subtest gt1: SUCCESS (6.625s)
[76.788773] Subtest freq-reset-multiple: SUCCESS (14.084s)
[76.862812] [009/133] (943s left) gem_exec_schedule (u-fairslice)
[76.941639] Starting subtest: u-fairslice
[76.943827] Starting dynamic subtest: rcs0
[78.967848] Dynamic subtest rcs0: SUCCESS (2.032s)
[78.976357] Starting dynamic subtest: bcs0
[80.994182] Dynamic subtest bcs0: SUCCESS (2.024s)
[81.003971] Starting dynamic subtest: vcs0
[83.014565] Dynamic subtest vcs0: SUCCESS (2.019s)
[83.023484] Starting dynamic subtest: vcs1
[85.032502] Dynamic subtest vcs1: SUCCESS (2.018s)
[85.041038] Starting dynamic subtest: vecs0
[87.051963] Dynamic subtest vecs0: SUCCESS (2.018s)
[87.062221] Starting dynamic subtest: ccs0
[89.074217] Dynamic subtest ccs0: SUCCESS (2.024s)
[89.076217] Subtest u-fairslice: SUCCESS (12.137s)
[89.390710] [010/133] (930s left) kms_prime (d3hot)
[89.482487] Subtest D3hot: SKIP (0.000s)
[89.586523] [FACT kms_prime (d3hot)] new: kernel.kmod_is_loaded.vgem: true
[89.589986] [011/133] (930s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[89.687034] Starting subtest: plane-lut1d-ctm3x4-lut1d
[89.854064] Starting dynamic subtest: pipe-A-plane-0
[90.032277] Dynamic subtest pipe-A-plane-0: SUCCESS (0.178s)
[90.039658] Starting dynamic subtest: pipe-A-plane-1
[90.222506] Dynamic subtest pipe-A-plane-1: SUCCESS (0.189s)
[90.231934] Starting dynamic subtest: pipe-A-plane-2
[90.388003] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[91.583481] Starting dynamic subtest: pipe-B-plane-0
[91.745321] Dynamic subtest pipe-B-plane-0: SUCCESS (0.167s)
[91.760088] Starting dynamic subtest: pipe-B-plane-1
[91.900609] Dynamic subtest pipe-B-plane-1: SUCCESS (0.155s)
[91.910073] Starting dynamic subtest: pipe-B-plane-2
[92.067076] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[93.325098] Starting dynamic subtest: pipe-C-plane-0
[93.486382] Dynamic subtest pipe-C-plane-0: SUCCESS (0.167s)
[93.495427] Starting dynamic subtest: pipe-C-plane-1
[93.641670] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s)
[93.649372] Starting dynamic subtest: pipe-C-plane-2
[93.808708] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s)
[95.019996] Starting dynamic subtest: pipe-D-plane-0
[95.181670] Dynamic subtest pipe-D-plane-0: SUCCESS (0.167s)
[95.190079] Starting dynamic subtest: pipe-D-plane-1
[95.325829] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[95.335150] Starting dynamic subtest: pipe-D-plane-2
[95.495287] Dynamic subtest pipe-D-plane-2: SUCCESS (0.167s)
[95.778203] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (6.092s)
[96.593989] [012/133] (923s left) api_intel_bb (misplaced-blitter)
[96.650898] Starting subtest: misplaced-blitter
[96.657388] Subtest misplaced-blitter: SUCCESS (0.007s)
[96.810991] [013/133] (923s left) kms_addfb_basic (invalid-set-prop)
[96.861110] Starting subtest: invalid-set-prop
[96.863047] Subtest invalid-set-prop: SUCCESS (0.000s)
[96.992802] [014/133] (923s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[97.099104] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[97.103096] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[97.202455] [015/133] (923s left) gem_create (create-valid-nonaligned)
[97.268891] Starting subtest: create-valid-nonaligned
[97.271419] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[97.468340] [016/133] (922s left) gem_spin_batch (legacy-resubmit-new)
[97.533626] Starting subtest: legacy-resubmit-new
[97.536130] Starting dynamic subtest: default
[97.541376] Dynamic subtest default: SUCCESS (0.007s)
[97.550878] Starting dynamic subtest: render
[97.553160] Dynamic subtest render: SUCCESS (0.004s)
[97.560677] Starting dynamic subtest: bsd
[97.562585] Dynamic subtest bsd: SUCCESS (0.006s)
[97.569837] Starting dynamic subtest: bsd1
[97.572026] Dynamic subtest bsd1: SUCCESS (0.004s)
[97.579164] Starting dynamic subtest: bsd2
[97.581298] Dynamic subtest bsd2: SUCCESS (0.005s)
[97.588279] Starting dynamic subtest: blt
[97.590448] Dynamic subtest blt: SUCCESS (0.005s)
[97.597655] Starting dynamic subtest: vebox
[97.599873] Dynamic subtest vebox: SUCCESS (0.005s)
[97.602062] Subtest legacy-resubmit-new: SUCCESS (0.041s)
[98.877987] [017/133] (921s left) kms_flip (dpms-off-confusion-interruptible)
[98.970134] Starting subtest: dpms-off-confusion-interruptible
[98.972484] Starting dynamic subtest: A-eDP1
[107.697682] Dynamic subtest A-eDP1: SUCCESS (8.723s)
[107.705571] Starting dynamic subtest: B-eDP1
[116.319521] Dynamic subtest B-eDP1: SUCCESS (8.622s)
[116.334968] Starting dynamic subtest: C-eDP1
[124.951052] Dynamic subtest C-eDP1: SUCCESS (8.614s)
[124.960915] Starting dynamic subtest: D-eDP1
[133.573600] Dynamic subtest D-eDP1: SUCCESS (8.638s)
[133.578471] Subtest dpms-off-confusion-interruptible: SUCCESS (34.607s)
[134.744917] [018/133] (885s left) gem_exec_whisper (basic-contexts-priority)
[134.808089] Starting subtest: basic-contexts-priority
[158.527646] Subtest basic-contexts-priority: SUCCESS (23.715s)
[158.704317] [019/133] (861s left) gem_ccs (block-multicopy-inplace)
[158.765704] Starting subtest: block-multicopy-inplace
[158.770135] Subtest block-multicopy-inplace: SKIP (0.000s)
[158.861108] [020/133] (861s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[158.960200] Starting subtest: fbc-indfb-scaledprimary
[161.910497] Subtest fbc-indfb-scaledprimary: SUCCESS (2.955s)
[163.039724] [021/133] (857s left) kms_cdclk (plane-scaling)
[163.136966] Starting subtest: plane-scaling
[163.139313] Starting dynamic subtest: pipe-A-eDP-1
[163.426714] Dynamic subtest pipe-A-eDP-1: SKIP (0.289s)
[163.437023] Starting dynamic subtest: pipe-B-eDP-1
[163.441292] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[163.449328] Starting dynamic subtest: pipe-C-eDP-1
[163.453749] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[163.461814] Starting dynamic subtest: pipe-D-eDP-1
[163.466128] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[163.470222] Subtest plane-scaling: SKIP (0.296s)
[164.251245] [022/133] (856s left) gem_workarounds (basic-read-fd)
[164.317736] Starting subtest: basic-read-fd
[164.329353] Subtest basic-read-fd: SUCCESS (0.012s)
[164.453870] [023/133] (856s left) perf_pmu (rc6-all-gts)
[164.490909] Starting subtest: rc6-all-gts
[170.866196] Subtest rc6-all-gts: SUCCESS (6.373s)
[171.742334] [024/133] (848s left) api_intel_bb (blit-noreloc-purge-cache)
[171.803053] Starting subtest: blit-noreloc-purge-cache
[171.816379] Subtest blit-noreloc-purge-cache: SUCCESS (0.016s)
[171.928625] [025/133] (848s left) gem_mmap_gtt (big-copy)
[171.992248] Subtest big-copy: SKIP (0.000s)
[172.046661] [026/133] (848s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[172.166829] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[172.170272] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[172.275422] [027/133] (848s left) kms_vblank (ts-continuation-idle)
[172.364211] Starting subtest: ts-continuation-idle
[172.365978] Starting dynamic subtest: pipe-A-eDP-1
[172.767540] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.402s)
[172.781474] Starting dynamic subtest: pipe-D-eDP-1
[173.837078] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.067s)
[173.839373] Subtest ts-continuation-idle: SUCCESS (1.472s)
[174.702567] [028/133] (846s left) gem_create (create-ext-placement-sanity-check)
[174.887076] Starting subtest: create-ext-placement-sanity-check
[174.889535] Subtest create-ext-placement-sanity-check: SUCCESS (0.005s)
[175.001939] [029/133] (845s left) kms_feature_discovery (display-2x)
[175.089779] Starting subtest: display-2x
[175.094146] Subtest display-2x: SKIP (0.000s)
[175.185758] [030/133] (845s left) gem_exec_schedule (implicit-boths)
[175.257982] Starting subtest: implicit-boths
[175.259924] Starting dynamic subtest: rcs0
[175.359380] Dynamic subtest rcs0: SUCCESS (0.111s)
[175.369346] Starting dynamic subtest: vcs0
[175.439863] Dynamic subtest vcs0: SUCCESS (0.080s)
[175.451283] Starting dynamic subtest: vcs1
[175.520671] Dynamic subtest vcs1: SUCCESS (0.080s)
[175.532466] Starting dynamic subtest: vecs0
[175.613357] Dynamic subtest vecs0: SUCCESS (0.092s)
[175.624490] Starting dynamic subtest: ccs0
[175.698319] Dynamic subtest ccs0: SUCCESS (0.084s)
[175.700692] Subtest implicit-boths: SUCCESS (0.450s)
[177.022198] [031/133] (843s left) kms_atomic_interruptible (universal-setplane-cursor)
[177.116472] Starting subtest: universal-setplane-cursor
[177.118758] Starting dynamic subtest: pipe-A-eDP-1
[184.503586] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.387s)
[184.506066] Subtest universal-setplane-cursor: SUCCESS (7.388s)
[185.352586] [032/133] (835s left) kms_pipe_crc_basic (bad-source)
[185.452294] Starting subtest: bad-source
[185.454538] Subtest bad-source: SUCCESS (0.000s)
[185.533850] [033/133] (835s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[185.645410] Starting subtest: x-tiled-16bpp-rotate-270
[185.665094] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s)
[185.791693] [034/133] (835s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[185.891256] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[185.895092] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[185.990594] [035/133] (835s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[186.100791] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[186.105326] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[186.195311] [036/133] (835s left) tools_test (sysfs_l3_parity)
[186.245515] Starting subtest: sysfs_l3_parity
[186.320465] Subtest sysfs_l3_parity: SKIP (0.089s)
[186.390229] [037/133] (834s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[186.481911] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[193.562913] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.084s)
[193.677871] [038/133] (827s left) gem_exec_reloc (basic-write-read-active)
[193.730661] Subtest basic-write-read-active: SKIP (0.000s)
[193.797118] [039/133] (827s left) gem_ctx_persistence (heartbeat-hang)
[193.855867] Starting subtest: heartbeat-hang
[193.860343] Subtest heartbeat-hang: SKIP (0.000s)
[193.955128] [040/133] (827s left) gem_exec_create (forked)
[194.020924] Starting subtest: forked
[194.023192] Starting dynamic subtest: smem
[214.939356] Dynamic subtest smem: SUCCESS (20.911s)
[214.943551] Subtest forked: SUCCESS (20.912s)
[215.142388] [041/133] (806s left) kms_flip (2x-flip-vs-rmfb)
[215.240227] Starting subtest: 2x-flip-vs-rmfb
[215.250975] Subtest 2x-flip-vs-rmfb: SKIP (0.010s)
[215.327351] [042/133] (806s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[215.432950] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[220.300510] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.872s)
[221.488473] [043/133] (799s left) intel_hwmon (hwmon-read)
[221.549305] Subtest hwmon-read: SKIP (0.000s)
[221.606275] [044/133] (799s left) kms_flip (2x-plain-flip-interruptible)
[221.703796] Starting subtest: 2x-plain-flip-interruptible
[221.716113] Subtest 2x-plain-flip-interruptible: SKIP (0.011s)
[221.789006] [045/133] (799s left) syncobj_timeline (wait-any-complex)
[221.846903] Starting subtest: wait-any-complex
[221.908781] Subtest wait-any-complex: SUCCESS (0.062s)
[221.984594] [046/133] (799s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[222.081675] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[222.083828] Starting dynamic subtest: pipe-A-eDP-1
[228.850998] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.769s)
[228.865715] Starting dynamic subtest: pipe-B-eDP-1
[235.905207] Dynamic subtest pipe-B-eDP-1: SUCCESS (7.055s)
[235.907436] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.826s)
[236.759283] [047/133] (784s left) kms_chamelium_hpd (hdmi-hpd-storm)
[237.133938] Subtest hdmi-hpd-storm: SKIP (0.000s)
[237.971949] [048/133] (783s left) kms_plane_cursor (overlay)
[238.073954] Starting subtest: overlay
[238.078375] Starting dynamic subtest: pipe-A-eDP-1-size-64
[240.668874] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.596s)
[240.727248] Starting dynamic subtest: pipe-A-eDP-1-size-128
[243.236952] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.516s)
[243.295073] Starting dynamic subtest: pipe-A-eDP-1-size-256
[245.805453] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.516s)
[246.156294] Starting dynamic subtest: pipe-B-eDP-1-size-64
[249.434088] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.287s)
[249.493045] Starting dynamic subtest: pipe-B-eDP-1-size-128
[252.045508] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.560s)
[252.105575] Starting dynamic subtest: pipe-B-eDP-1-size-256
[254.648919] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.550s)
[255.001511] Starting dynamic subtest: pipe-C-eDP-1-size-64
[257.959221] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.970s)
[257.996620] Starting dynamic subtest: pipe-C-eDP-1-size-128
[260.192471] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.203s)
[260.232522] Starting dynamic subtest: pipe-C-eDP-1-size-256
[262.416073] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.192s)
[262.743015] Starting dynamic subtest: pipe-D-eDP-1-size-64
[265.663172] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.931s)
[265.700773] Starting dynamic subtest: pipe-D-eDP-1-size-128
[267.863794] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.169s)
[267.900752] Starting dynamic subtest: pipe-D-eDP-1-size-256
[270.085414] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.191s)
[270.404695] Subtest overlay: SUCCESS (32.331s)
[271.210598] [049/133] (750s left) gem_exec_schedule (out-order)
[271.293634] Starting subtest: out-order
[271.295626] Starting dynamic subtest: rcs0
[271.391335] Dynamic subtest rcs0: SUCCESS (0.105s)
[271.403051] Starting dynamic subtest: vcs0
[271.478581] Dynamic subtest vcs0: SUCCESS (0.086s)
[271.490939] Starting dynamic subtest: vcs1
[271.554051] Dynamic subtest vcs1: SUCCESS (0.075s)
[271.567056] Starting dynamic subtest: vecs0
[271.628576] Dynamic subtest vecs0: SUCCESS (0.074s)
[271.639808] Starting dynamic subtest: ccs0
[271.711409] Dynamic subtest ccs0: SUCCESS (0.082s)
[271.713851] Subtest out-order: SUCCESS (0.425s)
[272.954482] [050/133] (748s left) gem_eio (context-create)
[273.186179] Starting subtest: context-create
[273.523531] Subtest context-create: SUCCESS (0.337s)
[273.658980] [051/133] (748s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[273.772211] Starting subtest: fbcpsr-tiling-4
[280.874048] Subtest fbcpsr-tiling-4: SUCCESS (7.104s)
[281.012416] [052/133] (740s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[281.108492] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[281.112620] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[281.188695] [053/133] (740s left) kms_cursor_crc (cursor-offscreen-32x10)
[281.350014] Starting subtest: cursor-offscreen-32x10
[281.397197] Subtest cursor-offscreen-32x10: SKIP (0.043s)
[281.674054] [054/133] (740s left) kms_frontbuffer_tracking (basic)
[281.775274] Starting subtest: basic
[285.109144] Subtest basic: SUCCESS (3.337s)
[285.205044] [055/133] (736s left) gem_exec_fence (parallel)
[285.373547] Starting subtest: parallel
[285.375871] Starting dynamic subtest: rcs0
[287.524036] Dynamic subtest rcs0: SUCCESS (2.151s)
[287.533451] Starting dynamic subtest: bcs0
[289.674997] Dynamic subtest bcs0: SUCCESS (2.150s)
[289.685412] Starting dynamic subtest: vcs0
[291.824131] Dynamic subtest vcs0: SUCCESS (2.148s)
[291.833794] Starting dynamic subtest: vcs1
[293.978758] Dynamic subtest vcs1: SUCCESS (2.154s)
[293.989174] Starting dynamic subtest: vecs0
[296.130845] Dynamic subtest vecs0: SUCCESS (2.151s)
[296.140051] Starting dynamic subtest: ccs0
[298.281547] Dynamic subtest ccs0: SUCCESS (2.150s)
[298.283605] Subtest parallel: SUCCESS (12.909s)
[299.015368] [056/133] (723s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[299.124573] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[299.126801] Starting dynamic subtest: pipe-A-eDP-1
[299.223549] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[299.234174] Starting dynamic subtest: pipe-B-eDP-1
[300.339085] Dynamic subtest pipe-B-eDP-1: SKIP (1.113s)
[300.343599] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.216s)
[301.548433] [057/133] (720s left) kms_flip (flip-vs-dpms-on-nop)
[301.650522] Starting subtest: flip-vs-dpms-on-nop
[301.652494] Starting dynamic subtest: A-eDP1
[303.524209] Dynamic subtest A-eDP1: SUCCESS (1.875s)
[303.535592] Starting dynamic subtest: B-eDP1
[305.366081] Dynamic subtest B-eDP1: SUCCESS (1.840s)
[305.380583] Starting dynamic subtest: C-eDP1
[307.214026] Dynamic subtest C-eDP1: SUCCESS (1.826s)
[307.231848] Starting dynamic subtest: D-eDP1
[309.051308] Dynamic subtest D-eDP1: SUCCESS (1.832s)
[309.061733] Subtest flip-vs-dpms-on-nop: SUCCESS (7.388s)
[310.217434] [058/133] (711s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[310.328256] Starting subtest: psr-shrfb-scaledprimary
[316.088616] Subtest psr-shrfb-scaledprimary: SUCCESS (5.762s)
[316.225698] [059/133] (705s left) gem_pxp (create-regular-buffer)
[316.346731] Starting subtest: create-regular-buffer
[316.349209] Subtest create-regular-buffer: SUCCESS (0.000s)
[316.450893] [060/133] (705s left) kms_plane_scaling (invalid-num-scalers)
[316.536066] Starting subtest: invalid-num-scalers
[316.538204] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[316.556146] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.019s)
[316.565459] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[316.586535] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.031s)
[316.595159] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[316.621053] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.032s)
[316.629453] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[316.653872] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.032s)
[316.656076] Subtest invalid-num-scalers: SUCCESS (0.120s)
[316.773685] [061/133] (705s left) kms_invalid_mode (uint-max-clock)
[316.877855] Starting subtest: uint-max-clock
[316.880032] Starting dynamic subtest: pipe-A-eDP-1
[317.179518] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.303s)
[317.188714] Starting dynamic subtest: pipe-B-eDP-1
[317.190860] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[317.199174] Starting dynamic subtest: pipe-C-eDP-1
[317.201270] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[317.209506] Starting dynamic subtest: pipe-D-eDP-1
[317.211787] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[317.213945] Subtest uint-max-clock: SUCCESS (0.309s)
[317.974634] [062/133] (704s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[318.071432] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[318.075761] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[318.167703] [063/133] (704s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[318.258012] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[318.260245] Starting dynamic subtest: pipe-A-default-mode
[319.434938] Dynamic subtest pipe-A-default-mode: SKIP (1.173s)
[319.439101] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.175s)
[319.577161] [064/133] (702s left) syncobj_wait (invalid-reset-one-illegal-handle)
[319.644638] Starting subtest: invalid-reset-one-illegal-handle
[319.646547] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[319.746466] [065/133] (702s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[319.855110] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[319.859362] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[320.942865] [066/133] (701s left) kms_lease (simple-lease)
[321.044114] Starting subtest: simple-lease
[321.046278] Starting dynamic subtest: pipe-A-eDP-1
[321.547770] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.502s)
[321.556192] Starting dynamic subtest: pipe-B-eDP-1
[322.990322] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.441s)
[323.002023] Starting dynamic subtest: pipe-C-eDP-1
[324.392900] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.401s)
[324.404240] Starting dynamic subtest: pipe-D-eDP-1
[325.793655] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.398s)
[325.796050] Subtest simple-lease: SUCCESS (4.749s)
[326.616061] [067/133] (695s left) kms_async_flips (invalid-async-flip)
[326.706226] Starting subtest: invalid-async-flip
[327.082618] Starting dynamic subtest: pipe-A-eDP-1
[327.915648] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.834s)
[328.287576] Starting dynamic subtest: pipe-B-eDP-1
[329.065814] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.786s)
[329.422802] Starting dynamic subtest: pipe-C-eDP-1
[330.179319] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.764s)
[330.534412] Starting dynamic subtest: pipe-D-eDP-1
[331.312266] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.785s)
[331.314572] Subtest invalid-async-flip: SUCCESS (4.609s)
[332.477500] [068/133] (690s left) kms_cursor_crc (cursor-sliding-128x42)
[332.717590] Starting subtest: cursor-sliding-128x42
[332.766369] Subtest cursor-sliding-128x42: SKIP (0.044s)
[332.974590] [069/133] (689s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[333.075506] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[334.111952] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.037s)
[334.232331] [070/133] (688s left) gem_softpin (evict-active)
[334.282711] Starting subtest: evict-active
[334.289111] Subtest evict-active: SUCCESS (0.006s)
[334.401106] [071/133] (688s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[334.521231] Starting subtest: cursorB-vs-flipA-toggle
[334.524996] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[334.664052] [072/133] (688s left) sysfs_heartbeat_interval (invalid)
[334.734297] Starting subtest: invalid
[334.736217] Starting dynamic subtest: vecs0
[334.738060] Dynamic subtest vecs0: SUCCESS (0.000s)
[334.747074] Starting dynamic subtest: ccs0
[334.748899] Dynamic subtest ccs0: SUCCESS (0.000s)
[334.756924] Starting dynamic subtest: vcs0
[334.758781] Dynamic subtest vcs0: SUCCESS (0.000s)
[334.766782] Starting dynamic subtest: bcs0
[334.768736] Dynamic subtest bcs0: SUCCESS (0.000s)
[334.776753] Starting dynamic subtest: rcs0
[334.778611] Dynamic subtest rcs0: SUCCESS (0.000s)
[334.787081] Starting dynamic subtest: vcs1
[334.788818] Dynamic subtest vcs1: SUCCESS (0.000s)
[334.790540] Subtest invalid: SUCCESS (0.005s)
[334.849945] [073/133] (687s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[334.972051] Starting subtest: basic-flip-before-cursor-atomic
[335.902178] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.928s)
[336.705851] [074/133] (686s left) gem_exec_capture (pi)
[336.777263] Starting subtest: pi
[336.779575] Starting dynamic subtest: rcs0
[341.167640] Dynamic subtest rcs0: SUCCESS (4.391s)
[341.182264] Starting dynamic subtest: bcs0
[345.205937] Dynamic subtest bcs0: SUCCESS (4.036s)
[345.216567] Starting dynamic subtest: vcs0
[349.211731] Dynamic subtest vcs0: SUCCESS (4.005s)
[349.223607] Starting dynamic subtest: vcs1
[353.151695] Dynamic subtest vcs1: SUCCESS (3.937s)
[353.163887] Starting dynamic subtest: vecs0
[357.102419] Dynamic subtest vecs0: SUCCESS (3.948s)
[357.114203] Starting dynamic subtest: ccs0
[361.060601] Dynamic subtest ccs0: SUCCESS (3.956s)
[361.062899] Subtest pi: SUCCESS (24.285s)
[361.141426] [075/133] (661s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[361.248302] Starting subtest: invalid-signal-one-illegal-handle
[361.250708] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[361.348118] [076/133] (661s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[361.451933] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[361.454238] Starting dynamic subtest: pipe-A-eDP-1
[361.479471] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[361.490196] Starting dynamic subtest: pipe-B-eDP-1
[361.513594] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[361.522093] Starting dynamic subtest: pipe-C-eDP-1
[361.546362] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[361.554629] Starting dynamic subtest: pipe-D-eDP-1
[361.578762] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[361.583211] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[363.764574] [077/133] (659s left) kms_hdr (bpc-switch-dpms)
[363.853746] Starting subtest: bpc-switch-dpms
[364.937929] Starting dynamic subtest: pipe-A-eDP-1
[369.467309] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.531s)
[369.469703] Subtest bpc-switch-dpms: SUCCESS (5.614s)
[369.571474] [078/133] (653s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[369.688046] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[369.692748] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[369.784230] [079/133] (653s left) perf_pmu (semaphore-wait-idle)
[369.825208] Starting subtest: semaphore-wait-idle
[369.827628] Starting dynamic subtest: rcs0
[370.338732] Dynamic subtest rcs0: SUCCESS (0.513s)
[370.351269] Starting dynamic subtest: bcs0
[370.851848] Dynamic subtest bcs0: SUCCESS (0.511s)
[370.864753] Starting dynamic subtest: vcs0
[371.366769] Dynamic subtest vcs0: SUCCESS (0.511s)
[371.379052] Starting dynamic subtest: vcs1
[371.880647] Dynamic subtest vcs1: SUCCESS (0.511s)
[371.895875] Starting dynamic subtest: vecs0
[372.395479] Dynamic subtest vecs0: SUCCESS (0.511s)
[372.408042] Starting dynamic subtest: ccs0
[372.911831] Dynamic subtest ccs0: SUCCESS (0.513s)
[372.914700] Subtest semaphore-wait-idle: SUCCESS (3.088s)
[373.029528] [080/133] (649s left) kms_psr (psr-primary-page-flip)
[373.140885] Starting subtest: psr-primary-page-flip
[373.143186] Starting dynamic subtest: eDP-1
[374.915586] Dynamic subtest eDP-1: SUCCESS (1.775s)
[374.917965] Subtest psr-primary-page-flip: SUCCESS (1.776s)
[375.782016] [081/133] (647s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[375.909494] Starting subtest: short-flip-after-cursor-atomic-transitions
[376.854768] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.946s)
[377.706868] [082/133] (645s left) syncobj_timeline (multi-wait-available-signaled)
[377.764060] Starting subtest: multi-wait-available-signaled
[377.766290] Subtest multi-wait-available-signaled: SUCCESS (0.000s)
[377.873665] [083/133] (645s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[377.978663] Starting subtest: y-tiled-64bpp-rotate-270
[377.983088] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[378.087553] [084/133] (645s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[378.197391] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[378.201982] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[378.342919] [085/133] (644s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[378.430147] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[378.432361] Starting dynamic subtest: pipe-A
[378.453437] Dynamic subtest pipe-A: SKIP (0.019s)
[378.463124] Starting dynamic subtest: pipe-B
[378.489172] Dynamic subtest pipe-B: SKIP (0.036s)
[378.498594] Starting dynamic subtest: pipe-C
[378.531479] Dynamic subtest pipe-C: SKIP (0.041s)
[378.540448] Starting dynamic subtest: pipe-D
[378.565572] Dynamic subtest pipe-D: SKIP (0.035s)
[378.569812] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.133s)
[378.650076] [086/133] (644s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[378.751498] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[385.542423] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.793s)
[385.691291] [087/133] (637s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[385.756175] Starting subtest: y-tiled-to-vebox-yf-tiled
[385.760672] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[385.941304] [088/133] (637s left) syncobj_wait (invalid-wait-bad-flags)
[385.993294] Starting subtest: invalid-wait-bad-flags
[385.995642] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[386.076555] [089/133] (637s left) kms_flip (2x-nonexisting-fb)
[386.180411] Starting subtest: 2x-nonexisting-fb
[386.197618] Subtest 2x-nonexisting-fb: SKIP (0.019s)
[386.293047] [090/133] (637s left) i915_pm_rps (thresholds-idle)
[386.354248] Starting subtest: thresholds-idle
[386.358315] Subtest thresholds-idle: SKIP (0.001s)
[386.460975] [091/133] (637s left) gem_eio (in-flight-contexts-immediate)
[386.658998] Starting subtest: in-flight-contexts-immediate
[397.924687] Subtest in-flight-contexts-immediate: SUCCESS (11.263s)
[398.087226] [092/133] (625s left) gem_mmap (basic-small-bo)
[398.152889] Subtest basic-small-bo: SKIP (0.000s)
[398.221069] [093/133] (625s left) kms_cursor_edge_walk (128x128-right-edge)
[398.316680] Starting subtest: 128x128-right-edge
[398.319177] Starting dynamic subtest: pipe-A-eDP-1
[401.816500] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.500s)
[401.826371] Starting dynamic subtest: pipe-D-eDP-1
[404.941347] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.125s)
[404.943678] Subtest 128x128-right-edge: SUCCESS (6.627s)
[405.754969] [094/133] (617s left) gem_mmap_gtt (basic-small-copy-xy)
[405.824561] Subtest basic-small-copy-XY: SKIP (0.000s)
[405.898087] [095/133] (617s left) dmabuf_sync_file (export-wait-after-attach)
[405.948129] Starting subtest: export-wait-after-attach
[405.950552] Subtest export-wait-after-attach: SUCCESS (0.001s)
[406.006403] [096/133] (617s left) kms_pm_dc (dc3co-vpb-simulation)
[407.106914] Starting subtest: dc3co-vpb-simulation
[415.841268] Subtest dc3co-vpb-simulation: SKIP (8.731s)
[415.966595] [097/133] (607s left) gem_lmem_swapping (basic)
[416.010159] Subtest basic: SKIP (0.000s)
[416.049340] [098/133] (607s left) kms_psr (fbc-psr-primary-render)
[416.145397] Starting subtest: fbc-psr-primary-render
[416.147688] Starting dynamic subtest: eDP-1
[416.152094] Dynamic subtest eDP-1: SKIP (0.000s)
[416.156489] Subtest fbc-psr-primary-render: SKIP (0.001s)
[416.218059] [099/133] (607s left) i915_drm_fdinfo (busy-idle-check-all)
[416.260683] Starting subtest: busy-idle-check-all
[416.262875] Starting dynamic subtest: rcs0
[416.267064] Dynamic subtest rcs0: SKIP (0.003s)
[416.281039] Starting dynamic subtest: bcs0
[416.285262] Dynamic subtest bcs0: SKIP (0.000s)
[416.293696] Starting dynamic subtest: vcs0
[416.297980] Dynamic subtest vcs0: SKIP (0.000s)
[416.306453] Starting dynamic subtest: vcs1
[416.310691] Dynamic subtest vcs1: SKIP (0.000s)
[416.319203] Starting dynamic subtest: vecs0
[416.323306] Dynamic subtest vecs0: SKIP (0.000s)
[416.331964] Starting dynamic subtest: ccs0
[416.336141] Dynamic subtest ccs0: SKIP (0.000s)
[416.340317] Subtest busy-idle-check-all: SKIP (0.009s)
[416.376753] [100/133] (607s left) gem_ctx_param (invalid-size-set)
[416.459664] Starting subtest: invalid-size-set
[416.462074] Subtest invalid-size-set: SUCCESS (0.001s)
[416.557440] [101/133] (607s left) gem_ctx_isolation (preservation-s3)
[416.616449] Starting subtest: preservation-S3
[416.618831] Starting dynamic subtest: rcs0
[433.186455] Dynamic subtest rcs0: SUCCESS (2.160s)
[433.197486] Starting dynamic subtest: bcs0
[449.171903] Dynamic subtest bcs0: SUCCESS (1.305s)
[449.182248] Starting dynamic subtest: vcs0
[465.179536] Dynamic subtest vcs0: SUCCESS (2.894s)
[465.190627] Starting dynamic subtest: vcs1
[483.187072] Dynamic subtest vcs1: SUCCESS (4.970s)
[483.200675] Starting dynamic subtest: vecs0
[501.184018] Dynamic subtest vecs0: SUCCESS (4.939s)
[501.194901] Starting dynamic subtest: ccs0
[519.179204] Dynamic subtest ccs0: SUCCESS (3.152s)
[519.181568] Subtest preservation-S3: SUCCESS (19.425s)
[519.406891] [102/133] (504s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[519.515760] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[519.517992] Starting dynamic subtest: pipe-A-eDP-1
[519.540936] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[519.552871] Starting dynamic subtest: pipe-B-eDP-1
[519.574568] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[519.584215] Starting dynamic subtest: pipe-C-eDP-1
[519.605271] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[519.614507] Starting dynamic subtest: pipe-D-eDP-1
[519.635734] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[519.640262] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[521.803251] [103/133] (502s left) kms_pipe_crc_basic (nonblocking-crc)
[521.900026] Starting subtest: nonblocking-crc
[521.902028] Starting dynamic subtest: pipe-A-eDP-1
[522.662076] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.757s)
[522.672344] Starting dynamic subtest: pipe-B-eDP-1
[524.141398] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.471s)
[524.152029] Starting dynamic subtest: pipe-C-eDP-1
[525.518803] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.370s)
[525.528733] Starting dynamic subtest: pipe-D-eDP-1
[526.943025] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.418s)
[526.945421] Subtest nonblocking-crc: SUCCESS (5.022s)
[527.747596] [104/133] (496s left) syncobj_wait (wait-for-submit-complex)
[527.806030] Starting subtest: wait-for-submit-complex
[527.867494] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[527.957733] [105/133] (496s left) syncobj_wait (invalid-signal-one-illegal-handle)
[528.014983] Starting subtest: invalid-signal-one-illegal-handle
[528.017042] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[528.124623] [106/133] (495s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[528.242872] Starting subtest: short-busy-flip-before-cursor-toggle
[528.247424] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[528.390571] [107/133] (495s left) kms_chamelium_edid (hdmi-edid-read)
[528.787776] Subtest hdmi-edid-read: SKIP (0.000s)
[529.576129] [108/133] (494s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[529.682617] Starting subtest: psr-rgb565-draw-mmap-wc
[536.499196] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.808s)
[536.602090] [109/133] (487s left) kms_psr (psr2-sprite-mmap-cpu)
[536.693305] Starting subtest: psr2-sprite-mmap-cpu
[536.695527] Starting dynamic subtest: eDP-1
[538.429503] Dynamic subtest eDP-1: SUCCESS (1.734s)
[538.431829] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.735s)
[539.297284] [110/133] (484s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[539.396168] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[546.932379] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.535s)
[547.059631] [111/133] (477s left) gem_busy (close-race)
[547.122240] Starting subtest: close-race
[570.908837] Subtest close-race: SUCCESS (23.760s)
[571.278613] [112/133] (453s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[571.384777] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[571.389339] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[571.587960] [113/133] (452s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[571.694406] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[571.696663] Starting dynamic subtest: A-eDP1
[580.615296] Dynamic subtest A-eDP1: SUCCESS (8.915s)
[580.628339] Starting dynamic subtest: B-eDP1
[589.542935] Dynamic subtest B-eDP1: SUCCESS (8.928s)
[589.561782] Starting dynamic subtest: C-eDP1
[598.470650] Dynamic subtest C-eDP1: SUCCESS (8.925s)
[598.481927] Starting dynamic subtest: D-eDP1
[607.400478] Dynamic subtest D-eDP1: SUCCESS (8.927s)
[607.402897] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.705s)
[608.653205] [114/133] (415s left) gem_exec_reloc (basic-write-gtt-noreloc)
[608.711412] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[608.788574] [115/133] (415s left) kms_content_protection (lic-type-0-hdcp14)
[608.933849] Starting subtest: lic-type-0-hdcp14
[608.938313] Subtest lic-type-0-hdcp14: SKIP (0.000s)
[609.070856] [116/133] (415s left) perf_pmu (busy-accuracy-98)
[609.116568] Starting subtest: busy-accuracy-98
[609.118760] Starting dynamic subtest: rcs0
[612.149795] Dynamic subtest rcs0: SUCCESS (3.032s)
[612.161792] Starting dynamic subtest: bcs0
[615.203117] Dynamic subtest bcs0: SUCCESS (3.050s)
[615.215417] Starting dynamic subtest: vcs0
[618.251392] Dynamic subtest vcs0: SUCCESS (3.045s)
[618.263412] Starting dynamic subtest: vcs1
[621.295663] Dynamic subtest vcs1: SUCCESS (3.040s)
[621.307871] Starting dynamic subtest: vecs0
[624.340160] Dynamic subtest vecs0: SUCCESS (3.041s)
[624.356104] Starting dynamic subtest: ccs0
[627.396306] Dynamic subtest ccs0: SUCCESS (3.053s)
[627.398351] Subtest busy-accuracy-98: SUCCESS (18.275s)
[627.510298] [117/133] (397s left) gem_userptr_blits (forbidden-operations)
[627.578736] Starting subtest: forbidden-operations
[627.582961] Subtest forbidden-operations: SKIP (0.000s)
[627.699195] [118/133] (396s left) gen7_exec_parse (basic-allocation)
[627.761855] Subtest basic-allocation: SKIP (0.000s)
[627.831578] [119/133] (396s left) syncobj_basic (bad-pad-fd-to-handle)
[627.878204] Starting subtest: bad-pad-fd-to-handle
[627.880514] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[627.964127] [120/133] (396s left) gem_exec_balancer (busy)
[628.029191] Starting subtest: busy
[629.918361] Subtest busy: SUCCESS (1.887s)
[630.243475] [121/133] (394s left) prime_mmap (test_correct_cpu_write)
[630.300183] Starting subtest: test_correct_cpu_write
[630.302303] Starting dynamic subtest: test_correct_cpu_write-smem
[630.304135] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[630.306165] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[630.395321] [122/133] (394s left) gen9_exec_parse (batch-zero-length)
[630.459838] Subtest batch-zero-length: SKIP (0.000s)
[630.525731] [123/133] (394s left) kms_psr (pr-sprite-mmap-cpu)
[630.634394] Starting subtest: pr-sprite-mmap-cpu
[630.638759] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[630.721561] [124/133] (394s left) kms_universal_plane (universal-plane-functional)
[630.818669] Starting subtest: universal-plane-functional
[630.820620] Starting dynamic subtest: pipe-A-eDP-1
[634.753413] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.934s)
[634.764095] Starting dynamic subtest: pipe-B-eDP-1
[639.329532] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.573s)
[639.339961] Starting dynamic subtest: pipe-C-eDP-1
[643.679070] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.345s)
[643.689364] Starting dynamic subtest: pipe-D-eDP-1
[648.074159] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.395s)
[648.076515] Subtest universal-plane-functional: SUCCESS (17.253s)
[648.948510] [125/133] (375s left) kms_plane (pixel-format-yf-tiled-ccs-modifier)
[649.048751] Starting subtest: pixel-format-yf-tiled-ccs-modifier
[649.053220] Subtest pixel-format-yf-tiled-ccs-modifier: SKIP (0.000s)
[649.124601] [126/133] (375s left) kms_big_fb (linear-addfb)
[649.224744] Starting subtest: linear-addfb
[649.226854] Subtest linear-addfb: SUCCESS (0.000s)
[649.347802] [127/133] (375s left) gem_mmap_offset (bad-flags)
[649.399312] Starting subtest: bad-flags
[649.401224] Subtest bad-flags: SUCCESS (0.000s)
[649.502518] [128/133] (375s left) gem_sync (basic-each)
[649.570714] Starting subtest: basic-each
[651.913716] Subtest basic-each: SUCCESS (2.354s)
[652.103834] [129/133] (373s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[652.207534] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[652.998479] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.793s)
[653.216862] [130/133] (371s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[653.304300] Starting subtest: fbc-psr2-cursor-mmap-gtt
[653.306603] Starting dynamic subtest: eDP-1
[653.310892] Dynamic subtest eDP-1: SKIP (0.000s)
[653.315288] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[653.380769] [131/133] (371s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[653.464333] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[653.570648] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.104s)
[653.650264] [132/133] (371s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted)
[653.704598] Starting subtest: etime-single-wait-all-available-unsubmitted
[653.810346] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.105s)
[653.888866] [133/133] (371s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[653.996654] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[654.001053] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[654.104301] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: syncobj_wait
results: parsing output: 2/ for test: gem_media_vme
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: i915_pm_rps
results: parsing output: 5/ for test: sw_sync
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: i915_pm_freq_api
results: parsing output: 8/ for test: gem_exec_schedule
results: parsing output: 9/ for test: kms_prime
results: parsing output: 10/ for test: kms_color_pipeline
results: parsing output: 11/ for test: api_intel_bb
results: parsing output: 12/ for test: kms_addfb_basic
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_create
results: parsing output: 15/ for test: gem_spin_batch
results: parsing output: 16/ for test: kms_flip
results: parsing output: 17/ for test: gem_exec_whisper
results: parsing output: 18/ for test: gem_ccs
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_cdclk
results: parsing output: 21/ for test: gem_workarounds
results: parsing output: 22/ for test: perf_pmu
results: parsing output: 23/ for test: api_intel_bb
results: parsing output: 24/ for test: gem_mmap_gtt
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_vblank
results: parsing output: 27/ for test: gem_create
results: parsing output: 28/ for test: kms_feature_discovery
results: parsing output: 29/ for test: gem_exec_schedule
results: parsing output: 30/ for test: kms_atomic_interruptible
results: parsing output: 31/ for test: kms_pipe_crc_basic
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: tools_test
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_exec_reloc
results: parsing output: 38/ for test: gem_ctx_persistence
results: parsing output: 39/ for test: gem_exec_create
results: parsing output: 40/ for test: kms_flip
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: intel_hwmon
results: parsing output: 43/ for test: kms_flip
results: parsing output: 44/ for test: syncobj_timeline
results: parsing output: 45/ for test: kms_psr2_sf
results: parsing output: 46/ for test: kms_chamelium_hpd
results: parsing output: 47/ for test: kms_plane_cursor
results: parsing output: 48/ for test: gem_exec_schedule
results: parsing output: 49/ for test: gem_eio
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_psr2_sf
results: parsing output: 52/ for test: kms_cursor_crc
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_exec_fence
results: parsing output: 55/ for test: kms_psr2_sf
results: parsing output: 56/ for test: kms_flip
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: gem_pxp
results: parsing output: 59/ for test: kms_plane_scaling
results: parsing output: 60/ for test: kms_invalid_mode
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_flip_scaled_crc
results: parsing output: 63/ for test: syncobj_wait
results: parsing output: 64/ for test: kms_ccs
results: parsing output: 65/ for test: kms_lease
results: parsing output: 66/ for test: kms_async_flips
results: parsing output: 67/ for test: kms_cursor_crc
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: gem_softpin
results: parsing output: 70/ for test: kms_cursor_legacy
results: parsing output: 71/ for test: sysfs_heartbeat_interval
results: parsing output: 72/ for test: kms_cursor_legacy
results: parsing output: 73/ for test: gem_exec_capture
results: parsing output: 74/ for test: syncobj_timeline
results: parsing output: 75/ for test: kms_ccs
results: parsing output: 76/ for test: kms_hdr
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: perf_pmu
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: kms_cursor_legacy
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: kms_cursor_legacy
results: parsing output: 84/ for test: kms_plane_scaling
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_render_copy
results: parsing output: 87/ for test: syncobj_wait
results: parsing output: 88/ for test: kms_flip
results: parsing output: 89/ for test: i915_pm_rps
results: parsing output: 90/ for test: gem_eio
results: parsing output: 91/ for test: gem_mmap
results: parsing output: 92/ for test: kms_cursor_edge_walk
results: parsing output: 93/ for test: gem_mmap_gtt
results: parsing output: 94/ for test: dmabuf_sync_file
results: parsing output: 95/ for test: kms_pm_dc
results: parsing output: 96/ for test: gem_lmem_swapping
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: i915_drm_fdinfo
results: parsing output: 99/ for test: gem_ctx_param
results: parsing output: 100/ for test: gem_ctx_isolation
results: parsing output: 101/ for test: kms_ccs
results: parsing output: 102/ for test: kms_pipe_crc_basic
results: parsing output: 103/ for test: syncobj_wait
results: parsing output: 104/ for test: syncobj_wait
results: parsing output: 105/ for test: kms_cursor_legacy
results: parsing output: 106/ for test: kms_chamelium_edid
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_psr
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: gem_busy
results: parsing output: 111/ for test: gem_render_copy
results: parsing output: 112/ for test: kms_flip
results: parsing output: 113/ for test: gem_exec_reloc
results: parsing output: 114/ for test: kms_content_protection
results: parsing output: 115/ for test: perf_pmu
results: parsing output: 116/ for test: gem_userptr_blits
results: parsing output: 117/ for test: gen7_exec_parse
results: parsing output: 118/ for test: syncobj_basic
results: parsing output: 119/ for test: gem_exec_balancer
results: parsing output: 120/ for test: prime_mmap
results: parsing output: 121/ for test: gen9_exec_parse
results: parsing output: 122/ for test: kms_psr
results: parsing output: 123/ for test: kms_universal_plane
results: parsing output: 124/ for test: kms_plane
results: parsing output: 125/ for test: kms_big_fb
results: parsing output: 126/ for test: gem_mmap_offset
results: parsing output: 127/ for test: gem_sync
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: syncobj_timeline
results: parsing output: 131/ for test: syncobj_timeline
results: parsing output: 132/ for test: kms_big_fb
Done.