[66.627900] Initializing watchdogs
[66.627947]   /dev/watchdog0
[66.641639] [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]
[66.646121] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[66.648323] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[66.651601] [001/133] (960s left) perf (invalid-open-flags)
[66.802366] Starting subtest: invalid-open-flags
[66.804749] Subtest invalid-open-flags: SUCCESS (0.000s)
[66.852534] [002/133] (960s left) gem_vm_create (create-ext)
[66.906395] Starting subtest: create-ext
[66.915219] Subtest create-ext: SUCCESS (0.009s)
[67.083161] [003/133] (960s left) gem_exec_params (rel-constants-invalid)
[67.141056] Starting subtest: rel-constants-invalid
[67.143371] Subtest rel-constants-invalid: SUCCESS (0.000s)
[67.260584] [004/133] (960s left) kms_universal_plane (universal-plane-functional)
[67.373055] Starting subtest: universal-plane-functional
[67.375575] Starting dynamic subtest: pipe-A-eDP-1
[71.384762] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.014s)
[71.394065] Starting dynamic subtest: pipe-B-eDP-1
[75.871218] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.486s)
[75.880640] Starting dynamic subtest: pipe-C-eDP-1
[80.215973] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.346s)
[80.224701] Starting dynamic subtest: pipe-D-eDP-1
[84.599965] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.384s)
[84.602286] Subtest universal-plane-functional: SUCCESS (17.235s)
[85.406091] [005/133] (941s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[85.517409] Starting subtest: basic-max-pipe-crc-check
[85.521594] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[85.560628] [006/133] (941s left) i915_suspend (fence-restore-tiled2untiled)
[85.619035] Starting subtest: fence-restore-tiled2untiled
[85.623545] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[85.741289] [007/133] (941s left) kms_feature_discovery (display-3x)
[85.836992] Starting subtest: display-3x
[85.841376] Subtest display-3x: SKIP (0.000s)
[85.932584] [008/133] (941s left) gem_mmap_wc (close)
[85.988359] Subtest close: SKIP (0.000s)
[86.045297] [009/133] (941s left) dmabuf_sync_file (import-multiple-read-write)
[86.107138] Starting subtest: import-multiple-read-write
[86.109415] Subtest import-multiple-read-write: SUCCESS (0.003s)
[86.167610] [FACT dmabuf_sync_file (import-multiple-read-write)] new: kernel.kmod_is_loaded.vgem: true
[86.170932] [010/133] (941s left) gem_exec_balancer (parallel-keep-in-fence)
[86.417695] Starting subtest: parallel-keep-in-fence
[87.582054] Subtest parallel-keep-in-fence: SUCCESS (1.165s)
[87.701701] [011/133] (939s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[87.796337] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[87.800196] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[87.904240] [012/133] (939s left) perf_pmu (rc6-suspend)
[87.943722] Starting subtest: rc6-suspend
[110.790726] Subtest rc6-suspend: SUCCESS (7.595s)
[111.696892] [013/133] (915s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[111.810595] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[111.812540] Starting dynamic subtest: pipe-A-eDP-1
[111.830402] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[111.838300] Starting dynamic subtest: pipe-B-eDP-1
[111.854216] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[111.861666] Starting dynamic subtest: pipe-C-eDP-1
[111.877061] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[111.884589] Starting dynamic subtest: pipe-D-eDP-1
[111.900767] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[111.902422] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s)
[113.987011] [014/133] (913s left) kms_plane_cursor (primary)
[114.081316] Starting subtest: primary
[114.085866] Starting dynamic subtest: pipe-A-eDP-1-size-64
[116.662883] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.585s)
[116.687930] Starting dynamic subtest: pipe-A-eDP-1-size-128
[119.250434] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.571s)
[119.275494] Starting dynamic subtest: pipe-A-eDP-1-size-256
[121.860065] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.594s)
[122.173048] Starting dynamic subtest: pipe-B-eDP-1-size-64
[125.482980] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.319s)
[125.504827] Starting dynamic subtest: pipe-B-eDP-1-size-128
[128.103012] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.606s)
[128.126317] Starting dynamic subtest: pipe-B-eDP-1-size-256
[130.680355] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.560s)
[130.994188] Starting dynamic subtest: pipe-C-eDP-1-size-64
[133.889628] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.906s)
[133.915157] Starting dynamic subtest: pipe-C-eDP-1-size-128
[136.121423] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.213s)
[136.147431] Starting dynamic subtest: pipe-C-eDP-1-size-256
[138.366698] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.225s)
[138.682026] Starting dynamic subtest: pipe-D-eDP-1-size-64
[141.636482] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.963s)
[141.668645] Starting dynamic subtest: pipe-D-eDP-1-size-128
[143.848426] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.191s)
[143.874293] Starting dynamic subtest: pipe-D-eDP-1-size-256
[146.059703] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.191s)
[146.368173] Subtest primary: SUCCESS (32.301s)
[147.179340] [015/133] (880s left) gem_ctx_param (invalid-ctx-get)
[147.230994] Starting subtest: invalid-ctx-get
[147.233447] Subtest invalid-ctx-get: SUCCESS (0.000s)
[147.319442] [016/133] (880s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[147.377244] Starting subtest: single-wait-all-for-submit-signaled
[147.379423] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[147.490368] [017/133] (880s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[147.586006] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[147.590433] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[147.706507] [018/133] (880s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[147.802910] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[152.217999] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.419s)
[153.375986] [019/133] (874s left) kms_chamelium_edid (hdmi-edid-read)
[153.774699] Subtest hdmi-edid-read: SKIP (0.000s)
[154.567042] [020/133] (873s left) gem_busy (extended)
[154.759119] Starting subtest: extended
[154.761868] Starting dynamic subtest: rcs0
[154.859634] Dynamic subtest rcs0: SUCCESS (0.101s)
[154.870598] Starting dynamic subtest: bcs0
[154.902594] Dynamic subtest bcs0: SUCCESS (0.041s)
[154.912335] Starting dynamic subtest: vcs0
[156.143582] Dynamic subtest vcs0: SUCCESS (1.237s)
[156.155278] Starting dynamic subtest: vcs1
[158.192437] Dynamic subtest vcs1: SUCCESS (2.046s)
[158.204893] Starting dynamic subtest: vecs0
[160.177139] Dynamic subtest vecs0: SUCCESS (1.982s)
[160.190694] Starting dynamic subtest: ccs0
[160.223622] Dynamic subtest ccs0: SUCCESS (0.045s)
[160.226171] Subtest extended: SUCCESS (5.466s)
[160.483411] [021/133] (867s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[160.577116] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs
[160.579390] Starting dynamic subtest: pipe-A-eDP-1
[160.602181] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[160.612788] Starting dynamic subtest: pipe-B-eDP-1
[160.634395] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[160.643406] Starting dynamic subtest: pipe-C-eDP-1
[160.664926] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[160.673474] Starting dynamic subtest: pipe-D-eDP-1
[160.695202] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[160.699254] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[162.881372] [022/133] (865s left) kms_pm_backlight (brightness-with-dpms)
[162.983266] Starting subtest: brightness-with-dpms
[163.058930] Starting dynamic subtest: eDP-1
[165.460972] Dynamic subtest eDP-1: SUCCESS (2.401s)
[165.463310] Subtest brightness-with-dpms: SUCCESS (2.479s)
[166.333762] [023/133] (861s left) gem_softpin (noreloc-interruptible)
[166.392328] Starting subtest: noreloc-interruptible
[171.820171] Subtest noreloc-interruptible: SUCCESS (5.427s)
[171.987750] [024/133] (856s left) gem_exec_parallel (contexts)
[172.063302] Starting subtest: contexts
[172.066041] Starting dynamic subtest: rcs0
[175.735288] Dynamic subtest rcs0: SUCCESS (3.675s)
[175.746380] Starting dynamic subtest: bcs0
[179.220009] Dynamic subtest bcs0: SUCCESS (3.484s)
[179.231165] Starting dynamic subtest: vcs0
[183.531362] Dynamic subtest vcs0: SUCCESS (4.311s)
[183.542869] Starting dynamic subtest: vcs1
[187.543938] Dynamic subtest vcs1: SUCCESS (4.010s)
[187.553562] Starting dynamic subtest: vecs0
[191.559116] Dynamic subtest vecs0: SUCCESS (4.015s)
[191.591064] Starting dynamic subtest: ccs0
[195.009198] Dynamic subtest ccs0: SUCCESS (3.447s)
[195.011900] Subtest contexts: SUCCESS (22.954s)
[195.213033] [025/133] (832s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[195.279625] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[195.388003] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.107s)
[195.488150] [026/133] (832s left) kms_cursor_legacy (single-move)
[195.618377] Starting subtest: single-move
[195.620682] Starting dynamic subtest: pipe-A
[201.000838] Dynamic subtest pipe-A: SUCCESS (5.379s)
[201.011194] Starting dynamic subtest: pipe-B
[206.384092] Dynamic subtest pipe-B: SUCCESS (5.379s)
[206.394997] Starting dynamic subtest: pipe-C
[211.768752] Dynamic subtest pipe-C: SUCCESS (5.379s)
[211.778964] Starting dynamic subtest: pipe-D
[217.149905] Dynamic subtest pipe-D: SUCCESS (5.379s)
[217.160157] Starting dynamic subtest: all-pipes
[222.539722] Dynamic subtest all-pipes: SUCCESS (5.387s)
[222.542103] Subtest single-move: SUCCESS (26.916s)
[222.727818] [027/133] (805s left) i915_pm_rpm (gem-evict-pwrite)
[224.376574] Starting subtest: gem-evict-pwrite
[224.381197] Subtest gem-evict-pwrite: SKIP (0.000s)
[225.059104] [028/133] (803s left) kms_properties (invalid-properties-atomic)
[225.151038] Starting subtest: invalid-properties-atomic
[225.454097] Subtest invalid-properties-atomic: SUCCESS (0.303s)
[225.538099] [029/133] (802s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[225.641466] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[232.550635] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.910s)
[232.722227] [030/133] (795s left) prime_mmap (test_invalid_sync_flags)
[232.784242] Starting subtest: test_invalid_sync_flags
[232.786459] Starting dynamic subtest: test_invalid_sync_flags-smem
[232.788347] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[232.790201] Subtest test_invalid_sync_flags: SUCCESS (0.001s)
[232.908175] [031/133] (795s left) kms_vblank (query-forked-busy)
[233.001059] Starting subtest: query-forked-busy
[233.003281] Starting dynamic subtest: pipe-A-eDP-1
[234.874720] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s)
[234.887901] Starting dynamic subtest: pipe-D-eDP-1
[237.425003] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.547s)
[237.427176] Subtest query-forked-busy: SUCCESS (4.425s)
[238.240743] [032/133] (790s left) gem_ctx_param (non-root-set)
[238.296569] Starting subtest: non-root-set
[238.316518] Subtest non-root-set: SUCCESS (0.020s)
[238.430497] [033/133] (789s left) gem_mmap_gtt (close-race)
[238.487773] Subtest close-race: SKIP (0.000s)
[238.546885] [034/133] (789s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[238.641198] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[238.643457] Starting dynamic subtest: pipe-A-default-mode
[238.943164] Dynamic subtest pipe-A-default-mode: SKIP (0.301s)
[238.947574] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.302s)
[239.776851] [035/133] (788s left) gem_partial_pwrite_pread (write-snoop)
[239.825797] Subtest write-snoop: SKIP (0.000s)
[239.893758] [036/133] (788s left) syncobj_wait (single-wait-signaled)
[239.955402] Starting subtest: single-wait-signaled
[239.957609] Subtest single-wait-signaled: SUCCESS (0.000s)
[240.080873] [037/133] (788s left) kms_setmode (basic-clone-single-crtc)
[240.129327] Starting subtest: basic-clone-single-crtc
[240.135378] Subtest basic-clone-single-crtc: SKIP (0.001s)
[240.262163] [038/133] (788s left) gem_ctx_shared (q-promotion)
[240.312217] Starting subtest: Q-promotion
[240.314562] Starting dynamic subtest: rcs0
[240.440341] Dynamic subtest rcs0: SUCCESS (0.126s)
[240.452890] Starting dynamic subtest: vcs0
[240.553682] Dynamic subtest vcs0: SUCCESS (0.114s)
[240.569404] Starting dynamic subtest: vcs1
[240.635847] Dynamic subtest vcs1: SUCCESS (0.081s)
[240.650958] Starting dynamic subtest: vecs0
[240.719719] Dynamic subtest vecs0: SUCCESS (0.082s)
[240.736294] Starting dynamic subtest: ccs0
[240.811537] Dynamic subtest ccs0: SUCCESS (0.090s)
[240.813815] Subtest Q-promotion: SUCCESS (0.499s)
[242.270928] [039/133] (786s left) prime_vgem (coherency-blt)
[242.337297] Starting subtest: coherency-blt
[244.206309] Subtest coherency-blt: SUCCESS (1.870s)
[244.386976] [040/133] (784s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[244.492002] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[244.494255] Starting dynamic subtest: pipe-A-eDP-1
[244.516917] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[244.528385] Starting dynamic subtest: pipe-B-eDP-1
[244.549214] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[244.558286] Starting dynamic subtest: pipe-C-eDP-1
[244.579483] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[244.588590] Starting dynamic subtest: pipe-D-eDP-1
[244.610908] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[244.614918] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[246.750810] [041/133] (781s left) gem_spin_batch (resubmit)
[246.804690] Starting subtest: resubmit
[246.807064] Starting dynamic subtest: rcs0
[246.811908] Dynamic subtest rcs0: SUCCESS (0.007s)
[246.822323] Starting dynamic subtest: bcs0
[246.824672] Dynamic subtest bcs0: SUCCESS (0.002s)
[246.834448] Starting dynamic subtest: vcs0
[246.836686] Dynamic subtest vcs0: SUCCESS (0.002s)
[246.845673] Starting dynamic subtest: vcs1
[246.847911] Dynamic subtest vcs1: SUCCESS (0.003s)
[246.856607] Starting dynamic subtest: vecs0
[246.858809] Dynamic subtest vecs0: SUCCESS (0.002s)
[246.867661] Starting dynamic subtest: ccs0
[246.869888] Dynamic subtest ccs0: SUCCESS (0.002s)
[246.872093] Subtest resubmit: SUCCESS (0.022s)
[247.082331] [042/133] (781s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[247.199989] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[247.204440] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[247.368645] [043/133] (781s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[247.473448] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[247.475775] Starting dynamic subtest: pipe-A-default-mode
[250.149971] Dynamic subtest pipe-A-default-mode: SUCCESS (2.677s)
[250.152411] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.679s)
[251.020707] [044/133] (777s left) kms_async_flips (invalid-async-flip-atomic)
[251.120412] Starting subtest: invalid-async-flip-atomic
[251.510264] Starting dynamic subtest: pipe-A-eDP-1
[252.907762] Dynamic subtest pipe-A-eDP-1: FAIL (0.809s)
[252.918022] Starting dynamic subtest: pipe-B-eDP-1
[253.839732] Dynamic subtest pipe-B-eDP-1: FAIL (0.745s)
[253.850301] Starting dynamic subtest: pipe-C-eDP-1
[254.592614] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.783s)
[254.945862] Starting dynamic subtest: pipe-D-eDP-1
[255.722487] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.784s)
[255.724939] Subtest invalid-async-flip-atomic: FAIL (4.605s)
[256.880817] [045/133] (772s left) kms_busy (extended-modeset-hang-oldfb)
[256.981456] Starting subtest: extended-modeset-hang-oldfb
[256.983805] Starting dynamic subtest: pipe-A
[268.649833] Dynamic subtest pipe-A: SUCCESS (11.665s)
[268.659840] Starting dynamic subtest: pipe-D
[280.901567] Dynamic subtest pipe-D: SUCCESS (12.253s)
[280.903953] Subtest extended-modeset-hang-oldfb: SUCCESS (23.923s)
[281.698539] [046/133] (747s left) kms_plane_multiple (2x-tiling-y)
[281.791151] Starting subtest: 2x-tiling-y
[281.795259] Subtest 2x-tiling-y: SKIP (0.000s)
[281.875566] [047/133] (747s left) kms_cursor_crc (cursor-sliding-32x32)
[282.023481] Starting subtest: cursor-sliding-32x32
[282.073040] Subtest cursor-sliding-32x32: SKIP (0.044s)
[282.399649] [048/133] (746s left) perf (gen12-group-exclusive-stream-ctx-handle)
[282.495746] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[282.521904] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.028s)
[282.569605] [049/133] (746s left) gem_mmap_gtt (hang)
[284.115918] Subtest hang: SKIP (0.000s)
[284.197138] [050/133] (744s left) gem_ctx_persistence (engines-queued)
[284.254426] Starting subtest: engines-queued
[284.256598] Starting dynamic subtest: rcs0
[284.346783] Dynamic subtest rcs0: SUCCESS (0.095s)
[284.358267] Starting dynamic subtest: bcs0
[284.381403] Dynamic subtest bcs0: SUCCESS (0.033s)
[284.390745] Starting dynamic subtest: vcs0
[286.161685] Dynamic subtest vcs0: SUCCESS (1.777s)
[286.173156] Starting dynamic subtest: vcs1
[288.078679] Dynamic subtest vcs1: SUCCESS (1.914s)
[288.091163] Starting dynamic subtest: vecs0
[289.101371] Dynamic subtest vecs0: SUCCESS (1.020s)
[289.112680] Starting dynamic subtest: ccs0
[289.317690] Dynamic subtest ccs0: SUCCESS (0.216s)
[289.320145] Subtest engines-queued: SUCCESS (5.067s)
[289.422667] [051/133] (739s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[289.528763] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[290.642062] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.113s)
[290.784964] [052/133] (738s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[290.886257] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[290.889508] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[291.007159] [053/133] (738s left) kms_content_protection (atomic)
[291.154765] Starting subtest: atomic
[291.158773] Subtest atomic: SKIP (0.000s)
[291.304767] [054/133] (737s left) kms_flip (flip-vs-panning-vs-hang)
[291.402028] Starting subtest: flip-vs-panning-vs-hang
[291.403743] Starting dynamic subtest: A-eDP1
[342.686881] Dynamic subtest A-eDP1: SUCCESS (51.288s)
[342.697929] Starting dynamic subtest: D-eDP1
[392.669469] Dynamic subtest D-eDP1: SUCCESS (49.976s)
[392.671763] Subtest flip-vs-panning-vs-hang: SUCCESS (101.267s)
[393.873475] [055/133] (635s left) i915_query (query-topology-known-pci-ids)
[393.925690] Starting subtest: query-topology-known-pci-ids
[393.929982] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[394.069485] [056/133] (635s left) gem_mmap_offset (clear-via-pagefault)
[394.122198] Starting subtest: clear-via-pagefault
[394.124022] Starting dynamic subtest: smem0
[424.746083] Dynamic subtest smem0: SUCCESS (30.621s)
[424.751194] Subtest clear-via-pagefault: SUCCESS (30.623s)
[424.875076] [057/133] (604s left) perf_pmu (frequency)
[424.911587] Starting subtest: frequency
[424.916697] Starting dynamic subtest: gt0
[427.132083] Dynamic subtest gt0: SUCCESS (2.210s)
[427.143268] Starting dynamic subtest: idle-gt0
[427.638612] Dynamic subtest idle-gt0: SUCCESS (0.505s)
[427.650953] Starting dynamic subtest: gt1
[432.203680] Dynamic subtest gt1: SUCCESS (4.560s)
[432.213251] Starting dynamic subtest: idle-gt1
[432.708578] Dynamic subtest idle-gt1: SUCCESS (0.504s)
[432.711515] Subtest frequency: SUCCESS (7.799s)
[432.838517] [058/133] (596s left) gem_tiled_partial_pwrite_pread (writes)
[432.907516] Subtest writes: SKIP (0.000s)
[432.993899] [059/133] (596s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[433.090530] Starting subtest: x-tiled-8bpp-rotate-0
[434.301406] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.212s)
[434.448204] [060/133] (595s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[434.545080] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[441.633607] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.091s)
[441.759543] [061/133] (587s left) kms_psr2_su (page_flip-p010)
[441.824823] Subtest page_flip-P010: SKIP (0.000s)
[441.890219] [062/133] (587s left) kms_colorop (plane-xr30-xr30-srgb_inv_eotf_lut-srgb_eotf_lut)
[442.029462] Subtest plane-XR30-XR30-srgb_inv_eotf_lut-srgb_eotf_lut: SKIP (0.000s)
[442.108768] [063/133] (587s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[442.220890] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[459.882209] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.659s)
[460.697344] [064/133] (568s left) kms_colorop (plane-xr24-xr24-srgb_inv_eotf)
[460.832393] Subtest plane-XR24-XR24-srgb_inv_eotf: SKIP (0.000s)
[460.927587] [065/133] (568s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[460.987641] Starting subtest: multi-wait-all-available-submitted-signaled
[460.989600] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s)
[461.108680] [066/133] (568s left) kms_frontbuffer_tracking (psr-2p-rte)
[461.209499] Starting subtest: psr-2p-rte
[461.213385] Subtest psr-2p-rte: SKIP (0.000s)
[461.342563] [067/133] (568s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[461.397217] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[461.399442] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[461.517522] [068/133] (568s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[466.538348] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf
[466.542947] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.002s)
[467.413936] [069/133] (562s left) gem_close_race (multigpu-basic-process)
[467.475933] Starting subtest: multigpu-basic-process
[467.480482] Subtest multigpu-basic-process: SKIP (0.000s)
[467.756139] [070/133] (562s left) prime_vgem (fence-read-hang)
[467.845294] Subtest fence-read-hang: SKIP (0.000s)
[467.975725] [071/133] (562s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[468.066983] Starting subtest: fbc-psr2-cursor-mmap-gtt
[468.069299] Starting dynamic subtest: eDP-1
[468.073700] Dynamic subtest eDP-1: SKIP (0.000s)
[468.078018] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[468.163500] [072/133] (561s left) kms_cursor_crc (cursor-onscreen-32x10)
[468.321266] Starting subtest: cursor-onscreen-32x10
[468.368669] Subtest cursor-onscreen-32x10: SKIP (0.043s)
[468.653450] [073/133] (561s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[468.740732] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[475.302450] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.562s)
[475.436639] [074/133] (554s left) perf_pmu (busy-double-start)
[475.474365] Starting subtest: busy-double-start
[475.476588] Starting dynamic subtest: rcs0
[479.108644] Dynamic subtest rcs0: FAIL (3.569s)
[479.119641] Starting dynamic subtest: bcs0
[482.650160] Dynamic subtest bcs0: SUCCESS (3.607s)
[482.662573] Starting dynamic subtest: vcs0
[486.729992] Dynamic subtest vcs0: SUCCESS (4.078s)
[486.742047] Starting dynamic subtest: vcs1
[490.723367] Dynamic subtest vcs1: SUCCESS (3.991s)
[490.735517] Starting dynamic subtest: vecs0
[494.699939] Dynamic subtest vecs0: SUCCESS (3.975s)
[494.711544] Starting dynamic subtest: ccs0
[498.334536] Dynamic subtest ccs0: FAIL (3.565s)
[498.337232] Subtest busy-double-start: FAIL (22.796s)
[498.434399] [075/133] (531s left) gem_mmap_wc (bad-offset)
[498.499152] Subtest bad-offset: SKIP (0.000s)
[498.568009] [076/133] (531s left) gem_basic (create-fd-close)
[498.623088] Starting subtest: create-fd-close
[498.627753] Subtest create-fd-close: SUCCESS (0.000s)
[498.732501] [077/133] (531s left) api_intel_bb (reset-flags)
[498.789470] Starting subtest: reset-flags
[498.803102] Subtest reset-flags: SUCCESS (0.016s)
[498.942363] [078/133] (531s left) gem_pxp (fail-invalid-protected-context)
[499.062596] Starting subtest: fail-invalid-protected-context
[499.064988] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[499.197316] [079/133] (531s left) gem_exec_fence (submit-chain)
[499.372237] Starting subtest: submit-chain
[499.401976] Subtest submit-chain: SUCCESS (0.031s)
[501.241876] [080/133] (529s left) kms_chamelium_color (gamma)
[501.349679] Subtest gamma: SKIP (0.000s)
[501.394806] [081/133] (529s left) gem_exec_whisper (basic-contexts)
[501.457108] Starting subtest: basic-contexts
[508.112044] Subtest basic-contexts: SUCCESS (6.651s)
[508.306947] [082/133] (522s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[508.409264] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[508.413324] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[508.531049] [083/133] (521s left) gem_lmem_swapping (massive-random)
[508.573230] Subtest massive-random: SKIP (0.000s)
[508.615536] [084/133] (521s left) gen9_exec_parse (bb-start-param)
[508.675845] Subtest bb-start-param: SKIP (0.000s)
[508.745691] [085/133] (521s left) i915_drm_fdinfo (memory-info-active)
[508.784165] Starting subtest: memory-info-active
[508.786551] Starting dynamic subtest: smem0
[511.354117] Dynamic subtest smem0: SUCCESS (2.571s)
[511.356379] Subtest memory-info-active: SUCCESS (2.573s)
[511.456300] [086/133] (519s left) kms_big_fb (linear-16bpp-rotate-270)
[511.556952] Starting subtest: linear-16bpp-rotate-270
[511.576664] Subtest linear-16bpp-rotate-270: SKIP (0.019s)
[511.738670] [087/133] (518s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[511.839035] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[511.842538] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[511.951897] [088/133] (518s left) gem_ctx_persistence (engines-cleanup)
[512.008623] Starting subtest: engines-cleanup
[512.010224] Starting dynamic subtest: rcs0
[512.072192] Dynamic subtest rcs0: SUCCESS (0.066s)
[512.083062] Starting dynamic subtest: bcs0
[512.135938] Dynamic subtest bcs0: SUCCESS (0.062s)
[512.145470] Starting dynamic subtest: vcs0
[512.246926] Dynamic subtest vcs0: SUCCESS (0.109s)
[512.257559] Starting dynamic subtest: vcs1
[512.320609] Dynamic subtest vcs1: SUCCESS (0.072s)
[512.330677] Starting dynamic subtest: vecs0
[512.354189] Dynamic subtest vecs0: SUCCESS (0.032s)
[512.365256] Starting dynamic subtest: ccs0
[512.438782] Dynamic subtest ccs0: SUCCESS (0.082s)
[512.441192] Subtest engines-cleanup: SUCCESS (0.433s)
[512.539340] [089/133] (518s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[512.643011] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[512.646849] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[512.766033] [090/133] (517s left) kms_frontbuffer_tracking (psr-slowdraw)
[512.871682] Starting subtest: psr-slowdraw
[538.173281] Subtest psr-slowdraw: SUCCESS (25.306s)
[538.339251] [091/133] (492s left) syncobj_wait (wait-any-snapshot)
[538.406746] Starting subtest: wait-any-snapshot
[538.488548] Subtest wait-any-snapshot: SUCCESS (0.081s)
[538.596414] [092/133] (492s left) kms_invalid_mode (zero-clock)
[538.696319] Starting subtest: zero-clock
[538.698846] Starting dynamic subtest: pipe-A-eDP-1
[538.979642] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[538.989436] Starting dynamic subtest: pipe-B-eDP-1
[538.991649] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[539.000972] Starting dynamic subtest: pipe-C-eDP-1
[539.003353] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[539.012568] Starting dynamic subtest: pipe-D-eDP-1
[539.014800] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[539.017142] Subtest zero-clock: SUCCESS (0.291s)
[539.800229] [093/133] (491s left) kms_getfb (getfb-handle-not-fb)
[539.886096] Starting subtest: getfb-handle-not-fb
[539.888367] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[540.023784] [094/133] (490s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[540.154693] Starting subtest: cursor-vs-flip-toggle
[571.003366] Subtest cursor-vs-flip-toggle: SUCCESS (30.851s)
[571.813298] [095/133] (459s left) kms_async_flips (async-flip-dpms)
[571.916038] Starting subtest: async-flip-dpms
[572.288908] Starting dynamic subtest: pipe-A-eDP-1
[573.571658] Dynamic subtest pipe-A-eDP-1: FAIL (0.789s)
[573.584245] Starting dynamic subtest: pipe-B-eDP-1
[574.474104] Dynamic subtest pipe-B-eDP-1: FAIL (0.760s)
[574.594959] Starting dynamic subtest: pipe-C-eDP-1
[578.371706] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.788s)
[578.750822] Starting dynamic subtest: pipe-D-eDP-1
[581.538084] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.797s)
[581.540367] Subtest async-flip-dpms: FAIL (9.625s)
[582.739743] [096/133] (448s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[582.836717] Starting subtest: psr-rgb565-draw-mmap-cpu
[589.608421] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.773s)
[589.724584] [097/133] (441s left) perf (sysctl-defaults)
[589.801458] Starting subtest: sysctl-defaults
[589.803944] Subtest sysctl-defaults: SUCCESS (0.000s)
[589.864956] [098/133] (441s left) kms_chamelium_hpd (dp-hpd-storm)
[590.245092] Subtest dp-hpd-storm: SKIP (0.000s)
[591.059750] [099/133] (440s left) gem_exec_params (invalid-batch-start-offset)
[591.122073] Starting subtest: invalid-batch-start-offset
[591.127864] Subtest invalid-batch-start-offset: SUCCESS (0.004s)
[591.273140] [100/133] (439s left) gem_exec_schedule (noreorder-corked)
[591.449799] Starting subtest: noreorder-corked
[591.452104] Starting dynamic subtest: rcs0
[592.612157] Dynamic subtest rcs0: SUCCESS (1.165s)
[592.624710] Starting dynamic subtest: vcs0
[594.176044] Dynamic subtest vcs0: SUCCESS (1.560s)
[594.187635] Starting dynamic subtest: vcs1
[596.163032] Dynamic subtest vcs1: SUCCESS (1.984s)
[596.173493] Starting dynamic subtest: vecs0
[598.216188] Dynamic subtest vecs0: SUCCESS (2.050s)
[598.228987] Starting dynamic subtest: ccs0
[599.393007] Dynamic subtest ccs0: SUCCESS (1.175s)
[599.395748] Subtest noreorder-corked: SUCCESS (7.946s)
[599.608860] [101/133] (431s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[599.705463] Starting subtest: 4-tiled-64bpp-rotate-90
[599.725175] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.019s)
[599.869633] [102/133] (431s left) gem_exec_schedule (promotion)
[599.932560] Starting subtest: promotion
[599.934539] Starting dynamic subtest: rcs0
[600.021850] Dynamic subtest rcs0: SUCCESS (0.096s)
[600.031831] Starting dynamic subtest: vcs0
[600.109029] Dynamic subtest vcs0: SUCCESS (0.087s)
[600.119575] Starting dynamic subtest: vcs1
[600.187710] Dynamic subtest vcs1: SUCCESS (0.077s)
[600.198514] Starting dynamic subtest: vecs0
[600.270309] Dynamic subtest vecs0: SUCCESS (0.082s)
[600.283121] Starting dynamic subtest: ccs0
[600.362118] Dynamic subtest ccs0: SUCCESS (0.089s)
[600.364858] Subtest promotion: SUCCESS (0.437s)
[601.258353] [103/133] (430s left) syncobj_wait (wait-delayed-signal)
[601.304529] Starting subtest: wait-delayed-signal
[601.405761] Subtest wait-delayed-signal: SUCCESS (0.102s)
[601.494325] [104/133] (429s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[601.580917] Starting subtest: 2x-absolute-wf_vblank-interruptible
[601.593801] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.012s)
[601.733549] [105/133] (429s left) gem_exec_params (dr1-dirt)
[601.795541] Starting subtest: DR1-dirt
[601.797713] Subtest DR1-dirt: SUCCESS (0.000s)
[601.911676] [106/133] (429s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[602.004505] Starting subtest: plane-upscale-20x20-with-modifiers
[602.006811] Starting dynamic subtest: pipe-A
[602.341336] Dynamic subtest pipe-A: SUCCESS (0.338s)
[602.350579] Starting dynamic subtest: pipe-B
[603.768667] Dynamic subtest pipe-B: SUCCESS (1.425s)
[603.778520] Starting dynamic subtest: pipe-C
[605.207274] Dynamic subtest pipe-C: SUCCESS (1.438s)
[605.218439] Starting dynamic subtest: pipe-D
[606.639847] Dynamic subtest pipe-D: SUCCESS (1.431s)
[606.642101] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.637s)
[607.818928] [107/133] (423s left) gem_exec_balancer (bonded-true-hang)
[608.083587] Starting subtest: bonded-true-hang
[608.088481] Subtest bonded-true-hang: SKIP (0.000s)
[608.206330] [108/133] (423s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[608.301388] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[608.305393] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[608.426480] [109/133] (423s left) syncobj_timeline (invalid-signal-illegal-handle)
[608.480658] Starting subtest: invalid-signal-illegal-handle
[608.482846] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[608.600717] [110/133] (423s left) gem_mmap_gtt (coherency)
[608.640452] Subtest coherency: SKIP (0.000s)
[608.709557] [111/133] (422s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[608.798198] Starting subtest: fbc-psr2-sprite-plane-onoff
[608.800458] Starting dynamic subtest: eDP-1
[608.804757] Dynamic subtest eDP-1: SKIP (0.000s)
[608.809180] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[608.886192] [112/133] (422s left) kms_psr (psr-cursor-plane-onoff)
[608.981417] Starting subtest: psr-cursor-plane-onoff
[608.983675] Starting dynamic subtest: eDP-1
[610.699991] Dynamic subtest eDP-1: SUCCESS (1.718s)
[610.702662] Subtest psr-cursor-plane-onoff: SUCCESS (1.719s)
[611.595301] [113/133] (420s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[611.692656] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[611.696751] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[611.826333] [114/133] (419s left) kms_pm_rpm (dpms-non-lpsp)
[613.351621] Starting subtest: dpms-non-lpsp
[613.356514] Subtest dpms-non-lpsp: SKIP (0.001s)
[614.126030] [115/133] (417s left) gem_exec_flush (basic-wb-set-default)
[614.190771] Starting subtest: basic-wb-set-default
[619.645254] Subtest basic-wb-set-default: SUCCESS (5.455s)
[619.844794] [116/133] (412s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[619.947562] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[619.951818] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[620.068458] [117/133] (411s left) kms_psr (fbc-psr-sprite-plane-move)
[620.169820] Starting subtest: fbc-psr-sprite-plane-move
[620.171762] Starting dynamic subtest: eDP-1
[620.175856] Dynamic subtest eDP-1: SKIP (0.000s)
[620.179882] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s)
[620.252754] [118/133] (411s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[620.352776] Starting subtest: y-tiled-64bpp-rotate-270
[620.357348] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[620.455850] [119/133] (411s left) kms_psr (psr2-cursor-plane-onoff)
[620.542290] Starting subtest: psr2-cursor-plane-onoff
[620.544601] Starting dynamic subtest: eDP-1
[622.282778] Dynamic subtest eDP-1: SUCCESS (1.741s)
[622.285119] Subtest psr2-cursor-plane-onoff: SUCCESS (1.742s)
[623.084868] [120/133] (408s left) kms_fbcon_fbt (psr)
[623.152489] Starting subtest: psr
[630.515081] Subtest psr: SUCCESS (7.360s)
[630.590024] [121/133] (401s left) i915_hangman (detector)
[630.665787] Starting subtest: detector
[630.667728] Starting dynamic subtest: rcs0
[642.126793] Dynamic subtest rcs0: SUCCESS (11.460s)
[642.139413] Starting dynamic subtest: bcs0
[654.158539] Dynamic subtest bcs0: SUCCESS (12.027s)
[654.171640] Starting dynamic subtest: vcs0
[666.062345] Dynamic subtest vcs0: SUCCESS (11.899s)
[666.074203] Starting dynamic subtest: vcs1
[677.070929] Dynamic subtest vcs1: SUCCESS (11.005s)
[677.085906] Starting dynamic subtest: vecs0
[688.078642] Dynamic subtest vecs0: SUCCESS (11.004s)
[688.091571] Starting dynamic subtest: ccs0
[699.150201] Dynamic subtest ccs0: SUCCESS (11.069s)
[699.153171] Subtest detector: SUCCESS (68.480s)
[699.261871] [122/133] (332s left) gem_ringfill (engines-basic)
[705.138548] Starting subtest: engines-basic
[705.141007] Starting dynamic subtest: rcs0
[705.209491] Dynamic subtest rcs0: SUCCESS (0.070s)
[705.221061] Starting dynamic subtest: bcs0
[705.256097] Dynamic subtest bcs0: SUCCESS (0.044s)
[705.266972] Starting dynamic subtest: vcs0
[705.301804] Dynamic subtest vcs0: SUCCESS (0.044s)
[705.312646] Starting dynamic subtest: vcs1
[705.345111] Dynamic subtest vcs1: SUCCESS (0.041s)
[705.356435] Starting dynamic subtest: vecs0
[705.389105] Dynamic subtest vecs0: SUCCESS (0.042s)
[705.399158] Starting dynamic subtest: ccs0
[705.433975] Dynamic subtest ccs0: SUCCESS (0.043s)
[705.436508] Subtest engines-basic: SUCCESS (0.297s)
[705.526561] [123/133] (326s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[705.644600] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[715.087049] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (9.440s)
[715.960957] [124/133] (316s left) syncobj_timeline (wait-any-interrupted)
[716.017158] Starting subtest: wait-any-interrupted
[716.121057] Subtest wait-any-interrupted: SUCCESS (0.102s)
[716.212467] [125/133] (316s left) syncobj_wait (multi-wait-all-submitted)
[716.258880] Starting subtest: multi-wait-all-submitted
[716.363901] Subtest multi-wait-all-submitted: SUCCESS (0.104s)
[716.465787] [126/133] (315s left) kms_hdr (bpc-switch-suspend)
[716.566428] Starting subtest: bpc-switch-suspend
[717.625447] Starting dynamic subtest: pipe-A-eDP-1
[736.759103] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.478s)
[736.761987] Subtest bpc-switch-suspend: SUCCESS (5.544s)
[736.905718] [127/133] (295s left) kms_dsc (dsc-basic)
[737.013064] Starting subtest: dsc-basic
[737.028131] Subtest dsc-basic: SKIP (0.000s)
[737.097099] [128/133] (295s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs)
[737.195500] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs
[737.200047] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s)
[738.364036] [129/133] (294s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[743.421523] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[743.424252] Starting dynamic subtest: pipe-A-eDP-1
[744.208492] Dynamic subtest pipe-A-eDP-1: SKIP (0.782s)
[744.221425] Starting dynamic subtest: pipe-B-eDP-1
[745.336680] Dynamic subtest pipe-B-eDP-1: SKIP (1.123s)
[745.342372] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.909s)
[746.545191] [130/133] (285s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[746.649703] Starting subtest: blocking-absolute-wf_vblank-interruptible
[746.652187] Starting dynamic subtest: A-eDP1
[755.399732] Dynamic subtest A-eDP1: SUCCESS (8.740s)
[755.411666] Starting dynamic subtest: B-eDP1
[764.139146] Dynamic subtest B-eDP1: SUCCESS (8.733s)
[764.149189] Starting dynamic subtest: C-eDP1
[772.852761] Dynamic subtest C-eDP1: SUCCESS (8.710s)
[772.864904] Starting dynamic subtest: D-eDP1
[781.576314] Dynamic subtest D-eDP1: SUCCESS (8.725s)
[781.580966] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.919s)
[782.801278] [131/133] (249s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[782.914628] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[782.919749] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[783.034470] [132/133] (249s left) kms_color (ctm-max)
[783.136007] Starting subtest: ctm-max
[783.138672] Starting dynamic subtest: pipe-A-eDP-1
[783.845120] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.710s)
[783.856200] Starting dynamic subtest: pipe-B-eDP-1
[785.289115] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.443s)
[785.301058] Starting dynamic subtest: pipe-C-eDP-1
[786.671907] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.381s)
[786.682930] Starting dynamic subtest: pipe-D-eDP-1
[787.994127] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.321s)
[787.996978] Subtest ctm-max: SUCCESS (4.859s)
[788.813537] [133/133] (243s left) gem_exec_reloc (basic-cpu-gtt)
[788.865876] Subtest basic-cpu-gtt: SKIP (0.000s)
[788.950099] Closing watchdogs
results: parsing output: 0/ for test: perf
results: parsing output: 1/ for test: gem_vm_create
results: parsing output: 2/ for test: gem_exec_params
results: parsing output: 3/ for test: kms_universal_plane
results: parsing output: 4/ for test: kms_multipipe_modeset
results: parsing output: 5/ for test: i915_suspend
results: parsing output: 6/ for test: kms_feature_discovery
results: parsing output: 7/ for test: gem_mmap_wc
results: parsing output: 8/ for test: dmabuf_sync_file
results: parsing output: 9/ for test: gem_exec_balancer
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: perf_pmu
results: parsing output: 12/ for test: kms_ccs
results: parsing output: 13/ for test: kms_plane_cursor
results: parsing output: 14/ for test: gem_ctx_param
results: parsing output: 15/ for test: syncobj_timeline
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_chamelium_edid
results: parsing output: 19/ for test: gem_busy
results: parsing output: 20/ for test: kms_ccs
results: parsing output: 21/ for test: kms_pm_backlight
results: parsing output: 22/ for test: gem_softpin
results: parsing output: 23/ for test: gem_exec_parallel
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: kms_cursor_legacy
results: parsing output: 26/ for test: i915_pm_rpm
results: parsing output: 27/ for test: kms_properties
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: prime_mmap
results: parsing output: 30/ for test: kms_vblank
results: parsing output: 31/ for test: gem_ctx_param
results: parsing output: 32/ for test: gem_mmap_gtt
results: parsing output: 33/ for test: kms_flip_scaled_crc
results: parsing output: 34/ for test: gem_partial_pwrite_pread
results: parsing output: 35/ for test: syncobj_wait
results: parsing output: 36/ for test: kms_setmode
results: parsing output: 37/ for test: gem_ctx_shared
results: parsing output: 38/ for test: prime_vgem
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: gem_spin_batch
results: parsing output: 41/ for test: kms_cursor_legacy
results: parsing output: 42/ for test: kms_flip_scaled_crc
results: parsing output: 43/ for test: kms_async_flips
results: parsing output: 44/ for test: kms_busy
results: parsing output: 45/ for test: kms_plane_multiple
results: parsing output: 46/ for test: kms_cursor_crc
results: parsing output: 47/ for test: perf
results: parsing output: 48/ for test: gem_mmap_gtt
results: parsing output: 49/ for test: gem_ctx_persistence
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_content_protection
results: parsing output: 53/ for test: kms_flip
results: parsing output: 54/ for test: i915_query
results: parsing output: 55/ for test: gem_mmap_offset
results: parsing output: 56/ for test: perf_pmu
results: parsing output: 57/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_psr2_su
results: parsing output: 61/ for test: kms_colorop
results: parsing output: 62/ for test: kms_cursor_legacy
results: parsing output: 63/ for test: kms_colorop
results: parsing output: 64/ for test: syncobj_timeline
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: syncobj_wait
results: parsing output: 67/ for test: kms_psr2_sf
results: parsing output: 68/ for test: gem_close_race
results: parsing output: 69/ for test: prime_vgem
results: parsing output: 70/ for test: kms_psr
results: parsing output: 71/ for test: kms_cursor_crc
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: perf_pmu
results: parsing output: 74/ for test: gem_mmap_wc
results: parsing output: 75/ for test: gem_basic
results: parsing output: 76/ for test: api_intel_bb
results: parsing output: 77/ for test: gem_pxp
results: parsing output: 78/ for test: gem_exec_fence
results: parsing output: 79/ for test: kms_chamelium_color
results: parsing output: 80/ for test: gem_exec_whisper
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_lmem_swapping
results: parsing output: 83/ for test: gen9_exec_parse
results: parsing output: 84/ for test: i915_drm_fdinfo
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_ctx_persistence
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: syncobj_wait
results: parsing output: 91/ for test: kms_invalid_mode
results: parsing output: 92/ for test: kms_getfb
results: parsing output: 93/ for test: kms_cursor_legacy
results: parsing output: 94/ for test: kms_async_flips
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: perf
results: parsing output: 97/ for test: kms_chamelium_hpd
results: parsing output: 98/ for test: gem_exec_params
results: parsing output: 99/ for test: gem_exec_schedule
results: parsing output: 100/ for test: kms_big_fb
results: parsing output: 101/ for test: gem_exec_schedule
results: parsing output: 102/ for test: syncobj_wait
results: parsing output: 103/ for test: kms_flip
results: parsing output: 104/ for test: gem_exec_params
results: parsing output: 105/ for test: kms_plane_scaling
results: parsing output: 106/ for test: gem_exec_balancer
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: syncobj_timeline
results: parsing output: 109/ for test: gem_mmap_gtt
results: parsing output: 110/ for test: kms_psr
results: parsing output: 111/ for test: kms_psr
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_pm_rpm
results: parsing output: 114/ for test: gem_exec_flush
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: kms_fbcon_fbt
results: parsing output: 120/ for test: i915_hangman
results: parsing output: 121/ for test: gem_ringfill
results: parsing output: 122/ for test: kms_cursor_legacy
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: syncobj_wait
results: parsing output: 125/ for test: kms_hdr
results: parsing output: 126/ for test: kms_dsc
results: parsing output: 127/ for test: kms_ccs
results: parsing output: 128/ for test: kms_psr2_sf
results: parsing output: 129/ for test: kms_flip
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_color
results: parsing output: 132/ for test: gem_exec_reloc
Done.