[58.254380] Initializing watchdogs
[58.254426]   /dev/watchdog0
[58.269781] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[58.273656] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.275803] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.279670] [001/156] (960s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[58.391984] Starting subtest: fbc-psr2-primary-mmap-cpu
[58.394562] Starting dynamic subtest: eDP-1
[58.398717] Dynamic subtest eDP-1: SKIP (0.000s)
[58.402831] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[58.462581] [002/156] (960s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[58.563119] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[65.419972] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.860s)
[65.539740] [003/156] (953s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[65.622860] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[72.449177] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.829s)
[72.746827] [004/156] (946s left) gem_pxp (hw-rejects-pxp-buffer)
[72.986282] Starting subtest: hw-rejects-pxp-buffer
[72.991309] Subtest hw-rejects-pxp-buffer: SKIP (0.000s)
[73.111137] [005/156] (945s left) syncobj_timeline (multi-wait-for-submit-signaled)
[73.184027] Starting subtest: multi-wait-for-submit-signaled
[73.186541] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[73.407570] [006/156] (945s left) i915_pm_rps (reset)
[73.467112] Starting subtest: reset
[81.869077] Subtest reset: SUCCESS (8.397s)
[81.968844] [007/156] (937s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-render)
[82.055989] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-render
[82.060602] Subtest hdr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[82.152198] [008/156] (936s left) perf (missing-sample-flags)
[82.284600] Starting subtest: missing-sample-flags
[82.286718] Subtest missing-sample-flags: SUCCESS (0.000s)
[82.325100] [009/156] (936s left) gem_ctx_shared (exec-single-timeline)
[82.378715] Starting subtest: exec-single-timeline
[82.381051] Starting dynamic subtest: rcs0
[83.419253] Dynamic subtest rcs0: SUCCESS (1.038s)
[83.429853] Starting dynamic subtest: bcs0
[84.507527] Dynamic subtest bcs0: SUCCESS (1.087s)
[84.520315] Starting dynamic subtest: vcs0
[85.596240] Dynamic subtest vcs0: SUCCESS (1.087s)
[85.606301] Starting dynamic subtest: vcs1
[86.684034] Dynamic subtest vcs1: SUCCESS (1.087s)
[86.695681] Starting dynamic subtest: vecs0
[87.773455] Dynamic subtest vecs0: SUCCESS (1.088s)
[87.782932] Starting dynamic subtest: ccs0
[88.861727] Dynamic subtest ccs0: SUCCESS (1.087s)
[88.864970] Subtest exec-single-timeline: SUCCESS (6.482s)
[89.059328] [010/156] (930s left) prime_vgem (sync)
[89.194549] Starting subtest: sync
[89.196976] Starting dynamic subtest: rcs0
[89.243527] Dynamic subtest rcs0: SUCCESS (0.049s)
[89.252237] Starting dynamic subtest: bcs0
[89.298679] Dynamic subtest bcs0: SUCCESS (0.055s)
[89.307357] Starting dynamic subtest: vcs0
[89.347708] Dynamic subtest vcs0: SUCCESS (0.048s)
[89.356455] Starting dynamic subtest: vcs1
[89.391466] Dynamic subtest vcs1: SUCCESS (0.043s)
[89.400283] Starting dynamic subtest: vecs0
[89.438674] Dynamic subtest vecs0: SUCCESS (0.047s)
[89.447225] Starting dynamic subtest: ccs0
[89.483576] Dynamic subtest ccs0: SUCCESS (0.045s)
[89.485708] Subtest sync: SUCCESS (0.289s)
[89.563940] [FACT prime_vgem (sync)] new: kernel.kmod_is_loaded.vgem: true
[89.567144] [011/156] (929s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[89.650278] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[89.654412] Starting dynamic subtest: pipe-A-eDP-1
[96.421951] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.776s)
[96.432116] Starting dynamic subtest: pipe-B-eDP-1
[103.343377] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.919s)
[103.345257] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.697s)
[104.206890] [012/156] (915s left) kms_addfb_basic (bad-pitch-65536)
[104.265911] Starting subtest: bad-pitch-65536
[104.267837] Subtest bad-pitch-65536: SUCCESS (0.000s)
[104.379504] [013/156] (914s left) kms_plane (pixel-format-4-tiled-modifier)
[104.456194] Starting subtest: pixel-format-4-tiled-modifier
[104.482054] Starting dynamic subtest: pipe-A-plane-0
[104.881653] Dynamic subtest pipe-A-plane-0: SUCCESS (0.400s)
[104.892169] Starting dynamic subtest: pipe-A-plane-3
[105.214977] Dynamic subtest pipe-A-plane-3: SUCCESS (0.333s)
[105.223183] Starting dynamic subtest: pipe-A-plane-5
[105.226798] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[106.295255] Starting dynamic subtest: pipe-B-plane-0
[106.687615] Dynamic subtest pipe-B-plane-0: SUCCESS (0.400s)
[106.695913] Starting dynamic subtest: pipe-B-plane-3
[107.010129] Dynamic subtest pipe-B-plane-3: SUCCESS (0.322s)
[107.019669] Starting dynamic subtest: pipe-B-plane-5
[107.023912] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[107.325284] Subtest pixel-format-4-tiled-modifier: SUCCESS (2.869s)
[108.182137] [014/156] (911s left) api_intel_allocator (two-level-inception)
[108.234246] Starting subtest: two-level-inception
[113.633025] Subtest two-level-inception: SUCCESS (5.399s)
[113.755487] [015/156] (905s left) gem_ctx_persistence (legacy-engines-mixed-process)
[113.813315] Starting subtest: legacy-engines-mixed-process
[113.815778] Starting dynamic subtest: render
[115.292439] Dynamic subtest render: SUCCESS (1.478s)
[115.303066] Starting dynamic subtest: bsd1
[117.261850] Dynamic subtest bsd1: SUCCESS (1.968s)
[117.272063] Starting dynamic subtest: bsd2
[119.248891] Dynamic subtest bsd2: SUCCESS (1.985s)
[119.260025] Starting dynamic subtest: blt
[121.219790] Dynamic subtest blt: SUCCESS (1.969s)
[121.229591] Starting dynamic subtest: vebox
[123.284881] Dynamic subtest vebox: SUCCESS (2.064s)
[123.287467] Subtest legacy-engines-mixed-process: SUCCESS (9.472s)
[123.364523] [016/156] (896s left) kms_atomic_interruptible (universal-setplane-cursor)
[123.445234] Starting subtest: universal-setplane-cursor
[123.447371] Starting dynamic subtest: pipe-A-eDP-1
[130.905894] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.459s)
[130.908437] Subtest universal-setplane-cursor: SUCCESS (7.460s)
[131.746987] [017/156] (887s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[131.832586] Starting subtest: fbc-modesetfrombusy
[135.602143] Subtest fbc-modesetfrombusy: SUCCESS (3.778s)
[136.780904] [018/156] (882s left) gem_softpin (evict-active)
[136.841551] Starting subtest: evict-active
[136.847356] Subtest evict-active: SUCCESS (0.006s)
[136.963232] [019/156] (882s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[137.046768] Starting subtest: extended-pageflip-modeset-hang-oldfb
[137.049028] Starting dynamic subtest: pipe-A
[144.965314] Dynamic subtest pipe-A: SUCCESS (7.918s)
[144.974691] Starting dynamic subtest: pipe-D
[153.579365] Dynamic subtest pipe-D: SUCCESS (8.610s)
[153.581600] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.533s)
[154.431498] [020/156] (865s left) kms_hdr (bpc-switch-dpms)
[154.507084] Starting subtest: bpc-switch-dpms
[154.509497] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[160.122510] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SUCCESS (5.615s)
[160.133920] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[165.685500] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SUCCESS (5.562s)
[165.687940] Subtest bpc-switch-dpms: SUCCESS (11.179s)
[165.798965] [021/156] (853s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[165.882734] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[165.886701] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[165.981565] [022/156] (853s left) gem_huc_copy (huc-copy)
[166.044534] Starting subtest: huc-copy
[166.049291] Subtest huc-copy: SUCCESS (0.003s)
[166.159389] [023/156] (853s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[166.236054] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[170.733868] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.505s)
[171.965964] [024/156] (847s left) i915_drm_fdinfo (virtual-idle)
[172.010701] Starting subtest: virtual-idle
[175.069976] Subtest virtual-idle: SUCCESS (3.051s)
[175.138554] [025/156] (844s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[175.208129] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[175.210423] Starting dynamic subtest: pipe-A-eDP-1
[175.230252] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[175.240199] Starting dynamic subtest: pipe-B-eDP-1
[175.260385] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[175.272077] Starting dynamic subtest: pipe-C-eDP-1
[175.291591] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[175.301603] Starting dynamic subtest: pipe-D-eDP-1
[175.321070] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[175.323314] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.007s)
[177.497134] [026/156] (842s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[177.582531] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[180.085305] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (2.508s)
[181.204427] [027/156] (838s left) syncobj_timeline (wait-all-for-submit-complex)
[181.263517] Starting subtest: wait-all-for-submit-complex
[181.476335] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[181.574272] [028/156] (838s left) gem_mmap_gtt (basic-short)
[181.623460] Subtest basic-short: SKIP (0.000s)
[181.685401] [029/156] (838s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[181.741187] Starting subtest: etime-multi-wait-all-available-unsubmitted
[181.842624] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.102s)
[181.916215] [030/156] (838s left) kms_pm_dc (dc5-dpms)
[183.000769] Starting subtest: dc5-dpms
[185.077591] Subtest dc5-dpms: SUCCESS (2.077s)
[185.168400] [031/156] (834s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-pgflip-blt)
[185.261314] Starting subtest: psrhdr-2p-scndscrn-shrfb-pgflip-blt
[185.265621] Subtest psrhdr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[185.365510] [032/156] (834s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[185.448584] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[185.453063] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[185.555842] [033/156] (834s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[185.625326] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[185.629672] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[186.753128] [034/156] (833s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[186.843652] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[186.848106] Subtest psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[186.933933] [035/156] (833s left) kms_cursor_crc (cursor-offscreen-512x170)
[187.209075] Starting subtest: cursor-offscreen-512x170
[187.213347] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[187.338381] [036/156] (832s left) kms_flip (plain-flip-fb-recreate-interruptible)
[187.417905] Starting subtest: plain-flip-fb-recreate-interruptible
[187.420327] Starting dynamic subtest: A-eDP1
[196.248240] Dynamic subtest A-eDP1: SUCCESS (8.829s)
[196.260589] Starting dynamic subtest: B-eDP1
[205.068116] Dynamic subtest B-eDP1: SUCCESS (8.818s)
[205.078995] Starting dynamic subtest: C-eDP1
[213.892056] Dynamic subtest C-eDP1: SUCCESS (8.822s)
[213.900935] Starting dynamic subtest: D-eDP1
[222.732102] Dynamic subtest D-eDP1: SUCCESS (8.838s)
[222.734077] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.315s)
[223.926936] [037/156] (796s left) gem_busy (parallel)
[224.131746] Starting subtest: parallel
[224.134158] Starting dynamic subtest: rcs0
[226.239857] Dynamic subtest rcs0: SUCCESS (2.110s)
[226.254033] Starting dynamic subtest: bcs0
[228.223235] Dynamic subtest bcs0: SUCCESS (1.980s)
[228.235247] Starting dynamic subtest: vcs0
[230.207494] Dynamic subtest vcs0: SUCCESS (1.981s)
[230.219551] Starting dynamic subtest: vcs1
[232.191262] Dynamic subtest vcs1: SUCCESS (1.981s)
[232.203886] Starting dynamic subtest: vecs0
[234.237976] Dynamic subtest vecs0: SUCCESS (2.045s)
[234.250075] Starting dynamic subtest: ccs0
[236.223382] Dynamic subtest ccs0: SUCCESS (1.982s)
[236.225997] Subtest parallel: SUCCESS (12.094s)
[236.474065] [038/156] (783s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[236.566612] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc
[236.570740] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[236.665512] [039/156] (783s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[236.749060] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[236.750975] Starting dynamic subtest: pipe-A
[237.085631] Dynamic subtest pipe-A: SUCCESS (0.339s)
[237.095523] Starting dynamic subtest: pipe-B
[238.515292] Dynamic subtest pipe-B: SUCCESS (1.429s)
[238.526016] Starting dynamic subtest: pipe-C
[239.948567] Dynamic subtest pipe-C: SUCCESS (1.432s)
[239.957506] Starting dynamic subtest: pipe-D
[241.385522] Dynamic subtest pipe-D: SUCCESS (1.435s)
[241.387955] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.640s)
[242.539964] [040/156] (777s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[242.597282] Starting subtest: multi-wait-all-available-submitted-signaled
[242.599640] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.001s)
[242.699579] [041/156] (777s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[242.780415] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-mmap-gtt
[242.784799] Subtest hdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[242.899034] [042/156] (777s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-pwrite)
[242.978229] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-pwrite
[242.982581] Subtest hdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[243.068583] [043/156] (777s left) kms_flip (2x-dpms-vs-vblank-race-interruptible)
[243.138796] Starting subtest: 2x-dpms-vs-vblank-race-interruptible
[243.148535] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.008s)
[243.237901] [044/156] (777s left) syncobj_basic (bad-flags-handle-to-fd)
[243.298967] Starting subtest: bad-flags-handle-to-fd
[243.301141] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[243.419288] [045/156] (777s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[243.481944] Starting subtest: map-fixed-invalidate-overlap-busy
[243.485595] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[243.588485] [046/156] (777s left) kms_lease (lease-unleased-crtc)
[243.653170] Starting subtest: lease-unleased-crtc
[243.655126] Starting dynamic subtest: pipe-A-eDP-1
[243.943377] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[243.954772] Starting dynamic subtest: pipe-B-eDP-1
[244.682708] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.737s)
[244.692741] Starting dynamic subtest: pipe-C-eDP-1
[244.694611] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[244.703616] Starting dynamic subtest: pipe-D-eDP-1
[244.705703] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[244.707811] Subtest lease-unleased-crtc: SUCCESS (1.039s)
[245.065580] [047/156] (775s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[245.111527] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[245.113860] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[245.207201] [048/156] (775s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[245.280652] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[245.282850] Starting dynamic subtest: pipe-A-eDP-1
[245.306097] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[245.316241] Starting dynamic subtest: pipe-B-eDP-1
[245.337522] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[245.346076] Starting dynamic subtest: pipe-C-eDP-1
[245.367965] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[245.376205] Starting dynamic subtest: pipe-D-eDP-1
[245.398210] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[245.402590] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[247.524788] [049/156] (773s left) gem_flink_basic (bad-open)
[247.580837] Starting subtest: bad-open
[247.582838] Subtest bad-open: SUCCESS (0.000s)
[247.698212] [050/156] (773s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[247.787231] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[247.791291] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[247.885932] [051/156] (772s left) kms_dirtyfb (drrs-dirtyfb-ioctl)
[247.965075] Starting subtest: drrs-dirtyfb-ioctl
[247.978234] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s)
[248.067443] [052/156] (772s left) gem_userptr_blits (create-destroy-unsync)
[248.127711] Subtest create-destroy-unsync: SKIP (0.000s)
[248.238631] [053/156] (772s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[248.321729] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc
[248.325860] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[248.433770] [054/156] (772s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-pwrite)
[248.513572] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-pwrite
[248.516876] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[248.601063] [055/156] (772s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[248.672966] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[248.676541] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[248.775894] [056/156] (772s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[248.845849] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[248.849366] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[248.924964] [057/156] (772s left) gem_spin_batch (legacy-resubmit)
[248.973702] Starting subtest: legacy-resubmit
[248.975616] Starting dynamic subtest: default
[248.979351] Dynamic subtest default: SUCCESS (0.005s)
[248.990491] Starting dynamic subtest: render
[248.992065] Dynamic subtest render: SUCCESS (0.001s)
[249.000455] Starting dynamic subtest: bsd
[249.002195] Dynamic subtest bsd: SUCCESS (0.003s)
[249.010131] Starting dynamic subtest: bsd1
[249.011851] Dynamic subtest bsd1: SUCCESS (0.002s)
[249.020094] Starting dynamic subtest: bsd2
[249.021956] Dynamic subtest bsd2: SUCCESS (0.001s)
[249.030613] Starting dynamic subtest: blt
[249.032355] Dynamic subtest blt: SUCCESS (0.002s)
[249.040387] Starting dynamic subtest: vebox
[249.042071] Dynamic subtest vebox: SUCCESS (0.002s)
[249.043792] Subtest legacy-resubmit: SUCCESS (0.021s)
[249.215827] [058/156] (771s left) gem_exec_whisper (basic-fds)
[249.270535] Starting subtest: basic-fds
[256.494243] Subtest basic-fds: SUCCESS (7.220s)
[256.676385] [059/156] (764s left) kms_frontbuffer_tracking (fbcpsrhdr-stridechange)
[256.758854] Starting subtest: fbcpsrhdr-stridechange
[256.763057] Subtest fbcpsrhdr-stridechange: SKIP (0.000s)
[256.858256] [060/156] (764s left) kms_flip (2x-modeset-vs-vblank-race)
[256.944631] Starting subtest: 2x-modeset-vs-vblank-race
[256.951643] Subtest 2x-modeset-vs-vblank-race: SKIP (0.008s)
[257.031444] [061/156] (764s left) gem_ctx_param (get-priority-new-ctx)
[257.083946] Starting subtest: get-priority-new-ctx
[257.086290] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[257.218163] [062/156] (764s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-fullscreen)
[257.302994] Starting subtest: hdr-2p-scndscrn-spr-indfb-fullscreen
[257.307449] Subtest hdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[257.402773] [063/156] (763s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[257.478069] Starting subtest: psr2-cursor-plane-move-continuous-sf
[257.480346] Starting dynamic subtest: pipe-A-eDP-1
[267.824566] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.351s)
[267.834708] Starting dynamic subtest: pipe-B-eDP-1
[278.867442] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.040s)
[278.869658] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (21.393s)
[279.677675] [064/156] (741s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[279.768139] Starting subtest: fbc-psr-sprite-mmap-gtt
[279.770501] Starting dynamic subtest: eDP-1
[279.774885] Dynamic subtest eDP-1: SKIP (0.000s)
[279.779275] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[279.852106] [065/156] (741s left) gem_vm_create (create-ext)
[279.908439] Starting subtest: create-ext
[279.913848] Subtest create-ext: SUCCESS (0.004s)
[280.026486] [066/156] (741s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[280.112755] Starting subtest: coverage-vs-premult-vs-constant
[280.397814] Starting dynamic subtest: pipe-A-eDP-1
[281.020480] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.619s)
[281.030740] Starting dynamic subtest: pipe-D-eDP-1
[282.386893] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.365s)
[282.390086] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.273s)
[283.244965] [067/156] (738s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[283.322064] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[283.326622] Subtest fbchdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[283.415443] [068/156] (738s left) gem_exec_reloc (basic-cpu-read-active)
[283.472060] Subtest basic-cpu-read-active: SKIP (0.000s)
[283.541279] [069/156] (738s left) kms_sequence (queue-idle)
[283.610354] Starting subtest: queue-idle
[283.612579] Starting dynamic subtest: pipe-A-eDP-1
[285.415066] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.805s)
[285.426454] Starting dynamic subtest: pipe-B-eDP-1
[287.927293] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.509s)
[287.938447] Starting dynamic subtest: pipe-C-eDP-1
[290.448019] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.518s)
[290.460214] Starting dynamic subtest: pipe-D-eDP-1
[292.886784] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.438s)
[292.889108] Subtest queue-idle: SUCCESS (9.275s)
[293.690910] [070/156] (727s left) kms_scaling_modes (scaling-mode-full-aspect)
[293.766932] Starting subtest: scaling-mode-full-aspect
[293.769136] Starting dynamic subtest: pipe-A-eDP-1
[293.858336] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.092s)
[293.869484] Starting dynamic subtest: pipe-B-eDP-1
[295.023696] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.164s)
[295.034916] Starting dynamic subtest: pipe-C-eDP-1
[296.151104] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.126s)
[296.161250] Starting dynamic subtest: pipe-D-eDP-1
[297.290815] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.137s)
[297.293148] Subtest scaling-mode-full-aspect: SUCCESS (3.526s)
[298.462473] [071/156] (723s left) kms_big_fb (linear-64bpp-rotate-270)
[298.552891] Starting subtest: linear-64bpp-rotate-270
[298.571495] Subtest linear-64bpp-rotate-270: SKIP (0.018s)
[298.686042] [072/156] (723s left) kms_cursor_crc (cursor-sliding-128x42)
[298.883872] Starting subtest: cursor-sliding-128x42
[298.930385] Subtest cursor-sliding-128x42: SKIP (0.041s)
[299.129659] [073/156] (722s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[299.209149] Starting subtest: 4-tiled-16bpp-rotate-180
[300.433975] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.224s)
[300.564957] [074/156] (721s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[300.644321] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[300.647924] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[300.738198] [075/156] (721s left) gem_mmap_gtt (flink-race)
[300.792030] Subtest flink-race: SKIP (0.000s)
[300.850379] [076/156] (721s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[301.217837] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[302.072017] [077/156] (719s left) api_intel_bb (simple-bb-ctx)
[302.124542] Starting subtest: simple-bb-ctx
[302.129919] Subtest simple-bb-ctx: SUCCESS (0.007s)
[302.257156] [078/156] (719s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[302.339611] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[302.343819] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[302.434079] [079/156] (719s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[302.523722] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[302.527858] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[302.611021] [080/156] (719s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[302.689864] Starting subtest: yf-tiled-16bpp-rotate-90
[302.695524] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[302.776879] [081/156] (719s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[302.857984] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[302.862079] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[302.957426] [082/156] (719s left) syncobj_wait (wait-for-submit-complex)
[303.008428] Starting subtest: wait-for-submit-complex
[303.071452] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[303.146605] [083/156] (719s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[303.223555] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[303.227318] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[303.325325] [084/156] (718s left) testdisplay
[303.588682] [085/156] (718s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-shrfb-fliptrack-mmap-gtt)
[303.669883] Starting subtest: fbcpsrhdr-1p-shrfb-fliptrack-mmap-gtt
[303.673587] Subtest fbcpsrhdr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[303.759118] [086/156] (718s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[303.831168] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[303.832962] Starting dynamic subtest: pipe-A
[303.894781] Dynamic subtest pipe-A: SUCCESS (0.064s)
[303.904676] Starting dynamic subtest: pipe-B
[305.006699] Dynamic subtest pipe-B: SUCCESS (1.110s)
[305.017788] Starting dynamic subtest: pipe-C
[306.125103] Dynamic subtest pipe-C: SUCCESS (1.117s)
[306.135704] Starting dynamic subtest: pipe-D
[307.255925] Dynamic subtest pipe-D: SUCCESS (1.130s)
[307.258322] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.426s)
[308.407466] [087/156] (713s left) gem_exec_schedule (preempt)
[308.478407] Starting subtest: preempt
[308.480815] Starting dynamic subtest: rcs0
[308.491655] Dynamic subtest rcs0: SUCCESS (0.023s)
[308.501825] Starting dynamic subtest: bcs0
[308.509173] Dynamic subtest bcs0: SUCCESS (0.017s)
[308.518307] Starting dynamic subtest: vcs0
[308.528506] Dynamic subtest vcs0: SUCCESS (0.019s)
[308.537928] Starting dynamic subtest: vcs1
[308.549670] Dynamic subtest vcs1: SUCCESS (0.020s)
[308.559210] Starting dynamic subtest: vecs0
[308.573695] Dynamic subtest vecs0: SUCCESS (0.023s)
[308.583595] Starting dynamic subtest: ccs0
[308.595270] Dynamic subtest ccs0: SUCCESS (0.021s)
[308.597548] Subtest preempt: SUCCESS (0.127s)
[310.294747] [088/156] (712s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-mmap-cpu)
[310.375810] Starting subtest: fbchdr-rgb565-draw-mmap-cpu
[310.379963] Subtest fbchdr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[310.492553] [089/156] (711s left) gem_exec_params (invalid-bsd-ring)
[310.555579] Starting subtest: invalid-bsd-ring
[310.557936] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[310.666834] [090/156] (711s left) kms_psr (psr-primary-blt)
[310.739234] Starting subtest: psr-primary-blt
[310.741439] Starting dynamic subtest: eDP-1
[312.500599] Dynamic subtest eDP-1: SUCCESS (1.761s)
[312.502979] Subtest psr-primary-blt: SUCCESS (1.762s)
[313.371062] [091/156] (709s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[313.425094] Subtest untiled-to-tiled: SKIP (0.000s)
[313.485650] [092/156] (709s left) gem_ctx_persistence (file)
[313.540205] Starting subtest: file
[313.640207] Subtest file: SUCCESS (0.100s)
[313.757578] [093/156] (708s left) gem_exec_params (sol-reset-invalid)
[313.807253] Starting subtest: sol-reset-invalid
[313.813307] Subtest sol-reset-invalid: SUCCESS (0.003s)
[315.262980] [094/156] (707s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[315.339693] Starting subtest: y-tiled-16bpp-rotate-0
[315.344771] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[315.445047] [095/156] (707s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[315.532394] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[315.536666] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[315.634733] [096/156] (707s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[315.726820] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc
[322.294505] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.572s)
[322.431974] [097/156] (700s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[322.517629] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[322.522022] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s)
[322.592575] [098/156] (700s left) gem_exec_reloc (basic-cpu-gtt)
[322.652509] Subtest basic-cpu-gtt: SKIP (0.000s)
[322.737438] [099/156] (700s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[322.821359] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[329.557776] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.743s)
[329.693902] [100/156] (693s left) kms_color (ctm-red-to-blue)
[329.764717] Starting subtest: ctm-red-to-blue
[329.767100] Starting dynamic subtest: pipe-A-eDP-1
[330.475094] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.712s)
[330.484864] Starting dynamic subtest: pipe-B-eDP-1
[331.885965] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.408s)
[331.895852] Starting dynamic subtest: pipe-C-eDP-1
[333.260948] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.376s)
[333.271547] Starting dynamic subtest: pipe-D-eDP-1
[334.672623] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.411s)
[334.675071] Subtest ctm-red-to-blue: SUCCESS (4.911s)
[335.475642] [101/156] (687s left) kms_psr (psr2-dpms)
[335.547371] Starting subtest: psr2-dpms
[335.549757] Starting dynamic subtest: eDP-1
[338.403573] Dynamic subtest eDP-1: SUCCESS (2.856s)
[338.405896] Subtest psr2-dpms: SUCCESS (2.857s)
[339.261682] [102/156] (683s left) kms_lease (atomic-implicit-crtc)
[339.340427] Starting subtest: atomic-implicit-crtc
[339.342598] Starting dynamic subtest: pipe-A-eDP-1
[339.354033] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[339.365104] Starting dynamic subtest: pipe-B-eDP-1
[339.376225] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[339.385597] Starting dynamic subtest: pipe-C-eDP-1
[339.396236] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s)
[339.406271] Starting dynamic subtest: pipe-D-eDP-1
[339.416765] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[339.418948] Subtest atomic-implicit-crtc: SUCCESS (0.034s)
[339.481871] [103/156] (683s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-shrfb-fliptrack-mmap-gtt)
[339.560707] Starting subtest: fbcpsrhdr-2p-shrfb-fliptrack-mmap-gtt
[339.565191] Subtest fbcpsrhdr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[339.657325] [104/156] (683s left) gem_pread (display)
[339.726084] Subtest display: SKIP (0.000s)
[339.786112] [105/156] (683s left) syncobj_basic (bad-handle-to-fd)
[339.832553] Starting subtest: bad-handle-to-fd
[339.834527] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[339.916487] [106/156] (683s left) i915_drm_fdinfo (memory-info-idle)
[339.949707] Starting subtest: memory-info-idle
[339.952137] Starting dynamic subtest: smem0
[339.988243] Dynamic subtest smem0: SUCCESS (0.038s)
[339.990881] Subtest memory-info-idle: SUCCESS (0.039s)
[340.064476] [107/156] (683s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[340.136174] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[340.140096] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[340.246029] [108/156] (682s left) i915_query (query-topology-garbage-items)
[340.289758] Starting subtest: query-topology-garbage-items
[340.291405] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[340.373707] [109/156] (682s left) perf_pmu (busy-start)
[340.407978] Starting subtest: busy-start
[340.409861] Starting dynamic subtest: rcs0
[342.956739] Dynamic subtest rcs0: SUCCESS (2.549s)
[342.969967] Starting dynamic subtest: bcs0
[345.506204] Dynamic subtest bcs0: SUCCESS (2.547s)
[345.519052] Starting dynamic subtest: vcs0
[349.246716] Dynamic subtest vcs0: SUCCESS (3.737s)
[349.258991] Starting dynamic subtest: vcs1
[353.214637] Dynamic subtest vcs1: SUCCESS (3.965s)
[353.228040] Starting dynamic subtest: vecs0
[357.246040] Dynamic subtest vecs0: SUCCESS (4.028s)
[357.259212] Starting dynamic subtest: ccs0
[359.793906] Dynamic subtest ccs0: SUCCESS (2.546s)
[359.797045] Subtest busy-start: SUCCESS (19.387s)
[359.891767] [110/156] (663s left) prime_vgem (fence-flip-hang)
[359.957081] Subtest fence-flip-hang: SKIP (0.000s)
[360.066826] [111/156] (663s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[360.144990] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-mmap-cpu
[360.149297] Subtest fbchdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[360.248768] [112/156] (663s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[360.323628] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[360.328117] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[360.420449] [113/156] (662s left) kms_cursor_crc (cursor-sliding-64x64)
[360.578859] Starting subtest: cursor-sliding-64x64
[360.584125] Starting dynamic subtest: pipe-A-eDP-1
[363.790095] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.207s)
[363.819875] Starting dynamic subtest: pipe-D-eDP-1
[367.665845] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.853s)
[367.668300] Subtest cursor-sliding-64x64: SUCCESS (7.086s)
[368.542301] [114/156] (654s left) gem_ctx_bad_destroy (double-destroy)
[368.600331] Starting subtest: double-destroy
[368.602628] Subtest double-destroy: SUCCESS (0.000s)
[368.674205] [115/156] (654s left) kms_vrr (flip-suspend)
[368.746255] Starting subtest: flip-suspend
[368.752640] Subtest flip-suspend: SKIP (0.000s)
[368.817190] [116/156] (654s left) gem_exec_params (readonly)
[368.875269] Starting subtest: readonly
[368.877586] Subtest readonly: SUCCESS (0.002s)
[369.010270] [117/156] (654s left) gem_exec_schedule (preempt-self)
[369.087702] Starting subtest: preempt-self
[369.090087] Starting dynamic subtest: rcs0
[369.096842] Dynamic subtest rcs0: SUCCESS (0.018s)
[369.107555] Starting dynamic subtest: bcs0
[369.118696] Dynamic subtest bcs0: SUCCESS (0.021s)
[369.129614] Starting dynamic subtest: vcs0
[369.141134] Dynamic subtest vcs0: SUCCESS (0.021s)
[369.151541] Starting dynamic subtest: vcs1
[369.160357] Dynamic subtest vcs1: SUCCESS (0.019s)
[369.169684] Starting dynamic subtest: vecs0
[369.181938] Dynamic subtest vecs0: SUCCESS (0.021s)
[369.191606] Starting dynamic subtest: ccs0
[369.204289] Dynamic subtest ccs0: SUCCESS (0.022s)
[369.206592] Subtest preempt-self: SUCCESS (0.127s)
[370.324255] [118/156] (653s left) kms_chamelium_hpd (hdmi-hpd)
[370.683095] Subtest hdmi-hpd: SKIP (0.000s)
[371.554737] [119/156] (652s left) gem_exec_await (wide-contexts)
[371.760990] Starting subtest: wide-contexts
[395.116271] Subtest wide-contexts: SUCCESS (23.352s)
[395.304526] [120/156] (628s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[395.423184] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[402.181583] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.765s)
[402.306090] [121/156] (621s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[402.385442] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[402.389808] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[402.482403] [122/156] (621s left) sw_sync (sync_random_merge)
[402.523510] Starting subtest: sync_random_merge
[402.566748] Subtest sync_random_merge: SUCCESS (0.043s)
[402.644540] [123/156] (621s left) kms_content_protection (uevent-hdcp14)
[402.769037] Starting subtest: uevent-hdcp14
[402.773364] Subtest uevent-hdcp14: SKIP (0.000s)
[402.894265] [124/156] (620s left) gen9_exec_parse (bb-start-out)
[402.955858] Subtest bb-start-out: SKIP (0.000s)
[403.024578] [125/156] (620s left) gem_exec_balancer (parallel-balancer)
[403.283334] Starting subtest: parallel-balancer
[404.166273] Subtest parallel-balancer: SUCCESS (0.883s)
[404.280585] [126/156] (619s left) vgem_basic (dmabuf-fence-before)
[404.319988] Starting subtest: dmabuf-fence-before
[404.322249] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[404.376837] [127/156] (619s left) kms_force_connector_basic (prune-stale-modes)
[404.432807] Subtest prune-stale-modes: SKIP (0.000s)
[404.490977] [128/156] (619s left) kms_chamelium_audio (hdmi-audio-edid)
[404.861835] Subtest hdmi-audio-edid: SKIP (0.000s)
[405.726594] [129/156] (618s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[405.777941] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[405.782544] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[405.975602] [130/156] (618s left) gem_exec_fence (submit)
[406.158587] Starting subtest: submit
[406.163082] Subtest submit: SKIP (0.000s)
[408.379023] [131/156] (615s left) kms_flip (flip-vs-rmfb)
[408.465724] Starting subtest: flip-vs-rmfb
[408.468241] Starting dynamic subtest: A-eDP1
[417.134179] Dynamic subtest A-eDP1: SUCCESS (8.669s)
[417.145792] Starting dynamic subtest: B-eDP1
[425.768844] Dynamic subtest B-eDP1: SUCCESS (8.633s)
[425.781400] Starting dynamic subtest: C-eDP1
[434.496228] Dynamic subtest C-eDP1: SUCCESS (8.726s)
[434.508045] Starting dynamic subtest: D-eDP1
[443.135496] Dynamic subtest D-eDP1: SUCCESS (8.637s)
[443.139830] Subtest flip-vs-rmfb: SUCCESS (34.674s)
[444.325186] [132/156] (579s left) perf (global-sseu-config-invalid)
[444.430720] Starting subtest: global-sseu-config-invalid
[444.435357] Subtest global-sseu-config-invalid: SKIP (0.000s)
[444.482663] [133/156] (579s left) kms_async_flips (crc-atomic)
[444.559428] Starting subtest: crc-atomic
[444.943890] Starting dynamic subtest: pipe-A-eDP-1
[447.852519] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.906s)
[448.248644] Starting dynamic subtest: pipe-B-eDP-1
[451.162658] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.924s)
[451.555460] Starting dynamic subtest: pipe-C-eDP-1
[454.486332] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.942s)
[454.851166] Starting dynamic subtest: pipe-D-eDP-1
[457.720726] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.882s)
[457.723072] Subtest crc-atomic: SUCCESS (13.162s)
[458.875609] [134/156] (565s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[458.957365] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[462.549834] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.600s)
[463.775912] [135/156] (560s left) kms_dsc (dsc-with-formats)
[463.850286] Starting subtest: dsc-with-formats
[463.891587] Subtest dsc-with-formats: SKIP (0.001s)
[463.934774] [136/156] (560s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0-hflip)
[464.020556] Starting subtest: linear-max-hw-stride-32bpp-rotate-0-hflip
[464.024691] Subtest linear-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[464.127482] [137/156] (560s left) gem_mmap_gtt (fault-concurrent-x)
[464.193099] Subtest fault-concurrent-X: SKIP (0.000s)
[464.249288] [138/156] (560s left) gem_workarounds (reset-context)
[464.309465] Starting subtest: reset-context
[464.479723] Subtest reset-context: SUCCESS (0.170s)
[464.597907] [139/156] (559s left) kms_flip (basic-plain-flip)
[464.669466] Starting subtest: basic-plain-flip
[464.671863] Starting dynamic subtest: A-eDP1
[466.362325] Dynamic subtest A-eDP1: SUCCESS (1.694s)
[466.375034] Starting dynamic subtest: B-eDP1
[467.994435] Dynamic subtest B-eDP1: SUCCESS (1.630s)
[468.010282] Starting dynamic subtest: C-eDP1
[469.711937] Dynamic subtest C-eDP1: SUCCESS (1.716s)
[469.733876] Starting dynamic subtest: D-eDP1
[471.350067] Dynamic subtest D-eDP1: SUCCESS (1.635s)
[471.355092] Subtest basic-plain-flip: SUCCESS (6.686s)
[472.530542] [140/156] (552s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-render)
[472.611534] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-render
[472.615837] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[472.696592] [141/156] (551s left) kms_setmode (basic-clone-single-crtc)
[472.746927] Starting subtest: basic-clone-single-crtc
[472.753181] Subtest basic-clone-single-crtc: SKIP (0.000s)
[472.865315] [142/156] (551s left) kms_frontbuffer_tracking (fbc-suspend)
[472.952043] Starting subtest: fbc-suspend
[510.666963] Subtest fbc-suspend: SUCCESS (8.397s)
[511.896552] [143/156] (512s left) kms_pm_rpm (pm-caching)
[513.628895] Starting subtest: pm-caching
[513.634035] Subtest pm-caching: SKIP (0.000s)
[514.174986] [144/156] (510s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-blt)
[514.261011] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-blt
[514.265509] Subtest hdr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[514.364268] [145/156] (510s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[514.445595] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[514.450115] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[514.551395] [146/156] (510s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[514.625075] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[514.627461] Starting dynamic subtest: pipe-A-eDP-1
[514.650910] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[514.663420] Starting dynamic subtest: pipe-B-eDP-1
[514.685951] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[514.698739] Starting dynamic subtest: pipe-C-eDP-1
[514.720633] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[514.733304] Starting dynamic subtest: pipe-D-eDP-1
[514.755987] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[514.760645] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[516.954832] [147/156] (507s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[517.022743] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[517.026731] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.000s)
[517.096230] [148/156] (507s left) gem_exec_big (single)
[517.151564] Starting subtest: single
[518.019723] Subtest single: SUCCESS (0.859s)
[518.165700] [149/156] (506s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[518.287792] Starting subtest: yf-tiled-ccs-to-y-tiled
[518.291844] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[518.486618] [150/156] (506s left) gem_create (create-massive)
[518.543636] Starting subtest: create-massive
[518.545614] Subtest create-massive: SUCCESS (0.000s)
[518.731211] [151/156] (506s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[518.821029] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[522.839597] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (3.993s)
[524.036807] [152/156] (501s left) vgem_basic (bad-handle)
[524.077533] Starting subtest: bad-handle
[524.079380] Subtest bad-handle: SUCCESS (0.000s)
[524.133304] [153/156] (500s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[524.224935] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area
[524.229425] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[524.295158] [154/156] (500s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[524.386898] Starting subtest: 4-tiled-32bpp-rotate-180
[525.726238] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.333s)
[525.906567] [155/156] (499s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc)
[525.982705] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc
[525.986225] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[526.092296] [156/156] (499s left) dmabuf_sync_file (import-multiple-read-write)
[526.142856] Starting subtest: import-multiple-read-write
[526.150595] Subtest import-multiple-read-write: SUCCESS (0.010s)
[526.208554] 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.