[56.025530] Initializing watchdogs
[56.025572]   /dev/watchdog0
[56.039608] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[56.043530] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.045879] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.049314] [001/156] (960s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[56.149764] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[56.152103] Starting dynamic subtest: pipe-A-default-mode
[58.840315] Dynamic subtest pipe-A-default-mode: SUCCESS (2.732s)
[58.842680] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.733s)
[59.698689] [002/156] (956s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-render)
[59.794488] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-render
[59.798642] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[59.885137] [003/156] (956s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-render)
[59.967916] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-render
[59.971630] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[60.065790] [004/156] (956s left) syncobj_eventfd (timeline-wait-before-signal)
[60.122869] Starting subtest: timeline-wait-before-signal
[60.152729] Subtest timeline-wait-before-signal: SUCCESS (0.031s)
[60.223791] [005/156] (956s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[60.325802] Starting subtest: flip-vs-cursor-crc-atomic
[61.009550] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.692s)
[61.895019] [006/156] (954s left) kms_pm_rpm (dpms-non-lpsp)
[63.396827] Starting subtest: dpms-non-lpsp
[63.401457] Subtest dpms-non-lpsp: SKIP (0.001s)
[64.126150] [007/156] (952s left) kms_feature_discovery (chamelium)
[64.204798] Starting subtest: chamelium
[64.209241] Subtest chamelium: SKIP (0.000s)
[64.274573] [008/156] (952s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-move)
[64.355108] Starting subtest: hdr-1p-primscrn-spr-indfb-move
[64.359158] Subtest hdr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[64.453205] [009/156] (952s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-pwrite)
[64.533713] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-pwrite
[64.538139] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[64.613723] [010/156] (952s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[64.698781] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[64.703037] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[64.803770] [011/156] (952s left) vgem_basic (sysfs)
[64.867120] Starting subtest: sysfs
[64.869342] Subtest sysfs: SUCCESS (0.000s)
[64.924148] [FACT vgem_basic (sysfs)] new: kernel.kmod_is_loaded.vgem: true
[64.926982] [012/156] (952s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[65.008126] Starting subtest: y-tiled-32bpp-rotate-270
[65.012231] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[65.108449] [013/156] (951s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[65.196191] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[68.892397] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.719s)
[70.073240] [014/156] (946s left) kms_flip (2x-absolute-wf_vblank)
[70.146255] Starting subtest: 2x-absolute-wf_vblank
[70.152945] Subtest 2x-absolute-wf_vblank: SKIP (0.008s)
[70.256144] [015/156] (946s left) gem_ctx_persistence (saturated-hostile)
[70.314491] Starting subtest: saturated-hostile
[70.316776] Starting dynamic subtest: rcs0
[71.142447] Dynamic subtest rcs0: SUCCESS (0.828s)
[71.150785] Starting dynamic subtest: bcs0
[71.944841] Dynamic subtest bcs0: SUCCESS (0.805s)
[71.953681] Starting dynamic subtest: vcs0
[72.736720] Dynamic subtest vcs0: SUCCESS (0.793s)
[72.746824] Starting dynamic subtest: vcs1
[73.687404] Dynamic subtest vcs1: SUCCESS (0.951s)
[73.695306] Starting dynamic subtest: vecs0
[74.478832] Dynamic subtest vecs0: SUCCESS (0.792s)
[74.490081] Starting dynamic subtest: ccs0
[75.303312] Dynamic subtest ccs0: SUCCESS (0.824s)
[75.305950] Subtest saturated-hostile: SUCCESS (4.999s)
[75.382986] [016/156] (941s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-render)
[75.469125] Starting subtest: fbchdr-rgb101010-draw-render
[75.473638] Subtest fbchdr-rgb101010-draw-render: SKIP (0.000s)
[75.564203] [017/156] (941s left) kms_psr (psr-sprite-plane-onoff)
[75.637092] Starting subtest: psr-sprite-plane-onoff
[75.639334] Starting dynamic subtest: eDP-1
[77.368245] Dynamic subtest eDP-1: SUCCESS (1.734s)
[77.370587] Subtest psr-sprite-plane-onoff: SUCCESS (1.735s)
[78.217905] [018/156] (938s left) gem_exec_schedule (semaphore-resolve)
[78.287965] Starting subtest: semaphore-resolve
[78.316374] Subtest semaphore-resolve: SUCCESS (0.036s)
[78.656514] [019/156] (938s left) gem_pxp (reject-modify-context-protection-off-1)
[78.777486] Starting subtest: reject-modify-context-protection-off-1
[78.779779] Subtest reject-modify-context-protection-off-1: SUCCESS (0.002s)
[78.892130] [020/156] (938s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[78.977610] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[78.981914] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[79.071181] [021/156] (938s left) kms_frontbuffer_tracking (fbcpsrhdr-farfromfence-mmap-gtt)
[79.150325] Starting subtest: fbcpsrhdr-farfromfence-mmap-gtt
[79.154821] Subtest fbcpsrhdr-farfromfence-mmap-gtt: SKIP (0.000s)
[79.245405] [022/156] (938s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[79.322975] Starting subtest: fbc-pr-cursor-mmap-cpu
[79.327616] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[79.397122] [023/156] (937s left) kms_vblank (ts-continuation-dpms-suspend)
[79.468830] Starting subtest: ts-continuation-dpms-suspend
[79.471068] Starting dynamic subtest: pipe-A-eDP-1
[96.822071] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.074s)
[96.837128] Starting dynamic subtest: pipe-D-eDP-1
[114.758068] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.535s)
[114.760370] Subtest ts-continuation-dpms-suspend: SUCCESS (4.611s)
[115.552850] [024/156] (901s left) kms_plane_lowres (tiling-y)
[115.629122] Starting subtest: tiling-y
[115.633782] Subtest tiling-y: SKIP (0.000s)
[115.697541] [025/156] (901s left) kms_cursor_edge_walk (64x64-top-edge)
[115.762733] Starting subtest: 64x64-top-edge
[115.764798] Starting dynamic subtest: pipe-A-eDP-1
[119.157034] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.462s)
[119.169052] Starting dynamic subtest: pipe-D-eDP-1
[122.255642] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.141s)
[122.258226] Subtest 64x64-top-edge: SUCCESS (6.605s)
[123.050351] [026/156] (894s left) kms_psr (fbc-psr2-primary-page-flip)
[123.131369] Starting subtest: fbc-psr2-primary-page-flip
[123.133725] Starting dynamic subtest: eDP-1
[123.137687] Dynamic subtest eDP-1: SKIP (0.000s)
[123.141979] Subtest fbc-psr2-primary-page-flip: SKIP (0.000s)
[123.204693] [027/156] (894s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[123.283249] Starting subtest: bad-aux-stride-yf-tiled-ccs
[123.285482] Starting dynamic subtest: pipe-A-eDP-1
[123.308025] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[123.317813] Starting dynamic subtest: pipe-B-eDP-1
[123.339847] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[123.348000] Starting dynamic subtest: pipe-C-eDP-1
[123.368837] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[123.376950] Starting dynamic subtest: pipe-D-eDP-1
[123.398989] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[123.403110] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.003s)
[125.592263] [028/156] (891s left) i915_module_load (reload-no-display)
[125.633276] Starting subtest: reload-no-display
[132.792815] Subtest reload-no-display: SUCCESS (7.193s)
[132.821616] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[132.822376] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[132.825894] [029/156] (884s left) kms_chamelium_frames (dp-crc-multiple)
[134.598774] Subtest dp-crc-multiple: SKIP (0.000s)
[135.449274] [FACT kms_chamelium_frames (dp-crc-multiple)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[135.450441] [FACT kms_chamelium_frames (dp-crc-multiple)] new: kernel.kmod_is_loaded.i915: true
[135.454148] [030/156] (882s left) gem_create (create-size-update)
[135.510332] Starting subtest: create-size-update
[135.512539] Subtest create-size-update: SUCCESS (0.000s)
[135.747627] [031/156] (881s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[135.855456] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[135.860432] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[135.998229] [032/156] (881s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[136.077834] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[136.080063] Starting dynamic subtest: pipe-A-eDP-1
[136.103942] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[136.114036] Starting dynamic subtest: pipe-B-eDP-1
[136.136123] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[136.145205] Starting dynamic subtest: pipe-C-eDP-1
[136.167310] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[136.175420] Starting dynamic subtest: pipe-D-eDP-1
[136.198234] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[136.202295] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[138.327278] [033/156] (879s left) gem_exec_suspend (basic)
[138.388774] Starting subtest: basic
[138.391114] Starting dynamic subtest: smem
[139.980442] Dynamic subtest smem: SUCCESS (1.592s)
[139.983001] Subtest basic: SUCCESS (1.593s)
[140.167238] [034/156] (877s left) kms_async_flips (async-flip-hang)
[140.249913] Starting subtest: async-flip-hang
[140.632803] Starting dynamic subtest: pipe-A-eDP-1
[156.463374] Dynamic subtest pipe-A-eDP-1: SUCCESS (15.824s)
[156.857365] Starting dynamic subtest: pipe-B-eDP-1
[172.454265] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.604s)
[172.856515] Starting dynamic subtest: pipe-C-eDP-1
[188.450670] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.604s)
[188.832712] Starting dynamic subtest: pipe-D-eDP-1
[204.447924] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.626s)
[204.450757] Subtest async-flip-hang: SUCCESS (64.201s)
[205.701515] [035/156] (812s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[205.789769] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[214.614476] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.829s)
[214.741844] [036/156] (803s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[214.835887] Starting subtest: fbcpsr-slowdraw
[240.122209] Subtest fbcpsr-slowdraw: SUCCESS (25.287s)
[240.256467] [037/156] (777s left) kms_plane_alpha_blend (alpha-basic)
[240.337036] Starting subtest: alpha-basic
[240.626966] Starting dynamic subtest: pipe-A-eDP-1
[242.553096] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.926s)
[242.581710] Starting dynamic subtest: pipe-D-eDP-1
[245.282468] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.706s)
[245.284844] Subtest alpha-basic: SUCCESS (4.945s)
[246.182267] [038/156] (771s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[246.270511] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc
[246.274548] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[246.363844] [039/156] (771s left) gem_mmap_gtt (isolation)
[246.417976] Subtest isolation: SKIP (0.000s)
[246.476533] [040/156] (771s left) gem_partial_pwrite_pread (write)
[246.527992] Subtest write: SKIP (0.000s)
[246.581805] [041/156] (771s left) kms_tiled_display (basic-test-pattern)
[246.672391] Subtest basic-test-pattern: SKIP (0.000s)
[246.718319] [042/156] (771s left) kms_chamelium_audio (dp-audio)
[247.080828] Subtest dp-audio: SKIP (0.000s)
[247.879702] [043/156] (770s left) gem_pxp (hw-rejects-pxp-buffer)
[248.010524] Starting subtest: hw-rejects-pxp-buffer
[248.015267] Subtest hw-rejects-pxp-buffer: SKIP (0.000s)
[248.114012] [044/156] (770s left) kms_frontbuffer_tracking (fbc-tiling-y)
[248.203708] Starting subtest: fbc-tiling-y
[248.209858] Subtest fbc-tiling-y: SKIP (0.000s)
[248.297343] [045/156] (769s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[248.375005] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[255.448578] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.078s)
[255.552551] [046/156] (762s left) i915_suspend (basic-s3-without-i915)
[255.584761] Starting subtest: basic-s3-without-i915
[258.962396] Subtest basic-s3-without-i915: SKIP (3.373s)
[260.490840] [047/156] (757s left) kms_lease (multimaster-lease)
[260.584531] Starting subtest: multimaster-lease
[260.586401] Subtest multimaster-lease: SUCCESS (0.003s)
[260.694502] [048/156] (757s left) kms_atomic (crtc-invalid-params)
[260.770207] Starting subtest: crtc-invalid-params
[260.772610] Starting dynamic subtest: pipe-A-eDP-1
[261.922887] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.149s)
[261.924937] Subtest crtc-invalid-params: SUCCESS (1.150s)
[262.306266] [049/156] (756s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-mmap-wc)
[262.404441] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-mmap-wc
[262.408933] Subtest psrhdr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[262.510327] [050/156] (755s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[262.572663] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[262.640328] [051/156] (755s left) kms_invalid_mode (bad-vsync-start)
[262.712800] Starting subtest: bad-vsync-start
[262.715166] Starting dynamic subtest: pipe-A-eDP-1
[262.997740] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[263.006436] Starting dynamic subtest: pipe-B-eDP-1
[263.008678] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[263.017201] Starting dynamic subtest: pipe-C-eDP-1
[263.019424] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[263.027990] Starting dynamic subtest: pipe-D-eDP-1
[263.030405] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[263.032727] Subtest bad-vsync-start: SUCCESS (0.293s)
[263.830111] [052/156] (754s left) gem_lmem_swapping (massive)
[263.872699] Subtest massive: SKIP (0.000s)
[263.931695] [053/156] (754s left) kms_atomic_transition (plane-all-transition-nonblocking)
[263.999921] Starting subtest: plane-all-transition-nonblocking
[264.002207] Starting dynamic subtest: pipe-A-eDP-1
[266.494095] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[266.802289] Starting dynamic subtest: pipe-B-eDP-1
[270.066311] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.273s)
[270.380894] Subtest plane-all-transition-nonblocking: SUCCESS (6.383s)
[271.202265] [054/156] (747s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[271.278261] Starting subtest: bad-pixel-format-yf-tiled-ccs
[271.280559] Starting dynamic subtest: pipe-A-eDP-1
[271.303945] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[271.314697] Starting dynamic subtest: pipe-B-eDP-1
[271.336886] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[271.345162] Starting dynamic subtest: pipe-C-eDP-1
[271.367411] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[271.375605] Starting dynamic subtest: pipe-D-eDP-1
[271.397528] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[271.401562] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.004s)
[273.559218] [055/156] (745s left) kms_content_protection (dp-mst-type-0)
[273.685982] Starting subtest: dp-mst-type-0
[273.690136] Subtest dp-mst-type-0: SKIP (0.000s)
[273.808212] [056/156] (744s left) gem_exec_balancer (parallel-ordering)
[274.072724] Starting subtest: parallel-ordering
[275.021229] Subtest parallel-ordering: SUCCESS (0.949s)
[275.142773] [057/156] (743s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[275.218054] Starting subtest: psr-rgb565-draw-mmap-cpu
[282.039416] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.826s)
[282.151328] [058/156] (736s left) kms_flip (wf_vblank-ts-check)
[282.232732] Starting subtest: wf_vblank-ts-check
[282.235009] Starting dynamic subtest: A-eDP1
[291.138238] Dynamic subtest A-eDP1: SUCCESS (8.908s)
[291.147908] Starting dynamic subtest: B-eDP1
[300.066850] Dynamic subtest B-eDP1: SUCCESS (8.929s)
[300.078224] Starting dynamic subtest: C-eDP1
[308.989722] Dynamic subtest C-eDP1: SUCCESS (8.923s)
[308.998279] Starting dynamic subtest: D-eDP1
[317.918580] Dynamic subtest D-eDP1: SUCCESS (8.929s)
[317.924280] Subtest wf_vblank-ts-check: SUCCESS (35.698s)
[319.140684] [059/156] (699s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[319.231058] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-mmap-gtt
[319.235223] Subtest hdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[319.329726] [060/156] (699s left) perf (gen12-unprivileged-single-ctx-counters)
[319.468703] Starting subtest: gen12-unprivileged-single-ctx-counters
[319.470872] Starting dynamic subtest: rcs0
[319.505996] Dynamic subtest rcs0: SUCCESS (0.039s)
[319.508280] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.040s)
[319.554635] [061/156] (699s left) api_intel_allocator (two-level-inception)
[319.634175] Starting subtest: two-level-inception
[325.036342] Subtest two-level-inception: SUCCESS (5.402s)
[325.168483] [062/156] (693s left) gen9_exec_parse (allowed-all)
[325.232927] Subtest allowed-all: SKIP (0.000s)
[325.329680] [063/156] (693s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-render)
[325.420916] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-render
[325.425199] Subtest fbchdr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[325.540438] [064/156] (693s left) i915_drm_fdinfo (busy-idle)
[325.579235] Starting subtest: busy-idle
[325.581586] Starting dynamic subtest: rcs0
[325.629782] Dynamic subtest rcs0: SKIP (0.049s)
[325.642769] Starting dynamic subtest: bcs0
[325.647120] Dynamic subtest bcs0: SKIP (0.001s)
[325.655868] Starting dynamic subtest: vcs0
[325.659979] Dynamic subtest vcs0: SKIP (0.000s)
[325.668396] Starting dynamic subtest: vcs1
[325.672898] Dynamic subtest vcs1: SKIP (0.000s)
[325.681855] Starting dynamic subtest: vecs0
[325.686158] Dynamic subtest vecs0: SKIP (0.000s)
[325.694563] Starting dynamic subtest: ccs0
[325.698751] Dynamic subtest ccs0: SKIP (0.000s)
[325.702926] Subtest busy-idle: SKIP (0.057s)
[325.743521] [065/156] (693s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[325.825464] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu
[325.829955] Subtest psrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[325.927584] [066/156] (693s left) gem_spin_batch (legacy-resubmit)
[325.990591] Starting subtest: legacy-resubmit
[325.992904] Starting dynamic subtest: default
[325.998740] Dynamic subtest default: SUCCESS (0.005s)
[326.012776] Starting dynamic subtest: render
[326.014944] Dynamic subtest render: SUCCESS (0.001s)
[326.023189] Starting dynamic subtest: bsd
[326.025116] Dynamic subtest bsd: SUCCESS (0.002s)
[326.034417] Starting dynamic subtest: bsd1
[326.036278] Dynamic subtest bsd1: SUCCESS (0.001s)
[326.044758] Starting dynamic subtest: bsd2
[326.046657] Dynamic subtest bsd2: SUCCESS (0.002s)
[326.054995] Starting dynamic subtest: blt
[326.056632] Dynamic subtest blt: SUCCESS (0.002s)
[326.064210] Starting dynamic subtest: vebox
[326.065745] Dynamic subtest vebox: SUCCESS (0.003s)
[326.067390] Subtest legacy-resubmit: SUCCESS (0.022s)
[326.243763] [067/156] (692s left) gem_wait (busy)
[326.316865] Starting subtest: busy
[326.318772] Starting dynamic subtest: all-engines
[327.946408] Dynamic subtest all-engines: SUCCESS (1.630s)
[327.961908] Starting dynamic subtest: rcs0
[328.489496] Dynamic subtest rcs0: SUCCESS (0.542s)
[328.501997] Starting dynamic subtest: bcs0
[329.030184] Dynamic subtest bcs0: SUCCESS (0.539s)
[329.040265] Starting dynamic subtest: vcs0
[330.953049] Dynamic subtest vcs0: SUCCESS (1.921s)
[330.964958] Starting dynamic subtest: vcs1
[332.937347] Dynamic subtest vcs1: SUCCESS (1.982s)
[332.949497] Starting dynamic subtest: vecs0
[334.985636] Dynamic subtest vecs0: SUCCESS (2.046s)
[334.997263] Starting dynamic subtest: ccs0
[335.526997] Dynamic subtest ccs0: SUCCESS (0.541s)
[335.529455] Subtest busy: SUCCESS (9.215s)
[335.720409] [068/156] (683s left) syncobj_wait (wait-zero-handles)
[335.769091] Starting subtest: wait-zero-handles
[335.771673] Subtest wait-zero-handles: SUCCESS (0.000s)
[335.862397] [069/156] (683s left) api_intel_bb (object-reloc-keep-cache)
[335.913714] Starting subtest: object-reloc-keep-cache
[335.918333] Subtest object-reloc-keep-cache: SKIP (0.002s)
[336.035148] [070/156] (683s left) gem_exec_store (pages)
[336.102473] Starting subtest: pages
[336.104400] Starting dynamic subtest: rcs0
[336.210838] Dynamic subtest rcs0: SUCCESS (0.111s)
[336.219640] Starting dynamic subtest: bcs0
[336.284234] Dynamic subtest bcs0: SUCCESS (0.072s)
[336.292814] Starting dynamic subtest: vcs0
[336.353204] Dynamic subtest vcs0: SUCCESS (0.068s)
[336.364564] Starting dynamic subtest: vcs1
[336.423136] Dynamic subtest vcs1: SUCCESS (0.069s)
[336.434471] Starting dynamic subtest: vecs0
[336.491222] Dynamic subtest vecs0: SUCCESS (0.067s)
[336.502603] Starting dynamic subtest: ccs0
[336.570202] Dynamic subtest ccs0: SUCCESS (0.078s)
[336.572574] Subtest pages: SUCCESS (0.471s)
[336.768087] [071/156] (682s left) kms_plane (pixel-format-y-tiled-modifier)
[336.840307] Starting subtest: pixel-format-y-tiled-modifier
[336.844637] Subtest pixel-format-y-tiled-modifier: SKIP (0.000s)
[336.914115] [072/156] (682s left) gem_exec_fence (keep-in-fence)
[337.100954] Starting subtest: keep-in-fence
[337.103324] Starting dynamic subtest: rcs0
[337.150802] Dynamic subtest rcs0: SUCCESS (0.054s)
[337.164494] Starting dynamic subtest: bcs0
[337.204473] Dynamic subtest bcs0: SUCCESS (0.051s)
[337.216091] Starting dynamic subtest: vcs0
[338.954555] Dynamic subtest vcs0: SUCCESS (1.746s)
[338.967830] Starting dynamic subtest: vcs1
[340.939806] Dynamic subtest vcs1: SUCCESS (1.981s)
[340.951491] Starting dynamic subtest: vecs0
[342.986267] Dynamic subtest vecs0: SUCCESS (2.043s)
[342.997026] Starting dynamic subtest: ccs0
[343.210191] Dynamic subtest ccs0: SUCCESS (0.223s)
[343.212588] Subtest keep-in-fence: SUCCESS (6.113s)
[345.045568] [073/156] (674s left) gem_ctx_shared (exec-shared-gtt)
[345.106803] Starting subtest: exec-shared-gtt
[345.109221] Starting dynamic subtest: rcs0
[345.120625] Dynamic subtest rcs0: SUCCESS (0.013s)
[345.133526] Starting dynamic subtest: bcs0
[345.135819] Dynamic subtest bcs0: SUCCESS (0.009s)
[345.145240] Starting dynamic subtest: vcs0
[345.147204] Dynamic subtest vcs0: SUCCESS (0.010s)
[345.155913] Starting dynamic subtest: vcs1
[345.158217] Dynamic subtest vcs1: SUCCESS (0.009s)
[345.167692] Starting dynamic subtest: vecs0
[345.170098] Dynamic subtest vecs0: SUCCESS (0.007s)
[345.178763] Starting dynamic subtest: ccs0
[345.180977] Dynamic subtest ccs0: SUCCESS (0.008s)
[345.183276] Subtest exec-shared-gtt: SUCCESS (0.061s)
[345.352194] [074/156] (674s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[345.433582] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[345.437657] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[345.523045] [075/156] (673s left) gem_bad_reloc (negative-reloc-bltcopy)
[345.580418] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[345.647712] [076/156] (673s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[345.716266] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[345.724728] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.008s)
[345.800465] [077/156] (673s left) kms_getfb (getfb2-handle-closed)
[345.887576] Starting subtest: getfb2-handle-closed
[345.889912] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[345.993304] [078/156] (673s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[346.076790] Starting subtest: x-tiled-8bpp-rotate-90
[346.101120] Subtest x-tiled-8bpp-rotate-90: SKIP (0.022s)
[346.209520] [079/156] (673s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[346.280214] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[353.182420] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.902s)
[353.343872] [080/156] (666s left) kms_atomic_interruptible (legacy-setmode)
[353.416244] Starting subtest: legacy-setmode
[353.418621] Starting dynamic subtest: pipe-A-eDP-1
[360.313826] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.895s)
[360.316198] Subtest legacy-setmode: SUCCESS (6.896s)
[361.141232] [081/156] (658s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[361.221336] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[362.323550] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.101s)
[362.446611] [082/156] (657s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-pwrite)
[362.544103] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-pwrite
[362.547718] Subtest fbchdr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[362.638925] [083/156] (657s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[362.716206] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[362.718210] Starting dynamic subtest: pipe-A-eDP-1
[374.023210] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.307s)
[374.032910] Starting dynamic subtest: pipe-B-eDP-1
[386.065524] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.039s)
[386.067776] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.350s)
[386.883939] [084/156] (632s left) gem_exec_schedule (pi-ringfull)
[387.073134] Starting subtest: pi-ringfull
[387.075274] Starting dynamic subtest: rcs0
[387.099550] Dynamic subtest rcs0: SUCCESS (0.029s)
[387.113320] Starting dynamic subtest: bcs0
[387.128714] Dynamic subtest bcs0: SUCCESS (0.028s)
[387.140902] Starting dynamic subtest: vcs0
[387.157947] Dynamic subtest vcs0: SUCCESS (0.028s)
[387.172689] Starting dynamic subtest: vcs1
[387.185563] Dynamic subtest vcs1: SUCCESS (0.027s)
[387.200455] Starting dynamic subtest: vecs0
[387.213816] Dynamic subtest vecs0: SUCCESS (0.027s)
[387.228363] Starting dynamic subtest: ccs0
[387.242216] Dynamic subtest ccs0: SUCCESS (0.027s)
[387.244339] Subtest pi-ringfull: SUCCESS (0.172s)
[387.468272] [085/156] (632s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[387.544439] Starting subtest: primary-yf-tiled-reflect-x-180
[387.617462] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.070s)
[387.720836] [086/156] (632s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[387.804719] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[387.808693] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[387.898257] [087/156] (632s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[387.999849] Starting subtest: 2x-long-flip-vs-cursor-atomic
[388.004298] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[388.143773] [088/156] (631s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[388.209557] Starting subtest: stress-mm-invalidate-close-overlap
[390.356664] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.149s)
[390.488634] [089/156] (629s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-shrfb-plflip-blt)
[390.568749] Starting subtest: fbchdr-2p-scndscrn-shrfb-plflip-blt
[390.573194] Subtest fbchdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[390.677659] [090/156] (629s left) gem_mmap_wc (write-cpu-read-wc)
[390.737947] Subtest write-cpu-read-wc: SKIP (0.000s)
[390.804727] [091/156] (629s left) gem_readwrite (new-obj)
[390.854665] Subtest new-obj: SKIP (0.000s)
[390.916767] [092/156] (629s left) kms_psr (psr-primary-mmap-cpu)
[390.984305] Starting subtest: psr-primary-mmap-cpu
[390.986649] Starting dynamic subtest: eDP-1
[392.683858] Dynamic subtest eDP-1: SUCCESS (1.700s)
[392.686156] Subtest psr-primary-mmap-cpu: SUCCESS (1.701s)
[393.550203] [093/156] (626s left) gem_create (create-valid-nonaligned)
[393.602989] Starting subtest: create-valid-nonaligned
[393.604862] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[393.800712] [094/156] (626s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[393.877556] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[393.881773] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[393.973739] [095/156] (626s left) kms_color (ctm-green-to-red)
[394.054133] Starting subtest: ctm-green-to-red
[394.056053] Starting dynamic subtest: pipe-A-eDP-1
[394.755041] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.700s)
[394.765162] Starting dynamic subtest: pipe-B-eDP-1
[396.173752] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.419s)
[396.183364] Starting dynamic subtest: pipe-C-eDP-1
[397.507937] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.334s)
[397.517722] Starting dynamic subtest: pipe-D-eDP-1
[398.825233] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.316s)
[398.827750] Subtest ctm-green-to-red: SUCCESS (4.772s)
[399.668488] [096/156] (620s left) kms_chamelium_hpd (dp-hpd)
[400.044067] Subtest dp-hpd: SKIP (0.000s)
[400.883241] [097/156] (619s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[400.960022] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[400.964034] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[401.053303] [098/156] (619s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[401.137378] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[402.150330] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.012s)
[402.270546] [099/156] (618s left) kms_frontbuffer_tracking (hdr-rgb565-draw-render)
[402.353894] Starting subtest: hdr-rgb565-draw-render
[402.358469] Subtest hdr-rgb565-draw-render: SKIP (0.000s)
[402.445869] [100/156] (618s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[402.525922] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[402.529403] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[402.636440] [101/156] (617s left) gem_mmap_gtt (big-copy-xy)
[402.685094] Subtest big-copy-XY: SKIP (0.000s)
[402.741966] [102/156] (617s left) kms_psr (fbc-psr-cursor-blt)
[402.808912] Starting subtest: fbc-psr-cursor-blt
[402.810928] Starting dynamic subtest: eDP-1
[402.814695] Dynamic subtest eDP-1: SKIP (0.000s)
[402.818261] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[402.896341] [103/156] (617s left) gem_render_copy (y-tiled)
[402.949089] Starting subtest: y-tiled
[402.953083] Subtest y-tiled: SKIP (0.000s)
[403.133408] [104/156] (617s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[403.214881] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[403.219435] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[403.327427] [105/156] (617s left) kms_frontbuffer_tracking (hdr-2p-primscrn-shrfb-plflip-blt)
[403.410738] Starting subtest: hdr-2p-primscrn-shrfb-plflip-blt
[403.414873] Subtest hdr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[403.487651] [106/156] (617s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[403.577476] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[403.580153] Starting dynamic subtest: pipe-A-default-mode
[406.331485] Dynamic subtest pipe-A-default-mode: SUCCESS (2.752s)
[406.333799] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.753s)
[407.212271] [107/156] (613s left) gem_flink_basic (bad-open)
[407.264803] Starting subtest: bad-open
[407.266812] Subtest bad-open: SUCCESS (0.000s)
[407.370403] [108/156] (613s left) gem_mmap_gtt (cpuset-big-copy-odd)
[407.417065] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[407.489780] [109/156] (613s left) gem_exec_params (batch-first)
[407.536783] Starting subtest: batch-first
[407.541662] Subtest batch-first: SUCCESS (0.005s)
[407.678401] [110/156] (613s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-onoff)
[407.759374] Starting subtest: fbchdr-2p-primscrn-cur-indfb-onoff
[407.763657] Subtest fbchdr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[407.857929] [111/156] (613s left) kms_psr (psr2-cursor-blt)
[407.927195] Starting subtest: psr2-cursor-blt
[407.929521] Starting dynamic subtest: eDP-1
[409.679475] Dynamic subtest eDP-1: SUCCESS (1.753s)
[409.681858] Subtest psr2-cursor-blt: SUCCESS (1.754s)
[410.564130] [112/156] (610s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[410.649672] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[410.653866] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[410.742784] [113/156] (610s left) syncobj_timeline (transfer-timeline-point)
[410.799718] Starting subtest: transfer-timeline-point
[410.801990] Subtest transfer-timeline-point: SUCCESS (0.000s)
[410.894908] [114/156] (610s left) kms_prop_blob (invalid-get-prop-any)
[410.954658] Starting subtest: invalid-get-prop-any
[410.956604] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[411.052157] [115/156] (610s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-blt)
[411.143229] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-blt
[411.147652] Subtest psrhdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[411.224860] [116/156] (609s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[411.279650] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[411.281931] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[411.380881] [117/156] (609s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[411.431688] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[411.433977] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[411.530505] [118/156] (609s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-wc)
[411.608813] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-wc
[411.612437] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[411.700943] [119/156] (609s left) gem_mmap_gtt (basic-read-write-distinct)
[411.759101] Subtest basic-read-write-distinct: SKIP (0.000s)
[411.817415] [120/156] (609s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-fullscreen)
[411.897375] Starting subtest: fbchdr-2p-primscrn-spr-indfb-fullscreen
[411.900761] Subtest fbchdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[411.998125] [121/156] (609s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[412.092218] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[412.728731] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.637s)
[412.910554] [122/156] (608s left) kms_cursor_crc (cursor-random-128x128)
[413.094451] Starting subtest: cursor-random-128x128
[413.099265] Starting dynamic subtest: pipe-A-eDP-1
[416.435776] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.337s)
[416.466908] Starting dynamic subtest: pipe-D-eDP-1
[420.465223] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.007s)
[420.467508] Subtest cursor-random-128x128: SUCCESS (7.370s)
[421.319670] [123/156] (600s left) gem_render_copy (yf-tiled-to-vebox-linear)
[421.369024] Starting subtest: yf-tiled-to-vebox-linear
[421.373431] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[421.547349] [124/156] (599s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[421.623781] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[424.103532] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (2.485s)
[425.235592] [125/156] (596s left) kms_addfb_basic (unused-handle)
[425.292235] Starting subtest: unused-handle
[425.294117] Subtest unused-handle: SUCCESS (0.000s)
[425.407320] [126/156] (596s left) gem_exec_balancer (invalid-bonds)
[425.474203] Starting subtest: invalid-bonds
[425.478324] Subtest invalid-bonds: SKIP (0.000s)
[425.780710] [127/156] (595s left) gem_ctx_param (invalid-param-set)
[425.833018] Starting subtest: invalid-param-set
[425.835532] Subtest invalid-param-set: SUCCESS (0.000s)
[425.916656] [128/156] (595s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[425.994776] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[425.997076] Starting dynamic subtest: pipe-A-eDP-1
[426.019759] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[426.032612] Starting dynamic subtest: pipe-B-eDP-1
[426.053209] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[426.062247] Starting dynamic subtest: pipe-C-eDP-1
[426.082898] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[426.091671] Starting dynamic subtest: pipe-D-eDP-1
[426.112416] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[426.116502] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.005s)
[428.278186] [129/156] (593s left) i915_pm_rc6_residency (media-rc6-accuracy)
[428.332969] Starting subtest: media-rc6-accuracy
[428.337397] Subtest media-rc6-accuracy: SKIP (0.000s)
[428.427840] [130/156] (593s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[428.511984] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-mmap-wc
[428.516344] Subtest hdr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[428.603455] [131/156] (593s left) gem_eio (wait-1us)
[428.820349] Starting subtest: wait-1us
[429.161222] Subtest wait-1us: SUCCESS (0.342s)
[429.280137] [132/156] (592s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[429.367023] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[429.370514] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[429.457261] [133/156] (592s left) perf_pmu (all-busy-check-all)
[429.498794] Starting subtest: all-busy-check-all
[430.986181] Subtest all-busy-check-all: SUCCESS (1.486s)
[431.089614] [134/156] (590s left) gem_flink_basic (double-flink)
[431.134799] Starting subtest: double-flink
[431.137375] Subtest double-flink: SUCCESS (0.000s)
[431.252274] [135/156] (590s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[431.325980] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[431.330229] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[431.445507] [136/156] (590s left) gem_tiled_swapping (non-threaded)
[431.495577] Subtest non-threaded: SKIP (0.000s)
[431.561467] [137/156] (590s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[431.626945] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[431.629266] Starting dynamic subtest: pipe-A
[431.965213] Dynamic subtest pipe-A: SUCCESS (0.339s)
[431.975784] Starting dynamic subtest: pipe-B
[433.354929] Dynamic subtest pipe-B: SUCCESS (1.389s)
[433.365007] Starting dynamic subtest: pipe-C
[434.792130] Dynamic subtest pipe-C: SUCCESS (1.436s)
[434.801918] Starting dynamic subtest: pipe-D
[436.219443] Dynamic subtest pipe-D: SUCCESS (1.427s)
[436.221790] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.594s)
[437.378743] [138/156] (584s left) kms_cursor_crc (cursor-random-max-size)
[437.650091] Starting subtest: cursor-random-max-size
[437.656060] Subtest cursor-random-max-size: SKIP (0.000s)
[437.773646] [139/156] (584s left) syncobj_timeline (invalid-query-zero-handles)
[437.826049] Starting subtest: invalid-query-zero-handles
[437.828335] Subtest invalid-query-zero-handles: SUCCESS (0.000s)
[437.928215] [140/156] (584s left) syncobj_eventfd (invalid-bad-flags)
[437.977295] Starting subtest: invalid-bad-flags
[437.979529] Subtest invalid-bad-flags: SUCCESS (0.000s)
[438.071558] [141/156] (584s left) kms_plane_scaling (planes-upscale-20x20)
[438.151289] Starting subtest: planes-upscale-20x20
[438.153593] Starting dynamic subtest: pipe-A
[438.212046] Dynamic subtest pipe-A: SUCCESS (0.062s)
[438.223645] Starting dynamic subtest: pipe-B
[439.398192] Dynamic subtest pipe-B: SUCCESS (1.185s)
[439.411485] Starting dynamic subtest: pipe-C
[440.501277] Dynamic subtest pipe-C: SUCCESS (1.102s)
[440.511251] Starting dynamic subtest: pipe-D
[441.635849] Dynamic subtest pipe-D: SUCCESS (1.134s)
[441.638297] Subtest planes-upscale-20x20: SUCCESS (3.487s)
[442.776591] [142/156] (579s left) gem_exec_reloc (basic-wc-read-active)
[442.833989] Subtest basic-wc-read-active: SKIP (0.000s)
[442.905899] [143/156] (579s left) gem_create (create-invalid-size)
[442.951568] Starting subtest: create-invalid-size
[442.953817] Subtest create-invalid-size: SUCCESS (0.000s)
[443.150940] [144/156] (579s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[443.225200] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[443.229703] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[443.299217] [145/156] (579s left) perf_pmu (invalid-open)
[443.341856] Starting subtest: invalid-open
[443.344071] Subtest invalid-open: SUCCESS (0.000s)
[443.463113] [146/156] (578s left) gem_exec_gttfill (multigpu-basic)
[443.629711] Starting subtest: multigpu-basic
[456.058370] Subtest multigpu-basic: SUCCESS (12.430s)
[456.157880] [147/156] (566s left) gem_ccs (block-multicopy-compressed)
[456.260029] Starting subtest: block-multicopy-compressed
[456.264770] Subtest block-multicopy-compressed: SKIP (0.000s)
[456.359759] [148/156] (566s left) core_setmaster (master-drop-set-root)
[456.427386] Starting subtest: master-drop-set-root
[456.452863] Subtest master-drop-set-root: SUCCESS (0.025s)
[456.504156] [149/156] (566s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-pwrite)
[456.593729] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-pwrite
[456.598129] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[456.699747] [150/156] (565s left) gem_exec_flush (basic-uc-rw-default)
[456.757426] Starting subtest: basic-uc-rw-default
[462.212890] Subtest basic-uc-rw-default: SUCCESS (5.456s)
[462.417556] [151/156] (560s left) sw_sync (sync_busy_fork_unixsocket)
[462.453586] Starting subtest: sync_busy_fork_unixsocket
[462.456868] Subtest sync_busy_fork_unixsocket: SUCCESS (0.006s)
[462.521080] [152/156] (560s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[462.615421] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area
[462.617754] Starting dynamic subtest: pipe-A-eDP-1
[462.711103] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[462.724331] Starting dynamic subtest: pipe-B-eDP-1
[463.858927] Dynamic subtest pipe-B-eDP-1: SKIP (1.145s)
[463.863704] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.247s)
[465.138737] [153/156] (557s left) gem_userptr_blits (process-exit)
[465.199254] Starting subtest: process-exit
[465.204959] Subtest process-exit: SUCCESS (0.009s)
[465.322800] [154/156] (557s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[465.404838] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[465.407121] Starting dynamic subtest: pipe-A-eDP-1
[465.430068] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[465.443216] Starting dynamic subtest: pipe-B-eDP-1
[465.465068] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[465.474689] Starting dynamic subtest: pipe-C-eDP-1
[465.496325] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[465.505784] Starting dynamic subtest: pipe-D-eDP-1
[465.528753] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[465.533179] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.004s)
[467.705707] [155/156] (555s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-blt)
[467.797701] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-blt
[467.802029] Subtest psrhdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[467.895125] [156/156] (554s left) gem_ctx_isolation (preservation-s3)
[467.957079] Starting subtest: preservation-S3
[467.959435] Starting dynamic subtest: rcs0
[484.253450] Dynamic subtest rcs0: SUCCESS (2.143s)
[484.267329] Starting dynamic subtest: bcs0
[500.250956] Dynamic subtest bcs0: SUCCESS (1.333s)
[500.262880] Starting dynamic subtest: vcs0
[516.279392] Dynamic subtest vcs0: SUCCESS (2.642s)
[516.290903] Starting dynamic subtest: vcs1
[534.265975] Dynamic subtest vcs1: SUCCESS (4.967s)
[534.276675] Starting dynamic subtest: vecs0
[552.242885] Dynamic subtest vecs0: SUCCESS (4.988s)
[552.254494] Starting dynamic subtest: ccs0
[570.245005] Dynamic subtest ccs0: SUCCESS (3.195s)
[570.247654] Subtest preservation-S3: SUCCESS (19.274s)
[570.465543] Closing watchdogs
results: parsing output: 0/ for test: kms_flip_scaled_crc
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: syncobj_eventfd
results: parsing output: 4/ for test: kms_cursor_legacy
results: parsing output: 5/ for test: kms_pm_rpm
results: parsing output: 6/ for test: kms_feature_discovery
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: vgem_basic
results: parsing output: 11/ for test: kms_big_fb
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_flip
results: parsing output: 14/ for test: gem_ctx_persistence
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: gem_exec_schedule
results: parsing output: 18/ for test: gem_pxp
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_psr
results: parsing output: 22/ for test: kms_vblank
results: parsing output: 23/ for test: kms_plane_lowres
results: parsing output: 24/ for test: kms_cursor_edge_walk
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: kms_ccs
results: parsing output: 27/ for test: i915_module_load
results: parsing output: 28/ for test: kms_chamelium_frames
results: parsing output: 29/ for test: gem_create
results: parsing output: 30/ for test: kms_cursor_legacy
results: parsing output: 31/ for test: kms_ccs
results: parsing output: 32/ for test: gem_exec_suspend
results: parsing output: 33/ for test: kms_async_flips
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_plane_alpha_blend
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_mmap_gtt
results: parsing output: 39/ for test: gem_partial_pwrite_pread
results: parsing output: 40/ for test: kms_tiled_display
results: parsing output: 41/ for test: kms_chamelium_audio
results: parsing output: 42/ for test: gem_pxp
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: i915_suspend
results: parsing output: 46/ for test: kms_lease
results: parsing output: 47/ for test: kms_atomic
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: gem_exec_reloc
results: parsing output: 50/ for test: kms_invalid_mode
results: parsing output: 51/ for test: gem_lmem_swapping
results: parsing output: 52/ for test: kms_atomic_transition
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: kms_content_protection
results: parsing output: 55/ for test: gem_exec_balancer
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_flip
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: perf
results: parsing output: 60/ for test: api_intel_allocator
results: parsing output: 61/ for test: gen9_exec_parse
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: i915_drm_fdinfo
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: gem_spin_batch
results: parsing output: 66/ for test: gem_wait
results: parsing output: 67/ for test: syncobj_wait
results: parsing output: 68/ for test: api_intel_bb
results: parsing output: 69/ for test: gem_exec_store
results: parsing output: 70/ for test: kms_plane
results: parsing output: 71/ for test: gem_exec_fence
results: parsing output: 72/ for test: gem_ctx_shared
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_bad_reloc
results: parsing output: 75/ for test: kms_flip
results: parsing output: 76/ for test: kms_getfb
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_atomic_interruptible
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_psr2_sf
results: parsing output: 83/ for test: gem_exec_schedule
results: parsing output: 84/ for test: kms_rotation_crc
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_cursor_legacy
results: parsing output: 87/ for test: gem_userptr_blits
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: gem_mmap_wc
results: parsing output: 90/ for test: gem_readwrite
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: gem_create
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_color
results: parsing output: 95/ for test: kms_chamelium_hpd
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_mmap_gtt
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: gem_render_copy
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_flip_scaled_crc
results: parsing output: 106/ for test: gem_flink_basic
results: parsing output: 107/ for test: gem_mmap_gtt
results: parsing output: 108/ for test: gem_exec_params
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_psr
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: kms_prop_blob
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: syncobj_timeline
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: gem_mmap_gtt
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: kms_cursor_crc
results: parsing output: 122/ for test: gem_render_copy
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_addfb_basic
results: parsing output: 125/ for test: gem_exec_balancer
results: parsing output: 126/ for test: gem_ctx_param
results: parsing output: 127/ for test: kms_ccs
results: parsing output: 128/ for test: i915_pm_rc6_residency
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: gem_eio
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: perf_pmu
results: parsing output: 133/ for test: gem_flink_basic
results: parsing output: 134/ for test: kms_frontbuffer_tracking
results: parsing output: 135/ for test: gem_tiled_swapping
results: parsing output: 136/ for test: kms_plane_scaling
results: parsing output: 137/ for test: kms_cursor_crc
results: parsing output: 138/ for test: syncobj_timeline
results: parsing output: 139/ for test: syncobj_eventfd
results: parsing output: 140/ for test: kms_plane_scaling
results: parsing output: 141/ for test: gem_exec_reloc
results: parsing output: 142/ for test: gem_create
results: parsing output: 143/ for test: kms_flip_scaled_crc
results: parsing output: 144/ for test: perf_pmu
results: parsing output: 145/ for test: gem_exec_gttfill
results: parsing output: 146/ for test: gem_ccs
results: parsing output: 147/ for test: core_setmaster
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: gem_exec_flush
results: parsing output: 150/ for test: sw_sync
results: parsing output: 151/ for test: kms_psr2_sf
results: parsing output: 152/ for test: gem_userptr_blits
results: parsing output: 153/ for test: kms_ccs
results: parsing output: 154/ for test: kms_frontbuffer_tracking
results: parsing output: 155/ for test: gem_ctx_isolation
Done.