[56.451947] Initializing watchdogs
[56.451991]   /dev/watchdog0
[56.465468] [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.469889] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.472289] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.475405] [001/134] (960s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[58.050408] Starting subtest: dpms-mode-unset-non-lpsp
[59.210870] Subtest dpms-mode-unset-non-lpsp: SKIP (1.157s)
[59.591232] [002/134] (957s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[59.679703] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[59.684265] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[59.786724] [003/134] (957s left) gem_lmem_swapping (heavy-multi)
[59.835417] Subtest heavy-multi: SKIP (0.000s)
[59.871293] [004/134] (957s left) kms_plane (plane-position-hole)
[59.969305] Starting subtest: plane-position-hole
[60.533770] Starting dynamic subtest: pipe-A-plane-1
[61.878751] Dynamic subtest pipe-A-plane-1: SUCCESS (1.344s)
[61.891252] Starting dynamic subtest: pipe-A-plane-2
[63.207289] Dynamic subtest pipe-A-plane-2: SUCCESS (1.329s)
[63.216460] Starting dynamic subtest: pipe-A-plane-3
[64.512447] Dynamic subtest pipe-A-plane-3: SUCCESS (1.305s)
[64.523647] Starting dynamic subtest: pipe-A-plane-4
[65.782427] Dynamic subtest pipe-A-plane-4: SUCCESS (1.267s)
[65.796186] Starting dynamic subtest: pipe-A-plane-5
[65.807857] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[66.997199] Starting dynamic subtest: pipe-B-plane-1
[68.319678] Dynamic subtest pipe-B-plane-1: SUCCESS (1.331s)
[68.327334] Starting dynamic subtest: pipe-B-plane-2
[69.560812] Dynamic subtest pipe-B-plane-2: SUCCESS (1.239s)
[69.574770] Starting dynamic subtest: pipe-B-plane-3
[70.870114] Dynamic subtest pipe-B-plane-3: SUCCESS (1.311s)
[70.880075] Starting dynamic subtest: pipe-B-plane-4
[72.140848] Dynamic subtest pipe-B-plane-4: SUCCESS (1.269s)
[72.149796] Starting dynamic subtest: pipe-B-plane-5
[72.165054] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s)
[72.167318] Subtest plane-position-hole: SUCCESS (12.190s)
[73.003480] [005/134] (944s left) gem_exec_reloc (basic-cpu-wc-active)
[73.060917] Subtest basic-cpu-wc-active: SKIP (0.000s)
[73.132619] [006/134] (944s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[78.182519] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[78.184959] Starting dynamic subtest: pipe-A-eDP-1
[78.971102] Dynamic subtest pipe-A-eDP-1: SKIP (0.784s)
[78.985831] Starting dynamic subtest: pipe-B-eDP-1
[80.110651] Dynamic subtest pipe-B-eDP-1: SKIP (1.138s)
[80.115632] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.927s)
[81.411773] [007/134] (935s left) kms_cdclk (plane-scaling)
[81.505451] Starting subtest: plane-scaling
[81.507825] Starting dynamic subtest: pipe-A-eDP-1
[81.798840] Dynamic subtest pipe-A-eDP-1: SKIP (0.293s)
[81.807038] Starting dynamic subtest: pipe-B-eDP-1
[81.811321] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[81.817985] Starting dynamic subtest: pipe-C-eDP-1
[81.822318] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[81.829059] Starting dynamic subtest: pipe-D-eDP-1
[81.833393] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[81.837424] Subtest plane-scaling: SKIP (0.299s)
[82.637178] [008/134] (934s left) gem_mmap_gtt (fault-concurrent-x)
[82.696211] Subtest fault-concurrent-X: SKIP (0.000s)
[82.759951] [009/134] (934s left) kms_psr (fbc-psr-basic)
[82.867413] Starting subtest: fbc-psr-basic
[82.869600] Starting dynamic subtest: eDP-1
[82.873946] Dynamic subtest eDP-1: SKIP (0.000s)
[82.878119] Subtest fbc-psr-basic: SKIP (0.002s)
[82.950608] [010/134] (934s left) gem_exec_schedule (semaphore-user)
[83.040514] Starting subtest: semaphore-user
[83.094871] Subtest semaphore-user: SUCCESS (0.057s)
[84.937433] [011/134] (932s left) api_intel_bb (add-remove-objects)
[85.002096] Starting subtest: add-remove-objects
[85.008239] Subtest add-remove-objects: SUCCESS (0.008s)
[85.151787] [012/134] (932s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[85.268782] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[85.273778] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[85.377050] [013/134] (932s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[85.495214] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[94.410254] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (8.914s)
[95.288026] [014/134] (922s left) kms_setmode (invalid-clone-exclusive-crtc)
[95.356051] Starting subtest: invalid-clone-exclusive-crtc
[95.362674] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[95.472814] [015/134] (922s left) i915_query (query-topology-kernel-writes)
[95.531315] Starting subtest: query-topology-kernel-writes
[95.533689] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[95.632665] [016/134] (921s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[95.734833] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[95.739485] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[95.834786] [017/134] (921s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[95.943304] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[95.947324] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[96.042036] [018/134] (921s left) kms_dsc (dsc-with-output-formats)
[96.138282] Starting subtest: dsc-with-output-formats
[96.159889] Subtest dsc-with-output-formats: SKIP (0.001s)
[96.231283] [019/134] (921s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[96.325059] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[96.326946] Starting dynamic subtest: pipe-A-eDP-1
[96.334053] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[96.342414] Starting dynamic subtest: pipe-B-eDP-1
[96.349717] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[96.356602] Starting dynamic subtest: pipe-C-eDP-1
[96.363630] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[96.369919] Starting dynamic subtest: pipe-D-eDP-1
[96.376997] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[96.380676] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[98.549250] [020/134] (919s left) gem_ctx_shared (q-smoketest-all)
[98.611179] Starting subtest: Q-smoketest-all
[130.998925] Subtest Q-smoketest-all: SUCCESS (32.340s)
[131.985406] [021/134] (885s left) kms_joiner (basic-big-joiner)
[132.088518] Starting subtest: basic-big-joiner
[132.093041] Subtest basic-big-joiner: SKIP (0.000s)
[132.161204] [022/134] (885s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[132.272748] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[135.838715] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.570s)
[137.043554] [023/134] (880s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[137.131220] Starting subtest: basic-max-pipe-crc-check
[137.135733] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[137.174959] [024/134] (880s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[137.281957] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[160.202406] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.925s)
[160.369073] [025/134] (857s left) kms_atomic_interruptible (legacy-pageflip)
[160.474995] Starting subtest: legacy-pageflip
[160.477061] Starting dynamic subtest: pipe-A-eDP-1
[167.877847] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.398s)
[167.880144] Subtest legacy-pageflip: SUCCESS (7.401s)
[168.706159] [026/134] (849s left) gem_exec_suspend (basic-s3-devices)
[168.763116] Starting subtest: basic-S3-devices
[168.765425] Starting dynamic subtest: smem
[179.924404] Dynamic subtest smem: SUCCESS (11.162s)
[179.927039] Subtest basic-S3-devices: SUCCESS (11.164s)
[180.120143] [027/134] (837s left) kms_properties (colorop-properties-legacy)
[180.225076] Starting subtest: colorop-properties-legacy
[180.227307] Starting dynamic subtest: pipe-A-eDP-1
[180.560023] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.334s)
[180.569569] Starting dynamic subtest: pipe-B-eDP-1
[181.636070] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.076s)
[181.646763] Starting dynamic subtest: pipe-C-eDP-1
[182.685648] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.047s)
[182.693811] Starting dynamic subtest: pipe-D-eDP-1
[183.724560] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.037s)
[183.726737] Subtest colorop-properties-legacy: SUCCESS (3.501s)
[184.547631] [028/134] (833s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[184.642219] Starting subtest: fbc-rgb101010-draw-pwrite
[190.000901] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.361s)
[191.150929] [029/134] (826s left) kms_plane_multiple (2x-tiling-yf)
[191.236292] Starting subtest: 2x-tiling-yf
[191.240676] Subtest 2x-tiling-yf: SKIP (0.000s)
[191.329072] [030/134] (826s left) i915_query (query-garbage)
[191.388818] Starting subtest: query-garbage
[191.391102] Subtest query-garbage: SUCCESS (0.000s)
[191.505738] [031/134] (826s left) gem_exec_schedule (noreorder)
[191.687060] Starting subtest: noreorder
[191.689487] Starting dynamic subtest: rcs0
[191.758541] Dynamic subtest rcs0: SUCCESS (0.071s)
[191.769373] Starting dynamic subtest: vcs0
[192.935292] Dynamic subtest vcs0: SUCCESS (1.173s)
[192.945318] Starting dynamic subtest: vcs1
[194.908324] Dynamic subtest vcs1: SUCCESS (1.970s)
[194.917478] Starting dynamic subtest: vecs0
[196.910933] Dynamic subtest vecs0: SUCCESS (2.000s)
[196.921257] Starting dynamic subtest: ccs0
[197.012970] Dynamic subtest ccs0: SUCCESS (0.101s)
[197.015588] Subtest noreorder: SUCCESS (5.326s)
[197.224139] [032/134] (820s left) syncobj_timeline (wait-all-for-submit-complex)
[197.284460] Starting subtest: wait-all-for-submit-complex
[197.497992] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[197.589259] [033/134] (820s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping)
[197.694107] Starting subtest: pixel-format-x-tiled-modifier-source-clamping
[197.719531] Starting dynamic subtest: pipe-A-plane-0
[198.341557] Dynamic subtest pipe-A-plane-0: SUCCESS (0.622s)
[198.350103] Starting dynamic subtest: pipe-A-plane-3
[198.730276] Dynamic subtest pipe-A-plane-3: SUCCESS (0.388s)
[198.738522] Starting dynamic subtest: pipe-A-plane-5
[198.742162] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[199.806731] Starting dynamic subtest: pipe-B-plane-0
[200.466596] Dynamic subtest pipe-B-plane-0: SUCCESS (0.666s)
[200.474791] Starting dynamic subtest: pipe-B-plane-3
[200.866172] Dynamic subtest pipe-B-plane-3: SUCCESS (0.399s)
[200.874510] Starting dynamic subtest: pipe-B-plane-5
[200.878038] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[201.190554] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (3.497s)
[201.995274] [034/134] (816s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[202.101075] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[202.105567] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[203.227812] [035/134] (815s left) kms_universal_plane (universal-plane-sanity)
[203.318085] Starting subtest: universal-plane-sanity
[203.320315] Starting dynamic subtest: pipe-A-eDP-1
[203.917656] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.599s)
[203.925605] Starting dynamic subtest: pipe-B-eDP-1
[205.125647] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.208s)
[205.135074] Starting dynamic subtest: pipe-C-eDP-1
[206.350703] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.223s)
[206.360030] Starting dynamic subtest: pipe-D-eDP-1
[207.586623] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.232s)
[207.588850] Subtest universal-plane-sanity: SUCCESS (4.268s)
[208.454468] [036/134] (809s left) gem_ccs (suspend-resume)
[208.529513] Starting subtest: suspend-resume
[208.534089] Subtest suspend-resume: SKIP (0.000s)
[208.663015] [037/134] (809s left) gem_tiled_blits (normal)
[208.723642] Subtest normal: SKIP (0.000s)
[208.807410] [038/134] (809s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[208.907779] Starting subtest: plane-lut1d-ctm3x4-lut1d
[208.922786] Starting dynamic subtest: pipe-A-eDP-1
[209.626528] Dynamic subtest pipe-A-eDP-1: FAIL (0.359s)
[210.328969] Starting dynamic subtest: pipe-B-eDP-1
[211.173429] Dynamic subtest pipe-B-eDP-1: FAIL (0.302s)
[211.665728] Starting dynamic subtest: pipe-C-eDP-1
[212.508851] Dynamic subtest pipe-C-eDP-1: FAIL (0.245s)
[212.998377] Starting dynamic subtest: pipe-D-eDP-1
[213.828441] Dynamic subtest pipe-D-eDP-1: FAIL (0.245s)
[213.830741] Subtest plane-lut1d-ctm3x4-lut1d: FAIL (4.623s)
[214.392927] [039/134] (804s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[214.489851] Starting subtest: fbc-dirtyfb-ioctl
[214.491674] Starting dynamic subtest: A-eDP-1
[217.083233] Dynamic subtest A-eDP-1: SUCCESS (2.593s)
[217.085404] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.594s)
[217.962082] [040/134] (800s left) core_sysfs (read-all-entries)
[218.018438] Starting subtest: read-all-entries
[218.020840] Subtest read-all-entries: SUCCESS (0.003s)
[218.121430] [041/134] (800s left) kms_scaling_modes (scaling-mode-full)
[218.226964] Starting subtest: scaling-mode-full
[218.229307] Starting dynamic subtest: pipe-A-eDP-1
[218.325674] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.097s)
[218.337545] Starting dynamic subtest: pipe-B-eDP-1
[219.479582] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.153s)
[219.488541] Starting dynamic subtest: pipe-C-eDP-1
[220.601524] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.121s)
[220.610064] Starting dynamic subtest: pipe-D-eDP-1
[221.731481] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.129s)
[221.733723] Subtest scaling-mode-full: SUCCESS (3.506s)
[222.916108] [042/134] (795s left) gem_caching (reads)
[222.983834] Subtest reads: SKIP (0.000s)
[223.072284] [043/134] (795s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[223.164349] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[223.166642] Starting dynamic subtest: pipe-A-default-mode
[223.451838] Dynamic subtest pipe-A-default-mode: SKIP (0.285s)
[223.456552] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.286s)
[224.251544] [044/134] (794s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[224.349261] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[225.307907] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (0.958s)
[225.440481] [045/134] (793s left) gem_exec_balancer (nohangcheck)
[225.700422] Starting subtest: nohangcheck
[226.571687] Subtest nohangcheck: SUCCESS (0.871s)
[226.725825] [046/134] (791s left) kms_vblank (ts-continuation-idle-hang)
[226.814023] Starting subtest: ts-continuation-idle-hang
[226.816132] Starting dynamic subtest: pipe-A-eDP-1
[254.675555] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.860s)
[254.688597] Starting dynamic subtest: pipe-D-eDP-1
[269.660379] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.982s)
[269.662364] Subtest ts-continuation-idle-hang: SUCCESS (42.846s)
[270.506325] [047/134] (748s left) gem_exec_reloc (basic-concurrent16)
[270.563595] Subtest basic-concurrent16: SKIP (0.000s)
[270.641245] [048/134] (748s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[270.696165] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[270.698492] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[270.807798] [049/134] (748s left) kms_flip (plain-flip-ts-check-interruptible)
[270.903518] Starting subtest: plain-flip-ts-check-interruptible
[270.905862] Starting dynamic subtest: A-eDP1
[279.785162] Dynamic subtest A-eDP1: SUCCESS (8.881s)
[279.795474] Starting dynamic subtest: B-eDP1
[288.615147] Dynamic subtest B-eDP1: SUCCESS (8.829s)
[288.625407] Starting dynamic subtest: C-eDP1
[297.435813] Dynamic subtest C-eDP1: SUCCESS (8.817s)
[297.445318] Starting dynamic subtest: D-eDP1
[306.265871] Dynamic subtest D-eDP1: SUCCESS (8.830s)
[306.271175] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.367s)
[307.456607] [050/134] (711s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[307.556241] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[307.558556] Starting dynamic subtest: pipe-A-default-mode
[308.717736] Dynamic subtest pipe-A-default-mode: SKIP (1.159s)
[308.721659] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.161s)
[308.871622] [051/134] (710s left) gem_flink_race (flink_close)
[308.907422] Starting subtest: flink_close
[313.993739] Subtest flink_close: SUCCESS (5.088s)
[314.126421] [052/134] (704s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[314.236720] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[315.027254] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.792s)
[315.221957] [053/134] (703s left) kms_properties (connector-properties-atomic)
[315.316128] Starting subtest: connector-properties-atomic
[315.318431] Starting dynamic subtest: pipe-A-eDP-1
[323.206406] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.890s)
[323.214781] Starting dynamic subtest: pipe-None-DP-1
[323.219181] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[323.226230] Starting dynamic subtest: pipe-None-HDMI-A-1
[323.230263] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[323.237830] Starting dynamic subtest: pipe-None-DP-2
[323.242125] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[323.249579] Starting dynamic subtest: pipe-None-HDMI-A-2
[323.253679] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[323.261169] Starting dynamic subtest: pipe-None-DP-3
[323.265530] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[323.276200] Starting dynamic subtest: pipe-None-DP-4
[323.280871] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[323.283168] Subtest connector-properties-atomic: SUCCESS (7.901s)
[324.066495] [054/134] (694s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[324.154175] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[330.905219] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.755s)
[331.041353] [055/134] (688s left) perf_pmu (busy-double-start)
[331.079481] Starting subtest: busy-double-start
[331.081953] Starting dynamic subtest: rcs0
[334.683771] Dynamic subtest rcs0: SUCCESS (3.605s)
[334.694963] Starting dynamic subtest: bcs0
[338.251757] Dynamic subtest bcs0: SUCCESS (3.566s)
[338.263574] Starting dynamic subtest: vcs0
[342.466614] Dynamic subtest vcs0: SUCCESS (4.213s)
[342.478064] Starting dynamic subtest: vcs1
[346.496842] Dynamic subtest vcs1: SUCCESS (4.028s)
[346.506952] Starting dynamic subtest: vecs0
[350.464671] Dynamic subtest vecs0: SUCCESS (3.966s)
[350.478079] Starting dynamic subtest: ccs0
[354.099859] Dynamic subtest ccs0: FAIL (3.568s)
[354.101722] Subtest busy-double-start: FAIL (22.959s)
[354.161963] [056/134] (664s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[354.268459] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[354.272605] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[354.364616] [057/134] (664s left) prime_busy (hang-wait)
[354.437054] Starting subtest: hang-wait
[354.439341] Starting dynamic subtest: rcs0
[380.400276] Dynamic subtest rcs0: SUCCESS (25.962s)
[380.411073] Starting dynamic subtest: bcs0
[387.555308] Dynamic subtest bcs0: SUCCESS (7.149s)
[387.564690] Starting dynamic subtest: vcs0
[394.594017] Dynamic subtest vcs0: SUCCESS (7.037s)
[394.604314] Starting dynamic subtest: vcs1
[401.569227] Dynamic subtest vcs1: SUCCESS (6.972s)
[401.579350] Starting dynamic subtest: vecs0
[408.543936] Dynamic subtest vecs0: SUCCESS (6.976s)
[408.555321] Starting dynamic subtest: ccs0
[422.447646] Dynamic subtest ccs0: SUCCESS (13.898s)
[422.450099] Subtest hang-wait: SUCCESS (68.012s)
[422.597058] [058/134] (596s left) gem_exec_store (cachelines)
[422.662070] Starting subtest: cachelines
[422.664395] Starting dynamic subtest: rcs0
[422.789076] Dynamic subtest rcs0: SUCCESS (0.127s)
[422.800279] Starting dynamic subtest: bcs0
[422.860289] Dynamic subtest bcs0: SUCCESS (0.069s)
[422.868605] Starting dynamic subtest: vcs0
[422.923013] Dynamic subtest vcs0: SUCCESS (0.061s)
[422.931075] Starting dynamic subtest: vcs1
[422.983979] Dynamic subtest vcs1: SUCCESS (0.060s)
[422.992074] Starting dynamic subtest: vecs0
[423.047122] Dynamic subtest vecs0: SUCCESS (0.062s)
[423.055544] Starting dynamic subtest: ccs0
[423.113066] Dynamic subtest ccs0: SUCCESS (0.065s)
[423.115430] Subtest cachelines: SUCCESS (0.453s)
[423.307459] [059/134] (595s left) gem_exec_balancer (parallel-keep-submit-fence)
[423.570608] Starting subtest: parallel-keep-submit-fence
[424.773546] Subtest parallel-keep-submit-fence: SUCCESS (1.206s)
[424.898408] [060/134] (594s left) i915_drm_fdinfo (context-close-stress)
[424.932300] Starting subtest: context-close-stress
[435.678673] Subtest context-close-stress: SUCCESS (10.745s)
[435.778818] [061/134] (583s left) kms_getfb (getfb-handle-closed)
[436.036942] Starting subtest: getfb-handle-closed
[436.039212] Subtest getfb-handle-closed: SUCCESS (0.000s)
[436.163045] [062/134] (583s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[436.268088] Starting subtest: primary-x-tiled-reflect-x-180
[443.446192] Subtest primary-x-tiled-reflect-x-180: SUCCESS (7.179s)
[444.642274] [063/134] (574s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[444.738925] Starting subtest: pipe-fbc-rte
[444.745987] Starting dynamic subtest: pipe-B-eDP-1
[450.253601] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.518s)
[450.261153] Subtest pipe-fbc-rte: SUCCESS (5.521s)
[452.571755] [064/134] (566s left) kms_flip (bo-too-big-interruptible)
[452.668788] Starting subtest: bo-too-big-interruptible
[452.671525] Starting dynamic subtest: A-eDP1
[454.040242] Dynamic subtest A-eDP1: SUCCESS (1.368s)
[454.048779] Starting dynamic subtest: B-eDP1
[455.349348] Dynamic subtest B-eDP1: SUCCESS (1.308s)
[455.359608] Starting dynamic subtest: C-eDP1
[456.575513] Dynamic subtest C-eDP1: SUCCESS (1.225s)
[456.587321] Starting dynamic subtest: D-eDP1
[457.816566] Dynamic subtest D-eDP1: SUCCESS (1.240s)
[457.821339] Subtest bo-too-big-interruptible: SUCCESS (5.155s)
[459.024203] [065/134] (560s left) gem_softpin (reverse)
[459.096536] Starting subtest: reverse
[459.102138] Subtest reverse: SUCCESS (0.005s)
[459.240803] [066/134] (560s left) prime_vgem (basic-read)
[459.389693] Starting subtest: basic-read
[459.395505] Subtest basic-read: SKIP (0.006s)
[459.495898] [FACT prime_vgem (basic-read)] new: kernel.kmod_is_loaded.vgem: true
[459.499342] [067/134] (560s left) perf_pmu (pmu-read)
[459.539965] Starting subtest: pmu-read
[459.542205] Subtest pmu-read: SUCCESS (0.003s)
[459.650141] [068/134] (559s left) prime_self_import (basic-llseek-size)
[459.696671] Starting subtest: basic-llseek-size
[459.721462] Subtest basic-llseek-size: SUCCESS (0.026s)
[459.838131] [069/134] (559s left) kms_getfb (getfb2-accept-nv12)
[459.943098] Starting subtest: getfb2-accept-nv12
[459.945279] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[460.062919] [070/134] (559s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[460.175493] Starting subtest: basic-busy-flip-before-cursor-atomic
[460.179389] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[460.355582] [071/134] (559s left) sysfs_heartbeat_interval (invalid)
[460.408265] Starting subtest: invalid
[460.410171] Starting dynamic subtest: vecs0
[460.411996] Dynamic subtest vecs0: SUCCESS (0.000s)
[460.421534] Starting dynamic subtest: ccs0
[460.423256] Dynamic subtest ccs0: SUCCESS (0.000s)
[460.431340] Starting dynamic subtest: vcs0
[460.433090] Dynamic subtest vcs0: SUCCESS (0.000s)
[460.440686] Starting dynamic subtest: bcs0
[460.442178] Dynamic subtest bcs0: SUCCESS (0.000s)
[460.449492] Starting dynamic subtest: rcs0
[460.451222] Dynamic subtest rcs0: SUCCESS (0.000s)
[460.461092] Starting dynamic subtest: vcs1
[460.462647] Dynamic subtest vcs1: SUCCESS (0.000s)
[460.464570] Subtest invalid: SUCCESS (0.005s)
[460.532471] [072/134] (559s left) prime_mmap (test_forked_cpu_write)
[460.599878] Starting subtest: test_forked_cpu_write
[460.601784] Starting dynamic subtest: test_forked_cpu_write-smem
[460.606312] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.007s)
[460.608153] Subtest test_forked_cpu_write: SUCCESS (0.008s)
[460.716661] [073/134] (559s left) sw_sync (sync_busy_fork_unixsocket)
[460.750666] Starting subtest: sync_busy_fork_unixsocket
[460.761143] Subtest sync_busy_fork_unixsocket: SUCCESS (0.011s)
[460.855736] [074/134] (558s left) gem_render_copy (linear-to-vebox-yf-tiled)
[460.914661] Starting subtest: linear-to-vebox-yf-tiled
[460.918474] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[461.109524] [075/134] (558s left) kms_pm_rpm (modeset-lpsp)
[463.144124] Starting subtest: modeset-lpsp
[464.605920] Subtest modeset-lpsp: SUCCESS (1.465s)
[464.716172] [076/134] (555s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[464.807776] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[472.004431] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.200s)
[472.140263] [077/134] (547s left) gem_userptr_blits (sync-unmap-cycles)
[472.200129] Starting subtest: sync-unmap-cycles
[477.570590] Subtest sync-unmap-cycles: SUCCESS (5.370s)
[477.735612] [078/134] (542s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[477.847872] Starting subtest: y-tiled-8bpp-rotate-270
[477.851566] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[477.970690] [079/134] (542s left) kms_plane_scaling (planes-upscale-factor-0-25)
[478.069500] Starting subtest: planes-upscale-factor-0-25
[478.071461] Starting dynamic subtest: pipe-A
[478.141429] Dynamic subtest pipe-A: SUCCESS (0.073s)
[478.149800] Starting dynamic subtest: pipe-B
[479.326308] Dynamic subtest pipe-B: SUCCESS (1.183s)
[479.337378] Starting dynamic subtest: pipe-C
[480.432076] Dynamic subtest pipe-C: SUCCESS (1.105s)
[480.441069] Starting dynamic subtest: pipe-D
[481.560873] Dynamic subtest pipe-D: SUCCESS (1.128s)
[481.563323] Subtest planes-upscale-factor-0-25: SUCCESS (3.494s)
[482.734380] [080/134] (537s left) kms_async_flips (alternate-sync-async-flip)
[482.849322] Starting subtest: alternate-sync-async-flip
[483.237795] Starting dynamic subtest: pipe-A-eDP-1
[486.026719] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.791s)
[486.422073] Starting dynamic subtest: pipe-B-eDP-1
[489.165924] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.751s)
[489.558048] Starting dynamic subtest: pipe-C-eDP-1
[492.299535] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.749s)
[492.664302] Starting dynamic subtest: pipe-D-eDP-1
[495.428855] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.772s)
[495.431107] Subtest alternate-sync-async-flip: SUCCESS (12.581s)
[496.610260] [081/134] (523s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[496.712429] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[496.714853] Starting dynamic subtest: pipe-A-eDP-1
[496.724051] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[496.742464] Starting dynamic subtest: pipe-B-eDP-1
[496.750403] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[496.769130] Starting dynamic subtest: pipe-C-eDP-1
[496.777964] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[496.795235] Starting dynamic subtest: pipe-D-eDP-1
[496.803972] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[496.808113] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[498.961035] [082/134] (521s left) gen9_exec_parse (bb-secure)
[499.035086] Subtest bb-secure: SKIP (0.000s)
[499.096262] [083/134] (521s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[499.202944] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[508.322259] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.121s)
[508.483805] [084/134] (511s left) gem_exec_fence (submit67)
[508.667927] Starting subtest: submit67
[508.672803] Subtest submit67: SKIP (0.000s)
[510.027206] [085/134] (510s left) gem_ctx_persistence (engines-queued)
[510.093503] Starting subtest: engines-queued
[510.095942] Starting dynamic subtest: rcs0
[510.204551] Dynamic subtest rcs0: SUCCESS (0.111s)
[510.216573] Starting dynamic subtest: bcs0
[510.277842] Dynamic subtest bcs0: SUCCESS (0.071s)
[510.289258] Starting dynamic subtest: vcs0
[511.861616] Dynamic subtest vcs0: SUCCESS (1.580s)
[511.873757] Starting dynamic subtest: vcs1
[513.904659] Dynamic subtest vcs1: SUCCESS (2.041s)
[513.915783] Starting dynamic subtest: vecs0
[515.828141] Dynamic subtest vecs0: SUCCESS (1.921s)
[515.840266] Starting dynamic subtest: ccs0
[516.055828] Dynamic subtest ccs0: SUCCESS (0.226s)
[516.058346] Subtest engines-queued: SUCCESS (5.964s)
[516.214779] [086/134] (504s left) kms_chamelium_color (ctm-red-to-blue)
[516.303492] Subtest ctm-red-to-blue: SKIP (0.000s)
[516.348257] [087/134] (503s left) kms_psr2_su (page_flip-p010)
[516.404945] Subtest page_flip-P010: SKIP (0.000s)
[516.462994] [088/134] (503s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[516.553172] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[516.555373] Starting dynamic subtest: pipe-A-default-mode
[517.746150] Dynamic subtest pipe-A-default-mode: SKIP (1.190s)
[517.750178] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.191s)
[517.945533] [089/134] (502s left) i915_drm_fdinfo (virtual-idle)
[517.994609] Starting subtest: virtual-idle
[521.077685] Subtest virtual-idle: SUCCESS (3.083s)
[521.179402] [090/134] (499s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[521.235760] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[521.239762] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[521.431724] [091/134] (499s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[521.542805] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[521.547207] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[522.646480] [092/134] (497s left) kms_cursor_crc (cursor-onscreen-256x85)
[522.928058] Starting subtest: cursor-onscreen-256x85
[522.975388] Subtest cursor-onscreen-256x85: SKIP (0.041s)
[523.153831] [093/134] (497s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[523.405739] Starting subtest: cursor-rapid-movement-512x512
[523.410247] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[523.598350] [094/134] (497s left) i915_suspend (forcewake)
[523.651568] Starting subtest: forcewake
[556.188855] Subtest forcewake: SUCCESS (2.266s)
[556.266589] [095/134] (464s left) syncobj_timeline (signal-array)
[556.332223] Starting subtest: signal-array
[556.334760] Subtest signal-array: SUCCESS (0.000s)
[556.438008] [096/134] (464s left) gem_exec_params (batch-first)
[556.490034] Starting subtest: batch-first
[556.495890] Subtest batch-first: SUCCESS (0.006s)
[556.642940] [097/134] (464s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[556.745301] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[556.749806] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[556.866453] [098/134] (463s left) kms_psr (psr2-primary-mmap-gtt)
[556.968563] Starting subtest: psr2-primary-mmap-gtt
[556.970864] Starting dynamic subtest: eDP-1
[558.433732] Dynamic subtest eDP-1: SKIP (1.458s)
[558.438933] Subtest psr2-primary-mmap-gtt: SKIP (1.460s)
[558.563624] [099/134] (462s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[558.673157] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[558.677292] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[558.784636] [100/134] (462s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[558.882976] Starting subtest: fbc-rgb565-draw-mmap-gtt
[558.887423] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[559.004234] [101/134] (461s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[559.096278] Starting subtest: stress-xrgb8888-xtiled
[564.963937] Subtest stress-xrgb8888-xtiled: SUCCESS (5.855s)
[565.021662] [102/134] (455s left) gem_exec_params (rel-constants-invalid)
[565.082589] Starting subtest: rel-constants-invalid
[565.084632] Subtest rel-constants-invalid: SUCCESS (0.000s)
[565.207122] [103/134] (455s left) gem_eio (in-flight-external)
[565.433873] Starting subtest: in-flight-external
[567.241735] Subtest in-flight-external: SUCCESS (1.806s)
[567.416644] [104/134] (453s left) gem_wait (busy)
[567.477239] Starting subtest: busy
[567.479529] Starting dynamic subtest: all-engines
[569.155025] Dynamic subtest all-engines: SUCCESS (1.674s)
[569.167853] Starting dynamic subtest: rcs0
[569.695693] Dynamic subtest rcs0: SUCCESS (0.539s)
[569.707239] Starting dynamic subtest: bcs0
[570.235663] Dynamic subtest bcs0: SUCCESS (0.539s)
[570.247397] Starting dynamic subtest: vcs0
[572.162791] Dynamic subtest vcs0: SUCCESS (1.922s)
[572.175273] Starting dynamic subtest: vcs1
[574.146721] Dynamic subtest vcs1: SUCCESS (1.980s)
[574.158893] Starting dynamic subtest: vecs0
[576.130330] Dynamic subtest vecs0: SUCCESS (1.980s)
[576.141533] Starting dynamic subtest: ccs0
[576.673567] Dynamic subtest ccs0: SUCCESS (0.542s)
[576.675872] Subtest busy: SUCCESS (9.189s)
[576.882639] [105/134] (444s left) fbdev (pan)
[576.923692] Starting subtest: pan
[576.944104] Subtest pan: SUCCESS (0.026s)
[577.029481] [106/134] (444s left) kms_chamelium_hpd (hdmi-hpd-storm)
[577.410887] Subtest hdmi-hpd-storm: SKIP (0.000s)
[578.200861] [107/134] (442s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[578.296360] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[584.806979] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.511s)
[584.944751] [108/134] (436s left) kms_async_flips (test-time-stamp-atomic)
[585.035401] Starting subtest: test-time-stamp-atomic
[585.421367] Starting dynamic subtest: pipe-A-eDP-1
[586.186732] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.765s)
[586.556621] Starting dynamic subtest: pipe-B-eDP-1
[587.320294] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.773s)
[587.701996] Starting dynamic subtest: pipe-C-eDP-1
[588.459148] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.764s)
[588.820971] Starting dynamic subtest: pipe-D-eDP-1
[589.588344] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.772s)
[589.590779] Subtest test-time-stamp-atomic: SUCCESS (4.551s)
[590.789822] [109/134] (430s left) kms_psr (pr-sprite-mmap-gtt)
[590.894611] Starting subtest: pr-sprite-mmap-gtt
[590.898967] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[590.978377] [110/134] (430s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[591.068772] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[591.072986] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[591.219815] [111/134] (430s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[591.316637] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[592.306325] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (0.988s)
[592.447941] [112/134] (428s left) gem_exec_schedule (smoketest-all)
[592.523846] Starting subtest: smoketest-all
[624.928688] Subtest smoketest-all: SUCCESS (32.348s)
[626.295164] [113/134] (395s left) vgem_basic (create)
[626.353438] Starting subtest: create
[626.355637] Subtest create: SUCCESS (0.000s)
[626.423316] [114/134] (395s left) gem_ctx_isolation (dirty-create)
[626.503688] Starting subtest: dirty-create
[626.505962] Starting dynamic subtest: rcs0
[626.771403] Dynamic subtest rcs0: SUCCESS (0.267s)
[626.780843] Starting dynamic subtest: bcs0
[627.039525] Dynamic subtest bcs0: SUCCESS (0.266s)
[627.048617] Starting dynamic subtest: vcs0
[627.320688] Dynamic subtest vcs0: SUCCESS (0.281s)
[627.329561] Starting dynamic subtest: vcs1
[629.413873] Dynamic subtest vcs1: SUCCESS (2.091s)
[629.423055] Starting dynamic subtest: vecs0
[631.402082] Dynamic subtest vecs0: SUCCESS (1.986s)
[631.414175] Starting dynamic subtest: ccs0
[633.368638] Dynamic subtest ccs0: SUCCESS (1.965s)
[633.371137] Subtest dirty-create: SUCCESS (6.863s)
[633.656297] [115/134] (387s left) kms_content_protection (uevent-hdcp14)
[633.802313] Starting subtest: uevent-hdcp14
[633.806886] Subtest uevent-hdcp14: SKIP (0.000s)
[633.949225] [116/134] (387s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[634.006672] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[634.112277] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.104s)
[634.199945] [117/134] (387s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[634.298961] Starting subtest: yf-tiled-32bpp-rotate-180
[634.303308] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[634.411627] [118/134] (387s left) gem_sync (basic-many-each)
[634.479934] Starting subtest: basic-many-each
[636.775726] Subtest basic-many-each: SUCCESS (2.305s)
[636.990296] [119/134] (384s left) kms_cursor_edge_walk (256x256-right-edge)
[637.084413] Starting subtest: 256x256-right-edge
[637.086554] Starting dynamic subtest: pipe-A-eDP-1
[640.539020] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.453s)
[640.549232] Starting dynamic subtest: pipe-D-eDP-1
[643.657458] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.116s)
[643.659930] Subtest 256x256-right-edge: SUCCESS (6.572s)
[644.475596] [120/134] (377s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[644.603889] Starting subtest: basic-flip-before-cursor-atomic
[645.537852] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.933s)
[646.428758] [121/134] (375s left) kms_flip (nonblocking-read)
[646.523254] Starting subtest: nonblocking-read
[646.525118] Subtest nonblocking-read: SUCCESS (0.000s)
[646.651277] [122/134] (375s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[646.752732] Starting subtest: yf-tiled-64bpp-rotate-180
[646.756676] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[646.862631] [123/134] (374s left) gem_exec_reloc (basic-wc-gtt-active)
[646.916964] Subtest basic-wc-gtt-active: SKIP (0.000s)
[646.990179] [124/134] (374s left) gem_mmap_wc (write-prefaulted)
[647.049107] Subtest write-prefaulted: SKIP (0.000s)
[647.106674] [125/134] (374s left) api_intel_bb (full-batch)
[647.171994] Starting subtest: full-batch
[647.177105] Subtest full-batch: SUCCESS (0.005s)
[647.332657] [126/134] (374s left) gem_eio (in-flight-internal-10ms)
[647.602425] Starting subtest: in-flight-internal-10ms
[649.233053] Subtest in-flight-internal-10ms: SUCCESS (1.629s)
[649.380101] [127/134] (372s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[649.478651] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[649.482555] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[649.586950] [128/134] (372s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[649.696828] Starting subtest: cursorA-vs-flipA-toggle
[660.824094] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.133s)
[661.628763] [129/134] (360s left) syncobj_timeline (etime-multi-wait-all-submitted)
[661.679929] Starting subtest: etime-multi-wait-all-submitted
[661.784152] Subtest etime-multi-wait-all-submitted: SUCCESS (0.104s)
[661.874697] [130/134] (360s left) gem_exec_reloc (basic-cpu-noreloc)
[661.925410] Subtest basic-cpu-noreloc: SKIP (0.000s)
[661.997997] [131/134] (360s left) gem_mmap (bad-offset)
[662.056416] Subtest bad-offset: SKIP (0.000s)
[662.126469] [132/134] (360s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[662.236081] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[662.240708] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[662.404421] [133/134] (359s left) i915_pm_rc6_residency (rc6-idle)
[662.451695] Starting subtest: rc6-idle
[662.496983] Starting dynamic subtest: gt0-rcs0
[686.832780] Dynamic subtest gt0-rcs0: SUCCESS (24.344s)
[686.841842] Starting dynamic subtest: gt0-bcs0
[711.101007] Dynamic subtest gt0-bcs0: SUCCESS (24.266s)
[711.112387] Starting dynamic subtest: gt0-ccs0
[735.370791] Dynamic subtest gt0-ccs0: SUCCESS (24.265s)
[735.382268] Starting dynamic subtest: gt1-vcs0
[741.545131] Dynamic subtest gt1-vcs0: SUCCESS (6.169s)
[741.557380] Starting dynamic subtest: gt1-vecs0
[747.719034] Dynamic subtest gt1-vecs0: SUCCESS (6.169s)
[747.722377] Subtest rc6-idle: SUCCESS (85.271s)
[747.811421] [134/134] (274s left) kms_psr (fbc-psr2-primary-page-flip)
[747.914577] Starting subtest: fbc-psr2-primary-page-flip
[747.916885] Starting dynamic subtest: eDP-1
[747.921371] Dynamic subtest eDP-1: SKIP (0.000s)
[747.925537] Subtest fbc-psr2-primary-page-flip: SKIP (0.002s)
[748.011371] Closing watchdogs
results: parsing output: 0/ for test: kms_pm_rpm
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: gem_lmem_swapping
results: parsing output: 3/ for test: kms_plane
results: parsing output: 4/ for test: gem_exec_reloc
results: parsing output: 5/ for test: kms_psr2_sf
results: parsing output: 6/ for test: kms_cdclk
results: parsing output: 7/ for test: gem_mmap_gtt
results: parsing output: 8/ for test: kms_psr
results: parsing output: 9/ for test: gem_exec_schedule
results: parsing output: 10/ for test: api_intel_bb
results: parsing output: 11/ for test: kms_big_fb
results: parsing output: 12/ for test: kms_cursor_legacy
results: parsing output: 13/ for test: kms_setmode
results: parsing output: 14/ for test: i915_query
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_dsc
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: gem_ctx_shared
results: parsing output: 20/ for test: kms_joiner
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_multipipe_modeset
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_atomic_interruptible
results: parsing output: 25/ for test: gem_exec_suspend
results: parsing output: 26/ for test: kms_properties
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_plane_multiple
results: parsing output: 29/ for test: i915_query
results: parsing output: 30/ for test: gem_exec_schedule
results: parsing output: 31/ for test: syncobj_timeline
results: parsing output: 32/ for test: kms_plane
results: parsing output: 33/ for test: kms_ccs
results: parsing output: 34/ for test: kms_universal_plane
results: parsing output: 35/ for test: gem_ccs
results: parsing output: 36/ for test: gem_tiled_blits
results: parsing output: 37/ for test: kms_color_pipeline
results: parsing output: 38/ for test: kms_dirtyfb
results: parsing output: 39/ for test: core_sysfs
results: parsing output: 40/ for test: kms_scaling_modes
results: parsing output: 41/ for test: gem_caching
results: parsing output: 42/ for test: kms_flip_scaled_crc
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: gem_exec_balancer
results: parsing output: 45/ for test: kms_vblank
results: parsing output: 46/ for test: gem_exec_reloc
results: parsing output: 47/ for test: syncobj_timeline
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: kms_flip_scaled_crc
results: parsing output: 50/ for test: gem_flink_race
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: kms_properties
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: perf_pmu
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: prime_busy
results: parsing output: 57/ for test: gem_exec_store
results: parsing output: 58/ for test: gem_exec_balancer
results: parsing output: 59/ for test: i915_drm_fdinfo
results: parsing output: 60/ for test: kms_getfb
results: parsing output: 61/ for test: kms_rotation_crc
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: gem_softpin
results: parsing output: 65/ for test: prime_vgem
results: parsing output: 66/ for test: perf_pmu
results: parsing output: 67/ for test: prime_self_import
results: parsing output: 68/ for test: kms_getfb
results: parsing output: 69/ for test: kms_cursor_legacy
results: parsing output: 70/ for test: sysfs_heartbeat_interval
results: parsing output: 71/ for test: prime_mmap
results: parsing output: 72/ for test: sw_sync
results: parsing output: 73/ for test: gem_render_copy
results: parsing output: 74/ for test: kms_pm_rpm
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_userptr_blits
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: kms_plane_scaling
results: parsing output: 79/ for test: kms_async_flips
results: parsing output: 80/ for test: kms_ccs
results: parsing output: 81/ for test: gen9_exec_parse
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: gem_exec_fence
results: parsing output: 84/ for test: gem_ctx_persistence
results: parsing output: 85/ for test: kms_chamelium_color
results: parsing output: 86/ for test: kms_psr2_su
results: parsing output: 87/ for test: kms_flip_scaled_crc
results: parsing output: 88/ for test: i915_drm_fdinfo
results: parsing output: 89/ for test: gem_render_copy
results: parsing output: 90/ for test: kms_ccs
results: parsing output: 91/ for test: kms_cursor_crc
results: parsing output: 92/ for test: kms_cursor_crc
results: parsing output: 93/ for test: i915_suspend
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: gem_exec_params
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_pipe_stress
results: parsing output: 101/ for test: gem_exec_params
results: parsing output: 102/ for test: gem_eio
results: parsing output: 103/ for test: gem_wait
results: parsing output: 104/ for test: fbdev
results: parsing output: 105/ for test: kms_chamelium_hpd
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_async_flips
results: parsing output: 108/ for test: kms_psr
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: gem_exec_schedule
results: parsing output: 112/ for test: vgem_basic
results: parsing output: 113/ for test: gem_ctx_isolation
results: parsing output: 114/ for test: kms_content_protection
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: gem_sync
results: parsing output: 118/ for test: kms_cursor_edge_walk
results: parsing output: 119/ for test: kms_cursor_legacy
results: parsing output: 120/ for test: kms_flip
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: gem_exec_reloc
results: parsing output: 123/ for test: gem_mmap_wc
results: parsing output: 124/ for test: api_intel_bb
results: parsing output: 125/ for test: gem_eio
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_cursor_legacy
results: parsing output: 128/ for test: syncobj_timeline
results: parsing output: 129/ for test: gem_exec_reloc
results: parsing output: 130/ for test: gem_mmap
results: parsing output: 131/ for test: kms_cursor_legacy
results: parsing output: 132/ for test: i915_pm_rc6_residency
results: parsing output: 133/ for test: kms_psr
Done.