[61.741869] Initializing watchdogs
[61.741915]   /dev/watchdog0
[61.757221] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[61.761165] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.763194] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.766726] [001/156] (960s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[61.863715] Starting subtest: fbc-psr2-primary-mmap-cpu
[61.865990] Starting dynamic subtest: eDP-1
[61.870228] Dynamic subtest eDP-1: SKIP (0.000s)
[61.874620] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.000s)
[61.927313] [002/156] (960s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[62.005839] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[68.865903] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.855s)
[68.986867] [003/156] (953s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[69.082073] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[75.961728] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.883s)
[76.095395] [004/156] (946s left) gem_pxp (hw-rejects-pxp-buffer)
[76.227410] Starting subtest: hw-rejects-pxp-buffer
[76.232305] Subtest hw-rejects-pxp-buffer: SKIP (0.000s)
[76.330653] [005/156] (946s left) syncobj_timeline (multi-wait-for-submit-signaled)
[76.382217] Starting subtest: multi-wait-for-submit-signaled
[76.384531] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[76.490153] [006/156] (945s left) i915_pm_rps (reset)
[76.545071] Starting subtest: reset
[84.943748] Subtest reset: SUCCESS (8.395s)
[85.101531] [007/156] (937s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-render)
[85.189667] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-render
[85.194300] Subtest hdr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[85.275819] [008/156] (937s left) perf (missing-sample-flags)
[85.411968] Starting subtest: missing-sample-flags
[85.413905] Subtest missing-sample-flags: SUCCESS (0.000s)
[85.451928] [009/156] (937s left) gem_ctx_shared (exec-single-timeline)
[85.508863] Starting subtest: exec-single-timeline
[85.511067] Starting dynamic subtest: rcs0
[86.559212] Dynamic subtest rcs0: SUCCESS (1.048s)
[86.571780] Starting dynamic subtest: bcs0
[87.642245] Dynamic subtest bcs0: SUCCESS (1.082s)
[87.653245] Starting dynamic subtest: vcs0
[88.731319] Dynamic subtest vcs0: SUCCESS (1.088s)
[88.742720] Starting dynamic subtest: vcs1
[89.820425] Dynamic subtest vcs1: SUCCESS (1.087s)
[89.831076] Starting dynamic subtest: vecs0
[90.908269] Dynamic subtest vecs0: SUCCESS (1.085s)
[90.919316] Starting dynamic subtest: ccs0
[91.995578] Dynamic subtest ccs0: SUCCESS (1.087s)
[91.998412] Subtest exec-single-timeline: SUCCESS (6.484s)
[92.181201] [010/156] (930s left) prime_vgem (sync)
[92.303460] Starting subtest: sync
[92.305486] Starting dynamic subtest: rcs0
[92.359359] Dynamic subtest rcs0: SUCCESS (0.057s)
[92.368852] Starting dynamic subtest: bcs0
[92.408616] Dynamic subtest bcs0: SUCCESS (0.049s)
[92.416784] Starting dynamic subtest: vcs0
[92.461051] Dynamic subtest vcs0: SUCCESS (0.052s)
[92.469730] Starting dynamic subtest: vcs1
[92.504863] Dynamic subtest vcs1: SUCCESS (0.044s)
[92.513207] Starting dynamic subtest: vecs0
[92.552380] Dynamic subtest vecs0: SUCCESS (0.047s)
[92.560576] Starting dynamic subtest: ccs0
[92.598847] Dynamic subtest ccs0: SUCCESS (0.047s)
[92.601106] Subtest sync: SUCCESS (0.297s)
[92.715867] [FACT prime_vgem (sync)] new: kernel.kmod_is_loaded.vgem: true
[92.721319] [011/156] (929s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[92.806733] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[92.809147] Starting dynamic subtest: pipe-A-eDP-1
[99.515149] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.712s)
[99.524787] Starting dynamic subtest: pipe-B-eDP-1
[106.567191] Dynamic subtest pipe-B-eDP-1: SUCCESS (7.048s)
[106.569448] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.763s)
[107.459171] [012/156] (915s left) kms_addfb_basic (bad-pitch-65536)
[107.515725] Starting subtest: bad-pitch-65536
[107.517621] Subtest bad-pitch-65536: SUCCESS (0.000s)
[107.639109] [013/156] (915s left) kms_plane (pixel-format-4-tiled-modifier)
[107.710062] Starting subtest: pixel-format-4-tiled-modifier
[107.738275] Starting dynamic subtest: pipe-A-plane-0
[108.160313] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s)
[108.168724] Starting dynamic subtest: pipe-A-plane-3
[108.482314] Dynamic subtest pipe-A-plane-3: SUCCESS (0.322s)
[108.491455] Starting dynamic subtest: pipe-A-plane-5
[108.495599] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[109.638798] Starting dynamic subtest: pipe-B-plane-0
[110.054237] Dynamic subtest pipe-B-plane-0: SUCCESS (0.422s)
[110.062965] Starting dynamic subtest: pipe-B-plane-3
[110.387514] Dynamic subtest pipe-B-plane-3: SUCCESS (0.332s)
[110.397998] Starting dynamic subtest: pipe-B-plane-5
[110.402658] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[110.707331] Subtest pixel-format-4-tiled-modifier: SUCCESS (2.997s)
[111.516897] [014/156] (911s left) api_intel_allocator (two-level-inception)
[111.573512] Starting subtest: two-level-inception
[116.974708] Subtest two-level-inception: SUCCESS (5.401s)
[117.089935] [015/156] (905s left) gem_ctx_persistence (legacy-engines-mixed-process)
[117.156553] Starting subtest: legacy-engines-mixed-process
[117.159529] Starting dynamic subtest: render
[119.213888] Dynamic subtest render: SUCCESS (2.055s)
[119.227190] Starting dynamic subtest: bsd1
[121.213542] Dynamic subtest bsd1: SUCCESS (2.001s)
[121.222375] Starting dynamic subtest: bsd2
[123.200771] Dynamic subtest bsd2: SUCCESS (1.986s)
[123.210169] Starting dynamic subtest: blt
[125.256445] Dynamic subtest blt: SUCCESS (2.054s)
[125.269760] Starting dynamic subtest: vebox
[127.234720] Dynamic subtest vebox: SUCCESS (1.977s)
[127.237132] Subtest legacy-engines-mixed-process: SUCCESS (10.079s)
[127.313965] [016/156] (895s left) kms_atomic_interruptible (universal-setplane-cursor)
[127.396813] Starting subtest: universal-setplane-cursor
[127.399108] Starting dynamic subtest: pipe-A-eDP-1
[134.825819] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.426s)
[134.828231] Subtest universal-setplane-cursor: SUCCESS (7.427s)
[135.684075] [017/156] (887s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[135.768042] Starting subtest: fbc-modesetfrombusy
[139.614796] Subtest fbc-modesetfrombusy: SUCCESS (3.855s)
[140.790340] [018/156] (882s left) gem_softpin (evict-active)
[140.847661] Starting subtest: evict-active
[140.853642] Subtest evict-active: SUCCESS (0.006s)
[140.969260] [019/156] (882s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[141.046280] Starting subtest: extended-pageflip-modeset-hang-oldfb
[141.048649] Starting dynamic subtest: pipe-A
[148.972273] Dynamic subtest pipe-A: SUCCESS (7.924s)
[148.980851] Starting dynamic subtest: pipe-D
[157.573894] Dynamic subtest pipe-D: SUCCESS (8.600s)
[157.576205] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.527s)
[158.419785] [020/156] (864s left) kms_hdr (bpc-switch-dpms)
[158.501158] Starting subtest: bpc-switch-dpms
[158.503463] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[164.105227] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SUCCESS (5.603s)
[164.115278] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[169.682540] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SUCCESS (5.576s)
[169.685060] Subtest bpc-switch-dpms: SUCCESS (11.182s)
[169.808568] [021/156] (853s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[169.897153] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[169.901239] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[170.016222] [022/156] (853s left) gem_huc_copy (huc-copy)
[170.074657] Starting subtest: huc-copy
[170.076908] Subtest huc-copy: SUCCESS (0.003s)
[170.195353] [023/156] (852s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[170.284590] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[174.751072] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.474s)
[175.967241] [024/156] (847s left) i915_drm_fdinfo (virtual-idle)
[176.002949] Starting subtest: virtual-idle
[179.061826] Subtest virtual-idle: SUCCESS (3.058s)
[179.152353] [025/156] (844s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[179.229568] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[179.231854] Starting dynamic subtest: pipe-A-eDP-1
[179.253061] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[179.264328] Starting dynamic subtest: pipe-B-eDP-1
[179.284866] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[179.293467] Starting dynamic subtest: pipe-C-eDP-1
[179.313902] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[179.322330] Starting dynamic subtest: pipe-D-eDP-1
[179.342156] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[179.344347] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.007s)
[181.502234] [026/156] (841s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[181.579426] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[184.110625] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (2.538s)
[185.257382] [027/156] (838s left) syncobj_timeline (wait-all-for-submit-complex)
[185.312030] Starting subtest: wait-all-for-submit-complex
[185.524768] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[185.612071] [028/156] (837s left) gem_mmap_gtt (basic-short)
[185.658680] Subtest basic-short: SKIP (0.000s)
[185.713267] [029/156] (837s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[185.764945] Starting subtest: etime-multi-wait-all-available-unsubmitted
[185.873414] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.108s)
[185.949965] [030/156] (837s left) kms_pm_dc (dc5-dpms)
[187.026893] Starting subtest: dc5-dpms
[189.109091] Subtest dc5-dpms: SUCCESS (2.082s)
[189.198661] [031/156] (834s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-pgflip-blt)
[189.289572] Starting subtest: psrhdr-2p-scndscrn-shrfb-pgflip-blt
[189.293970] Subtest psrhdr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[189.391714] [032/156] (834s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[189.471731] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[189.475954] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[189.578348] [033/156] (834s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[189.652016] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[189.656580] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[190.785959] [034/156] (832s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[190.871802] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[190.875812] Subtest psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[190.988958] [035/156] (832s left) kms_cursor_crc (cursor-offscreen-512x170)
[191.261287] Starting subtest: cursor-offscreen-512x170
[191.265580] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[191.418395] [036/156] (832s left) kms_flip (plain-flip-fb-recreate-interruptible)
[191.497149] Starting subtest: plain-flip-fb-recreate-interruptible
[191.499495] Starting dynamic subtest: A-eDP1
[200.378069] Dynamic subtest A-eDP1: SUCCESS (8.880s)
[200.388080] Starting dynamic subtest: B-eDP1
[209.215853] Dynamic subtest B-eDP1: SUCCESS (8.836s)
[209.224488] Starting dynamic subtest: C-eDP1
[218.036375] Dynamic subtest C-eDP1: SUCCESS (8.819s)
[218.045141] Starting dynamic subtest: D-eDP1
[226.866939] Dynamic subtest D-eDP1: SUCCESS (8.829s)
[226.871513] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.372s)
[228.067032] [037/156] (795s left) gem_busy (parallel)
[228.250977] Starting subtest: parallel
[228.253352] Starting dynamic subtest: rcs0
[230.205908] Dynamic subtest rcs0: SUCCESS (1.953s)
[230.218485] Starting dynamic subtest: bcs0
[232.253683] Dynamic subtest bcs0: SUCCESS (2.046s)
[232.264443] Starting dynamic subtest: vcs0
[234.237883] Dynamic subtest vcs0: SUCCESS (1.981s)
[234.250574] Starting dynamic subtest: vcs1
[236.222336] Dynamic subtest vcs1: SUCCESS (1.982s)
[236.234776] Starting dynamic subtest: vecs0
[238.206263] Dynamic subtest vecs0: SUCCESS (1.981s)
[238.218354] Starting dynamic subtest: ccs0
[240.254157] Dynamic subtest ccs0: SUCCESS (2.045s)
[240.256724] Subtest parallel: SUCCESS (12.003s)
[240.506273] [038/156] (783s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[240.594453] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc
[240.598685] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[240.685639] [039/156] (783s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[240.758570] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[240.760844] Starting dynamic subtest: pipe-A
[241.097078] Dynamic subtest pipe-A: SUCCESS (0.339s)
[241.106470] Starting dynamic subtest: pipe-B
[242.547208] Dynamic subtest pipe-B: SUCCESS (1.449s)
[242.560231] Starting dynamic subtest: pipe-C
[243.974549] Dynamic subtest pipe-C: SUCCESS (1.427s)
[243.983214] Starting dynamic subtest: pipe-D
[245.406632] Dynamic subtest pipe-D: SUCCESS (1.431s)
[245.409015] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.650s)
[246.571185] [040/156] (777s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[246.630461] Starting subtest: multi-wait-all-available-submitted-signaled
[246.632903] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s)
[246.734129] [041/156] (777s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[246.815164] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-mmap-gtt
[246.819174] Subtest hdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[246.919208] [042/156] (777s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-pwrite)
[246.993587] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-pwrite
[246.997831] Subtest hdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[247.080601] [043/156] (776s left) kms_flip (2x-dpms-vs-vblank-race-interruptible)
[247.161333] Starting subtest: 2x-dpms-vs-vblank-race-interruptible
[247.170383] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.008s)
[247.252357] [044/156] (776s left) syncobj_basic (bad-flags-handle-to-fd)
[247.299808] Starting subtest: bad-flags-handle-to-fd
[247.302082] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[247.415669] [045/156] (776s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[247.475464] Starting subtest: map-fixed-invalidate-overlap-busy
[247.479593] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[247.603316] [046/156] (776s left) kms_lease (lease-unleased-crtc)
[247.676243] Starting subtest: lease-unleased-crtc
[247.678144] Starting dynamic subtest: pipe-A-eDP-1
[247.966910] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[247.976264] Starting dynamic subtest: pipe-B-eDP-1
[248.721334] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.751s)
[248.734424] Starting dynamic subtest: pipe-C-eDP-1
[248.736862] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.005s)
[248.745267] Starting dynamic subtest: pipe-D-eDP-1
[248.747223] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.005s)
[248.749190] Subtest lease-unleased-crtc: SUCCESS (1.054s)
[249.107087] [047/156] (775s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[249.162821] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[249.165131] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[249.262375] [048/156] (774s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[249.327061] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[249.329369] Starting dynamic subtest: pipe-A-eDP-1
[249.352020] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[249.362866] Starting dynamic subtest: pipe-B-eDP-1
[249.384792] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[249.393328] Starting dynamic subtest: pipe-C-eDP-1
[249.415091] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[249.423278] Starting dynamic subtest: pipe-D-eDP-1
[249.445311] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[249.449698] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[251.583013] [049/156] (772s left) gem_flink_basic (bad-open)
[251.644751] Starting subtest: bad-open
[251.647105] Subtest bad-open: SUCCESS (0.000s)
[251.749108] [050/156] (772s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[251.836669] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[251.840667] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[251.948387] [051/156] (772s left) kms_dirtyfb (drrs-dirtyfb-ioctl)
[252.026109] Starting subtest: drrs-dirtyfb-ioctl
[252.039191] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s)
[252.124932] [052/156] (772s left) gem_userptr_blits (create-destroy-unsync)
[252.187719] Subtest create-destroy-unsync: SKIP (0.000s)
[252.326398] [053/156] (772s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[252.412263] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc
[252.416555] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[252.506329] [054/156] (771s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-pwrite)
[252.588913] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-pwrite
[252.592334] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[252.677658] [055/156] (771s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[252.757086] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[252.760958] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[252.835950] [056/156] (771s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[252.912035] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[252.915904] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[253.020499] [057/156] (771s left) gem_spin_batch (legacy-resubmit)
[253.084824] Starting subtest: legacy-resubmit
[253.086913] Starting dynamic subtest: default
[253.091108] Dynamic subtest default: SUCCESS (0.005s)
[253.100150] Starting dynamic subtest: render
[253.101944] Dynamic subtest render: SUCCESS (0.001s)
[253.110955] Starting dynamic subtest: bsd
[253.112724] Dynamic subtest bsd: SUCCESS (0.002s)
[253.120651] Starting dynamic subtest: bsd1
[253.122473] Dynamic subtest bsd1: SUCCESS (0.002s)
[253.130699] Starting dynamic subtest: bsd2
[253.132470] Dynamic subtest bsd2: SUCCESS (0.001s)
[253.140468] Starting dynamic subtest: blt
[253.142176] Dynamic subtest blt: SUCCESS (0.003s)
[253.150066] Starting dynamic subtest: vebox
[253.151801] Dynamic subtest vebox: SUCCESS (0.003s)
[253.153567] Subtest legacy-resubmit: SUCCESS (0.022s)
[253.342539] [058/156] (771s left) gem_exec_whisper (basic-fds)
[253.403506] Starting subtest: basic-fds
[261.215800] Subtest basic-fds: SUCCESS (7.809s)
[261.410162] [059/156] (763s left) kms_frontbuffer_tracking (fbcpsrhdr-stridechange)
[261.502349] Starting subtest: fbcpsrhdr-stridechange
[261.506664] Subtest fbcpsrhdr-stridechange: SKIP (0.000s)
[261.601986] [060/156] (763s left) kms_flip (2x-modeset-vs-vblank-race)
[261.683398] Starting subtest: 2x-modeset-vs-vblank-race
[261.691557] Subtest 2x-modeset-vs-vblank-race: SKIP (0.010s)
[261.806476] [061/156] (762s left) gem_ctx_param (get-priority-new-ctx)
[261.867599] Starting subtest: get-priority-new-ctx
[261.870143] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[261.975982] [062/156] (762s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-fullscreen)
[262.061562] Starting subtest: hdr-2p-scndscrn-spr-indfb-fullscreen
[262.065890] Subtest hdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[262.156366] [063/156] (762s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[262.230519] Starting subtest: psr2-cursor-plane-move-continuous-sf
[262.232752] Starting dynamic subtest: pipe-A-eDP-1
[272.582561] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.355s)
[272.592858] Starting dynamic subtest: pipe-B-eDP-1
[283.640640] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.055s)
[283.642874] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (21.413s)
[284.534801] [064/156] (740s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[284.617792] Starting subtest: fbc-psr-sprite-mmap-gtt
[284.620022] Starting dynamic subtest: eDP-1
[284.624383] Dynamic subtest eDP-1: SKIP (0.000s)
[284.629162] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[284.691562] [065/156] (740s left) gem_vm_create (create-ext)
[284.744485] Starting subtest: create-ext
[284.750203] Subtest create-ext: SUCCESS (0.006s)
[284.877955] [066/156] (740s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[284.959680] Starting subtest: coverage-vs-premult-vs-constant
[285.261134] Starting dynamic subtest: pipe-A-eDP-1
[285.826986] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.563s)
[285.836823] Starting dynamic subtest: pipe-D-eDP-1
[287.128252] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.301s)
[287.130513] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.169s)
[287.968914] [067/156] (737s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[288.058295] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[288.062594] Subtest fbchdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[288.161141] [068/156] (736s left) gem_exec_reloc (basic-cpu-read-active)
[288.222205] Subtest basic-cpu-read-active: SKIP (0.000s)
[288.286108] [069/156] (736s left) kms_sequence (queue-idle)
[288.360575] Starting subtest: queue-idle
[288.362845] Starting dynamic subtest: pipe-A-eDP-1
[290.143550] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.783s)
[290.152794] Starting dynamic subtest: pipe-B-eDP-1
[292.651084] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.507s)
[292.665785] Starting dynamic subtest: pipe-C-eDP-1
[295.175672] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.519s)
[295.186403] Starting dynamic subtest: pipe-D-eDP-1
[297.612226] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.435s)
[297.614469] Subtest queue-idle: SUCCESS (9.250s)
[298.419592] [070/156] (726s left) kms_scaling_modes (scaling-mode-full-aspect)
[298.497259] Starting subtest: scaling-mode-full-aspect
[298.499449] Starting dynamic subtest: pipe-A-eDP-1
[298.600757] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.104s)
[298.611031] Starting dynamic subtest: pipe-B-eDP-1
[299.736939] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.135s)
[299.748578] Starting dynamic subtest: pipe-C-eDP-1
[300.854107] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.116s)
[300.864824] Starting dynamic subtest: pipe-D-eDP-1
[301.993073] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.137s)
[301.995385] Subtest scaling-mode-full-aspect: SUCCESS (3.498s)
[303.165259] [071/156] (721s left) kms_big_fb (linear-64bpp-rotate-270)
[303.250891] Starting subtest: linear-64bpp-rotate-270
[303.269634] Subtest linear-64bpp-rotate-270: SKIP (0.018s)
[303.370440] [072/156] (721s left) kms_cursor_crc (cursor-sliding-128x42)
[303.571921] Starting subtest: cursor-sliding-128x42
[303.613871] Subtest cursor-sliding-128x42: SKIP (0.040s)
[303.821448] [073/156] (721s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[303.904522] Starting subtest: 4-tiled-16bpp-rotate-180
[305.138665] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.234s)
[305.248701] [074/156] (720s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[305.344396] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[305.347834] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[305.443023] [075/156] (719s left) gem_mmap_gtt (flink-race)
[305.493444] Subtest flink-race: SKIP (0.000s)
[305.549731] [076/156] (719s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[305.920534] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[306.771667] [077/156] (718s left) api_intel_bb (simple-bb-ctx)
[306.834323] Starting subtest: simple-bb-ctx
[306.840640] Subtest simple-bb-ctx: SUCCESS (0.007s)
[306.958089] [078/156] (718s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[307.036090] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[307.040262] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[307.138653] [079/156] (718s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[307.222214] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[307.226278] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[307.318331] [080/156] (718s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[307.398755] Starting subtest: yf-tiled-16bpp-rotate-90
[307.403179] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[307.482442] [081/156] (718s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[307.565219] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[307.569392] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[307.653671] [082/156] (717s left) syncobj_wait (wait-for-submit-complex)
[307.711660] Starting subtest: wait-for-submit-complex
[307.772904] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[307.850767] [083/156] (717s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[307.923636] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[307.927154] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[308.047788] [084/156] (717s left) testdisplay
[308.350287] [085/156] (717s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-shrfb-fliptrack-mmap-gtt)
[308.427115] Starting subtest: fbcpsrhdr-1p-shrfb-fliptrack-mmap-gtt
[308.430787] Subtest fbcpsrhdr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[308.530032] [086/156] (717s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[308.606256] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[308.608218] Starting dynamic subtest: pipe-A
[308.669804] Dynamic subtest pipe-A: SUCCESS (0.064s)
[308.682970] Starting dynamic subtest: pipe-B
[309.812809] Dynamic subtest pipe-B: SUCCESS (1.141s)
[309.827063] Starting dynamic subtest: pipe-C
[310.925529] Dynamic subtest pipe-C: SUCCESS (1.112s)
[310.936167] Starting dynamic subtest: pipe-D
[312.052489] Dynamic subtest pipe-D: SUCCESS (1.126s)
[312.054915] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.447s)
[313.203072] [087/156] (712s left) gem_exec_schedule (preempt)
[313.266212] Starting subtest: preempt
[313.268061] Starting dynamic subtest: rcs0
[313.283650] Dynamic subtest rcs0: SUCCESS (0.024s)
[313.294104] Starting dynamic subtest: bcs0
[313.308774] Dynamic subtest bcs0: SUCCESS (0.024s)
[313.318080] Starting dynamic subtest: vcs0
[313.332363] Dynamic subtest vcs0: SUCCESS (0.023s)
[313.342915] Starting dynamic subtest: vcs1
[313.352091] Dynamic subtest vcs1: SUCCESS (0.019s)
[313.361866] Starting dynamic subtest: vecs0
[313.371589] Dynamic subtest vecs0: SUCCESS (0.019s)
[313.382073] Starting dynamic subtest: ccs0
[313.394588] Dynamic subtest ccs0: SUCCESS (0.022s)
[313.397305] Subtest preempt: SUCCESS (0.136s)
[315.278746] [088/156] (710s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-mmap-cpu)
[315.357624] Starting subtest: fbchdr-rgb565-draw-mmap-cpu
[315.361892] Subtest fbchdr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[315.461239] [089/156] (710s left) gem_exec_params (invalid-bsd-ring)
[315.525299] Starting subtest: invalid-bsd-ring
[315.527898] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[315.639342] [090/156] (710s left) kms_psr (psr-primary-blt)
[315.713589] Starting subtest: psr-primary-blt
[315.715823] Starting dynamic subtest: eDP-1
[317.507576] Dynamic subtest eDP-1: SUCCESS (1.794s)
[317.510813] Subtest psr-primary-blt: SUCCESS (1.795s)
[318.373196] [091/156] (707s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[318.431748] Subtest untiled-to-tiled: SKIP (0.000s)
[318.504962] [092/156] (707s left) gem_ctx_persistence (file)
[318.555802] Starting subtest: file
[318.673211] Subtest file: SUCCESS (0.117s)
[318.821477] [093/156] (707s left) gem_exec_params (sol-reset-invalid)
[318.879701] Starting subtest: sol-reset-invalid
[318.882347] Subtest sol-reset-invalid: SUCCESS (0.002s)
[320.324973] [094/156] (705s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[320.422573] Starting subtest: y-tiled-16bpp-rotate-0
[320.427071] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[320.528464] [095/156] (705s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[320.608240] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[320.612318] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[320.711749] [096/156] (705s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[320.794941] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc
[327.387272] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.596s)
[327.526444] [097/156] (698s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[327.605789] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[327.610224] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s)
[327.677849] [098/156] (698s left) gem_exec_reloc (basic-cpu-gtt)
[327.737960] Subtest basic-cpu-gtt: SKIP (0.000s)
[327.813683] [099/156] (698s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[327.889022] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[334.663347] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.779s)
[334.789083] [100/156] (691s left) kms_color (ctm-red-to-blue)
[334.870899] Starting subtest: ctm-red-to-blue
[334.873228] Starting dynamic subtest: pipe-A-eDP-1
[335.609660] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.738s)
[335.619886] Starting dynamic subtest: pipe-B-eDP-1
[337.097235] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.487s)
[337.107323] Starting dynamic subtest: pipe-C-eDP-1
[338.453076] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.356s)
[338.462491] Starting dynamic subtest: pipe-D-eDP-1
[339.799637] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.344s)
[339.802078] Subtest ctm-red-to-blue: SUCCESS (4.929s)
[340.605470] [101/156] (685s left) kms_psr (psr2-dpms)
[340.683092] Starting subtest: psr2-dpms
[340.685379] Starting dynamic subtest: eDP-1
[343.637460] Dynamic subtest eDP-1: SUCCESS (2.954s)
[343.639735] Subtest psr2-dpms: SUCCESS (2.955s)
[344.506642] [102/156] (681s left) kms_lease (atomic-implicit-crtc)
[344.589814] Starting subtest: atomic-implicit-crtc
[344.592119] Starting dynamic subtest: pipe-A-eDP-1
[344.603051] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[344.612930] Starting dynamic subtest: pipe-B-eDP-1
[344.624357] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[344.633708] Starting dynamic subtest: pipe-C-eDP-1
[344.644637] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[344.653642] Starting dynamic subtest: pipe-D-eDP-1
[344.664146] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[344.666220] Subtest atomic-implicit-crtc: SUCCESS (0.035s)
[344.732124] [103/156] (681s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-shrfb-fliptrack-mmap-gtt)
[344.808222] Starting subtest: fbcpsrhdr-2p-shrfb-fliptrack-mmap-gtt
[344.812553] Subtest fbcpsrhdr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[344.905096] [104/156] (681s left) gem_pread (display)
[344.971600] Subtest display: SKIP (0.000s)
[345.032638] [105/156] (681s left) syncobj_basic (bad-handle-to-fd)
[345.087335] Starting subtest: bad-handle-to-fd
[345.089505] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[345.201845] [106/156] (681s left) i915_drm_fdinfo (memory-info-idle)
[345.239082] Starting subtest: memory-info-idle
[345.241378] Starting dynamic subtest: smem0
[345.279583] Dynamic subtest smem0: SUCCESS (0.043s)
[345.282010] Subtest memory-info-idle: SUCCESS (0.044s)
[345.351137] [107/156] (681s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[345.432488] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[345.435948] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[345.529342] [108/156] (681s left) i915_query (query-topology-garbage-items)
[345.592318] Starting subtest: query-topology-garbage-items
[345.594251] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[345.713113] [109/156] (681s left) perf_pmu (busy-start)
[345.752699] Starting subtest: busy-start
[345.754524] Starting dynamic subtest: rcs0
[348.302674] Dynamic subtest rcs0: SUCCESS (2.550s)
[348.315600] Starting dynamic subtest: bcs0
[350.852964] Dynamic subtest bcs0: SUCCESS (2.547s)
[350.864409] Starting dynamic subtest: vcs0
[354.236837] Dynamic subtest vcs0: SUCCESS (3.380s)
[354.247871] Starting dynamic subtest: vcs1
[358.204910] Dynamic subtest vcs1: SUCCESS (3.965s)
[358.215813] Starting dynamic subtest: vecs0
[362.237625] Dynamic subtest vecs0: SUCCESS (4.029s)
[362.256758] Starting dynamic subtest: ccs0
[364.787250] Dynamic subtest ccs0: SUCCESS (2.548s)
[364.789689] Subtest busy-start: SUCCESS (19.036s)
[364.909142] [110/156] (661s left) prime_vgem (fence-flip-hang)
[364.984314] Subtest fence-flip-hang: SKIP (0.000s)
[365.086661] [111/156] (661s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[365.166093] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-mmap-cpu
[365.170619] Subtest fbchdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[365.243234] [112/156] (661s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[365.315537] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[365.319978] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[365.389449] [113/156] (661s left) kms_cursor_crc (cursor-sliding-64x64)
[365.527717] Starting subtest: cursor-sliding-64x64
[365.533040] Starting dynamic subtest: pipe-A-eDP-1
[368.770744] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.238s)
[368.800074] Starting dynamic subtest: pipe-D-eDP-1
[372.700364] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.909s)
[372.703274] Subtest cursor-sliding-64x64: SUCCESS (7.173s)
[373.580344] [114/156] (653s left) gem_ctx_bad_destroy (double-destroy)
[373.632028] Starting subtest: double-destroy
[373.634401] Subtest double-destroy: SUCCESS (0.000s)
[373.705456] [115/156] (653s left) kms_vrr (flip-suspend)
[373.784857] Starting subtest: flip-suspend
[373.790795] Subtest flip-suspend: SKIP (0.000s)
[373.856289] [116/156] (653s left) gem_exec_params (readonly)
[373.909904] Starting subtest: readonly
[373.914765] Subtest readonly: SUCCESS (0.003s)
[374.039704] [117/156] (653s left) gem_exec_schedule (preempt-self)
[374.104908] Starting subtest: preempt-self
[374.107293] Starting dynamic subtest: rcs0
[374.116065] Dynamic subtest rcs0: SUCCESS (0.020s)
[374.127949] Starting dynamic subtest: bcs0
[374.135170] Dynamic subtest bcs0: SUCCESS (0.018s)
[374.144542] Starting dynamic subtest: vcs0
[374.156280] Dynamic subtest vcs0: SUCCESS (0.020s)
[374.165655] Starting dynamic subtest: vcs1
[374.176985] Dynamic subtest vcs1: SUCCESS (0.020s)
[374.187205] Starting dynamic subtest: vecs0
[374.202693] Dynamic subtest vecs0: SUCCESS (0.025s)
[374.211961] Starting dynamic subtest: ccs0
[374.223137] Dynamic subtest ccs0: SUCCESS (0.020s)
[374.225503] Subtest preempt-self: SUCCESS (0.127s)
[375.314480] [118/156] (651s left) kms_chamelium_hpd (hdmi-hpd)
[375.680353] Subtest hdmi-hpd: SKIP (0.000s)
[376.484380] [119/156] (650s left) gem_exec_await (wide-contexts)
[376.687588] Starting subtest: wide-contexts
[400.108780] Subtest wide-contexts: SUCCESS (23.420s)
[400.314543] [120/156] (626s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[400.445245] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[407.132528] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.694s)
[407.272695] [121/156] (619s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[407.355414] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[407.359484] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[407.446516] [122/156] (619s left) sw_sync (sync_random_merge)
[407.488079] Starting subtest: sync_random_merge
[407.537596] Subtest sync_random_merge: SUCCESS (0.048s)
[407.599274] [123/156] (619s left) kms_content_protection (uevent-hdcp14)
[407.721310] Starting subtest: uevent-hdcp14
[407.725816] Subtest uevent-hdcp14: SKIP (0.000s)
[407.839979] [124/156] (619s left) gen9_exec_parse (bb-start-out)
[407.896868] Subtest bb-start-out: SKIP (0.000s)
[407.978551] [125/156] (619s left) gem_exec_balancer (parallel-balancer)
[408.242641] Starting subtest: parallel-balancer
[409.151404] Subtest parallel-balancer: SUCCESS (0.909s)
[409.275515] [126/156] (618s left) vgem_basic (dmabuf-fence-before)
[409.315423] Starting subtest: dmabuf-fence-before
[409.317325] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[409.388854] [127/156] (618s left) kms_force_connector_basic (prune-stale-modes)
[409.447495] Subtest prune-stale-modes: SKIP (0.000s)
[409.512487] [128/156] (617s left) kms_chamelium_audio (hdmi-audio-edid)
[409.881499] Subtest hdmi-audio-edid: SKIP (0.000s)
[410.752302] [129/156] (616s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[410.812503] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[410.817159] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[410.996891] [130/156] (616s left) gem_exec_fence (submit)
[411.159517] Starting subtest: submit
[411.164296] Subtest submit: SKIP (0.000s)
[413.321217] [131/156] (614s left) kms_flip (flip-vs-rmfb)
[413.398825] Starting subtest: flip-vs-rmfb
[413.401072] Starting dynamic subtest: A-eDP1
[422.070042] Dynamic subtest A-eDP1: SUCCESS (8.671s)
[422.080451] Starting dynamic subtest: B-eDP1
[430.700839] Dynamic subtest B-eDP1: SUCCESS (8.629s)
[430.713216] Starting dynamic subtest: C-eDP1
[439.320726] Dynamic subtest C-eDP1: SUCCESS (8.618s)
[439.332875] Starting dynamic subtest: D-eDP1
[447.948072] Dynamic subtest D-eDP1: SUCCESS (8.625s)
[447.952191] Subtest flip-vs-rmfb: SUCCESS (34.554s)
[449.130272] [132/156] (578s left) perf (global-sseu-config-invalid)
[449.245741] Starting subtest: global-sseu-config-invalid
[449.250788] Subtest global-sseu-config-invalid: SKIP (0.000s)
[449.288631] [133/156] (578s left) kms_async_flips (crc-atomic)
[449.371771] Starting subtest: crc-atomic
[449.760348] Starting dynamic subtest: pipe-A-eDP-1
[452.648312] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.888s)
[453.028806] Starting dynamic subtest: pipe-B-eDP-1
[455.977076] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.961s)
[456.357801] Starting dynamic subtest: pipe-C-eDP-1
[459.291264] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.944s)
[459.674924] Starting dynamic subtest: pipe-D-eDP-1
[462.529859] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.868s)
[462.532164] Subtest crc-atomic: SUCCESS (13.160s)
[463.696167] [134/156] (564s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[463.778388] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[467.376181] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.604s)
[468.582967] [135/156] (559s left) kms_dsc (dsc-with-formats)
[468.650122] Starting subtest: dsc-with-formats
[468.690327] Subtest dsc-with-formats: SKIP (0.001s)
[468.731597] [136/156] (559s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0-hflip)
[468.805148] Starting subtest: linear-max-hw-stride-32bpp-rotate-0-hflip
[468.809639] Subtest linear-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[468.914075] [137/156] (558s left) gem_mmap_gtt (fault-concurrent-x)
[468.972416] Subtest fault-concurrent-X: SKIP (0.000s)
[469.035508] [138/156] (558s left) gem_workarounds (reset-context)
[469.103175] Starting subtest: reset-context
[469.272618] Subtest reset-context: SUCCESS (0.170s)
[469.413449] [139/156] (558s left) kms_flip (basic-plain-flip)
[469.498347] Starting subtest: basic-plain-flip
[469.500200] Starting dynamic subtest: A-eDP1
[471.187874] Dynamic subtest A-eDP1: SUCCESS (1.688s)
[471.200385] Starting dynamic subtest: B-eDP1
[472.904648] Dynamic subtest B-eDP1: SUCCESS (1.715s)
[472.916300] Starting dynamic subtest: C-eDP1
[474.630938] Dynamic subtest C-eDP1: SUCCESS (1.722s)
[474.641419] Starting dynamic subtest: D-eDP1
[476.264624] Dynamic subtest D-eDP1: SUCCESS (1.635s)
[476.270640] Subtest basic-plain-flip: SUCCESS (6.772s)
[477.435850] [140/156] (550s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-render)
[477.518232] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-render
[477.522243] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[477.619720] [141/156] (550s left) kms_setmode (basic-clone-single-crtc)
[477.673344] Starting subtest: basic-clone-single-crtc
[477.680130] Subtest basic-clone-single-crtc: SKIP (0.000s)
[477.766423] [142/156] (550s left) kms_frontbuffer_tracking (fbc-suspend)
[477.848429] Starting subtest: fbc-suspend
[516.259655] Subtest fbc-suspend: SUCCESS (8.510s)
[517.455903] [143/156] (510s left) kms_pm_rpm (pm-caching)
[519.257847] Starting subtest: pm-caching
[519.262748] Subtest pm-caching: SKIP (0.000s)
[519.714768] [144/156] (508s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-blt)
[519.797172] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-blt
[519.801640] Subtest hdr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[519.920417] [145/156] (508s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[520.005189] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[520.009705] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[520.108535] [146/156] (508s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[520.191485] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[520.193739] Starting dynamic subtest: pipe-A-eDP-1
[520.216551] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[520.229917] Starting dynamic subtest: pipe-B-eDP-1
[520.251714] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[520.262484] Starting dynamic subtest: pipe-C-eDP-1
[520.284657] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[520.295088] Starting dynamic subtest: pipe-D-eDP-1
[520.316978] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[520.320965] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[522.466660] [147/156] (505s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[522.555852] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[522.560038] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.000s)
[522.657994] [148/156] (505s left) gem_exec_big (single)
[522.714108] Starting subtest: single
[523.611622] Subtest single: SUCCESS (0.893s)
[523.761997] [149/156] (504s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[523.878592] Starting subtest: yf-tiled-ccs-to-y-tiled
[523.882882] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[524.055332] [150/156] (504s left) gem_create (create-massive)
[524.111760] Starting subtest: create-massive
[524.113743] Subtest create-massive: SUCCESS (0.000s)
[524.294653] [151/156] (504s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[524.372904] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[528.403439] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (4.024s)
[529.576681] [152/156] (498s left) vgem_basic (bad-handle)
[529.620624] Starting subtest: bad-handle
[529.622669] Subtest bad-handle: SUCCESS (0.000s)
[529.678983] [153/156] (498s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[529.769563] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area
[529.773583] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[529.841762] [154/156] (498s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[529.934412] Starting subtest: 4-tiled-32bpp-rotate-180
[531.304890] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.368s)
[531.434287] [155/156] (497s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc)
[531.508220] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc
[531.511748] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[531.605359] [156/156] (497s left) dmabuf_sync_file (import-multiple-read-write)
[531.648602] Starting subtest: import-multiple-read-write
[531.656040] Subtest import-multiple-read-write: SUCCESS (0.010s)
[531.729170] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_pxp
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: i915_pm_rps
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: perf
results: parsing output: 8/ for test: gem_ctx_shared
results: parsing output: 9/ for test: prime_vgem
results: parsing output: 10/ for test: kms_psr2_sf
results: parsing output: 11/ for test: kms_addfb_basic
results: parsing output: 12/ for test: kms_plane
results: parsing output: 13/ for test: api_intel_allocator
results: parsing output: 14/ for test: gem_ctx_persistence
results: parsing output: 15/ for test: kms_atomic_interruptible
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: gem_softpin
results: parsing output: 18/ for test: kms_busy
results: parsing output: 19/ for test: kms_hdr
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_huc_copy
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: i915_drm_fdinfo
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: gem_mmap_gtt
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: kms_pm_dc
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_ccs
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_cursor_crc
results: parsing output: 35/ for test: kms_flip
results: parsing output: 36/ for test: gem_busy
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_plane_scaling
results: parsing output: 39/ for test: syncobj_timeline
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_flip
results: parsing output: 43/ for test: syncobj_basic
results: parsing output: 44/ for test: gem_userptr_blits
results: parsing output: 45/ for test: kms_lease
results: parsing output: 46/ for test: syncobj_timeline
results: parsing output: 47/ for test: kms_ccs
results: parsing output: 48/ for test: gem_flink_basic
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_dirtyfb
results: parsing output: 51/ for test: gem_userptr_blits
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_spin_batch
results: parsing output: 57/ for test: gem_exec_whisper
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_flip
results: parsing output: 60/ for test: gem_ctx_param
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_psr2_sf
results: parsing output: 63/ for test: kms_psr
results: parsing output: 64/ for test: gem_vm_create
results: parsing output: 65/ for test: kms_plane_alpha_blend
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_exec_reloc
results: parsing output: 68/ for test: kms_sequence
results: parsing output: 69/ for test: kms_scaling_modes
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: kms_cursor_crc
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_mmap_gtt
results: parsing output: 75/ for test: kms_chamelium_edid
results: parsing output: 76/ for test: api_intel_bb
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: syncobj_wait
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: testdisplay
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_plane_scaling
results: parsing output: 86/ for test: gem_exec_schedule
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_exec_params
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: gem_set_tiling_vs_blt
results: parsing output: 91/ for test: gem_ctx_persistence
results: parsing output: 92/ for test: gem_exec_params
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_flip_scaled_crc
results: parsing output: 97/ for test: gem_exec_reloc
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_color
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: kms_lease
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_pread
results: parsing output: 104/ for test: syncobj_basic
results: parsing output: 105/ for test: i915_drm_fdinfo
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: i915_query
results: parsing output: 108/ for test: perf_pmu
results: parsing output: 109/ for test: prime_vgem
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_plane
results: parsing output: 112/ for test: kms_cursor_crc
results: parsing output: 113/ for test: gem_ctx_bad_destroy
results: parsing output: 114/ for test: kms_vrr
results: parsing output: 115/ for test: gem_exec_params
results: parsing output: 116/ for test: gem_exec_schedule
results: parsing output: 117/ for test: kms_chamelium_hpd
results: parsing output: 118/ for test: gem_exec_await
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: sw_sync
results: parsing output: 122/ for test: kms_content_protection
results: parsing output: 123/ for test: gen9_exec_parse
results: parsing output: 124/ for test: gem_exec_balancer
results: parsing output: 125/ for test: vgem_basic
results: parsing output: 126/ for test: kms_force_connector_basic
results: parsing output: 127/ for test: kms_chamelium_audio
results: parsing output: 128/ for test: gem_render_copy
results: parsing output: 129/ for test: gem_exec_fence
results: parsing output: 130/ for test: kms_flip
results: parsing output: 131/ for test: perf
results: parsing output: 132/ for test: kms_async_flips
results: parsing output: 133/ for test: kms_frontbuffer_tracking
results: parsing output: 134/ for test: kms_dsc
results: parsing output: 135/ for test: kms_big_fb
results: parsing output: 136/ for test: gem_mmap_gtt
results: parsing output: 137/ for test: gem_workarounds
results: parsing output: 138/ for test: kms_flip
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: kms_setmode
results: parsing output: 141/ for test: kms_frontbuffer_tracking
results: parsing output: 142/ for test: kms_pm_rpm
results: parsing output: 143/ for test: kms_frontbuffer_tracking
results: parsing output: 144/ for test: kms_big_fb
results: parsing output: 145/ for test: kms_ccs
results: parsing output: 146/ for test: kms_flip_scaled_crc
results: parsing output: 147/ for test: gem_exec_big
results: parsing output: 148/ for test: gem_render_copy
results: parsing output: 149/ for test: gem_create
results: parsing output: 150/ for test: kms_frontbuffer_tracking
results: parsing output: 151/ for test: vgem_basic
results: parsing output: 152/ for test: kms_psr2_sf
results: parsing output: 153/ for test: kms_big_fb
results: parsing output: 154/ for test: kms_frontbuffer_tracking
results: parsing output: 155/ for test: dmabuf_sync_file
Done.