[58.586821] Initializing watchdogs
[58.586869]   /dev/watchdog0
[58.601812] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.606197] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.608463] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.612171] [001/131] (960s left) gem_exec_schedule (submit-early-slice)
[58.710917] Starting subtest: submit-early-slice
[58.712976] Starting dynamic subtest: rcs0
[58.772264] Dynamic subtest rcs0: SUCCESS (0.062s)
[58.782548] Starting dynamic subtest: bcs0
[58.831450] Dynamic subtest bcs0: SUCCESS (0.059s)
[58.839251] Starting dynamic subtest: vcs0
[58.881089] Dynamic subtest vcs0: SUCCESS (0.049s)
[58.889437] Starting dynamic subtest: vcs1
[58.937811] Dynamic subtest vcs1: SUCCESS (0.056s)
[58.949672] Starting dynamic subtest: vecs0
[58.989146] Dynamic subtest vecs0: SUCCESS (0.050s)
[59.002316] Starting dynamic subtest: ccs0
[59.042866] Dynamic subtest ccs0: SUCCESS (0.053s)
[59.045150] Subtest submit-early-slice: SUCCESS (0.332s)
[60.052990] [002/131] (959s left) kms_psr (fbc-pr-primary-page-flip)
[60.164067] Starting subtest: fbc-pr-primary-page-flip
[60.168591] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[60.252892] [003/131] (958s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[60.350168] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[60.352600] Starting dynamic subtest: A-eDP1
[63.947915] Dynamic subtest A-eDP1: SUCCESS (3.584s)
[63.957137] Starting dynamic subtest: B-eDP1
[67.162870] Dynamic subtest B-eDP1: SUCCESS (3.208s)
[67.174746] Starting dynamic subtest: C-eDP1
[70.274694] Dynamic subtest C-eDP1: SUCCESS (3.102s)
[70.282357] Starting dynamic subtest: D-eDP1
[73.459285] Dynamic subtest D-eDP1: SUCCESS (3.183s)
[73.461625] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.085s)
[74.276424] [004/131] (944s left) kms_content_protection (lic-type-0)
[74.455891] Starting subtest: lic-type-0
[74.460456] Subtest lic-type-0: SKIP (0.000s)
[74.608292] [005/131] (944s left) kms_lease (lessee-list)
[74.702663] Starting subtest: lessee-list
[74.704925] Starting dynamic subtest: pipe-A-eDP-1
[74.707173] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[74.715776] Starting dynamic subtest: pipe-B-eDP-1
[74.717952] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[74.725151] Starting dynamic subtest: pipe-C-eDP-1
[74.727232] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[74.734235] Starting dynamic subtest: pipe-D-eDP-1
[74.736303] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[74.738444] Subtest lessee-list: SUCCESS (0.007s)
[74.842700] [006/131] (944s left) kms_psr (pr-sprite-plane-onoff)
[74.944814] Starting subtest: pr-sprite-plane-onoff
[74.949409] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[75.039212] [007/131] (944s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[75.125569] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[75.127762] Starting dynamic subtest: pipe-A
[75.148929] Dynamic subtest pipe-A: SKIP (0.019s)
[75.157487] Starting dynamic subtest: pipe-B
[75.182088] Dynamic subtest pipe-B: SKIP (0.033s)
[75.189020] Starting dynamic subtest: pipe-C
[75.215560] Dynamic subtest pipe-C: SKIP (0.034s)
[75.222168] Starting dynamic subtest: pipe-D
[75.246164] Dynamic subtest pipe-D: SKIP (0.031s)
[75.249156] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.119s)
[75.359469] [008/131] (944s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[75.409919] Starting subtest: invalid-single-wait-all-unsubmitted
[75.411778] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[75.527169] [009/131] (943s left) kms_psr (psr-cursor-blt)
[75.612059] Starting subtest: psr-cursor-blt
[75.613885] Starting dynamic subtest: eDP-1
[77.352882] Dynamic subtest eDP-1: SUCCESS (1.738s)
[77.355193] Subtest psr-cursor-blt: SUCCESS (1.739s)
[78.249768] [010/131] (941s left) i915_pm_rpm (debugfs-forcewake-user)
[80.069056] Starting subtest: debugfs-forcewake-user
[91.452888] Subtest debugfs-forcewake-user: SUCCESS (11.383s)
[91.840557] [011/131] (927s left) gem_caching (reads)
[91.914302] Subtest reads: SKIP (0.000s)
[91.988678] [012/131] (927s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[92.087849] Starting subtest: fbc-rgb565-draw-mmap-gtt
[92.091543] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[92.208687] [013/131] (927s left) gem_ctx_engines (independent)
[92.265183] Starting subtest: independent
[92.267223] Starting dynamic subtest: rcs0
[92.390758] Dynamic subtest rcs0: SUCCESS (0.123s)
[92.402291] Starting dynamic subtest: bcs0
[92.505263] Dynamic subtest bcs0: SUCCESS (0.114s)
[92.515636] Starting dynamic subtest: vcs0
[92.613351] Dynamic subtest vcs0: SUCCESS (0.109s)
[92.622286] Starting dynamic subtest: vcs1
[92.729260] Dynamic subtest vcs1: SUCCESS (0.114s)
[92.736655] Starting dynamic subtest: vecs0
[92.842288] Dynamic subtest vecs0: SUCCESS (0.113s)
[92.850215] Starting dynamic subtest: ccs0
[92.964317] Dynamic subtest ccs0: SUCCESS (0.122s)
[92.972744] Starting dynamic subtest: all-engines
[93.440966] Dynamic subtest all-engines: SUCCESS (0.476s)
[93.442897] Subtest independent: SUCCESS (1.174s)
[93.998789] [014/131] (925s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[94.110566] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[94.112744] Starting dynamic subtest: pipe-A-eDP-1
[94.134924] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[94.144758] Starting dynamic subtest: pipe-B-eDP-1
[94.166787] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[94.175604] Starting dynamic subtest: pipe-C-eDP-1
[94.196612] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[94.204747] Starting dynamic subtest: pipe-D-eDP-1
[94.227036] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[94.231155] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[96.613184] [015/131] (923s left) syncobj_wait (wait-all-delayed-signal)
[96.686019] Starting subtest: wait-all-delayed-signal
[96.789439] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[96.885018] [016/131] (922s left) kms_feature_discovery (psr1)
[96.989438] Starting subtest: psr1
[96.991682] Subtest psr1: SUCCESS (0.000s)
[97.086538] [017/131] (922s left) kms_cursor_crc (cursor-onscreen-256x256)
[97.316546] Starting subtest: cursor-onscreen-256x256
[97.318683] Starting dynamic subtest: pipe-A-eDP-1
[99.416871] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.096s)
[99.445074] Starting dynamic subtest: pipe-D-eDP-1
[102.180722] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.741s)
[102.182744] Subtest cursor-onscreen-256x256: SUCCESS (4.863s)
[103.076544] [018/131] (916s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[103.477379] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[104.258967] [019/131] (915s left) i915_drm_fdinfo (virtual-busy-idle-all)
[104.313864] Starting subtest: virtual-busy-idle-all
[104.318618] Subtest virtual-busy-idle-all: SKIP (0.000s)
[104.400636] [020/131] (915s left) prime_self_import (basic-with_fd_dup)
[104.441172] Starting subtest: basic-with_fd_dup
[104.468189] Subtest basic-with_fd_dup: SUCCESS (0.027s)
[104.589647] [021/131] (915s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[104.685567] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[111.718069] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.034s)
[111.894612] [022/131] (908s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[112.005841] Starting subtest: fbc-rgb101010-draw-mmap-wc
[116.604283] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.602s)
[117.733729] [023/131] (902s left) kms_pm_backlight (fade-with-suspend)
[117.830592] Starting subtest: fade-with-suspend
[134.532559] Starting dynamic subtest: eDP-1
[137.208754] Dynamic subtest eDP-1: SUCCESS (2.678s)
[137.211225] Subtest fade-with-suspend: SUCCESS (8.124s)
[147.083797] [024/131] (881s left) kms_flip (2x-dpms-vs-vblank-race-interruptible)
[147.191807] Starting subtest: 2x-dpms-vs-vblank-race-interruptible
[147.205154] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.011s)
[147.302638] [025/131] (881s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[147.429491] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[164.665672] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.063s)
[165.492350] [026/131] (863s left) gem_ctx_persistence (engines-queued)
[165.567273] Starting subtest: engines-queued
[165.569681] Starting dynamic subtest: rcs0
[165.682002] Dynamic subtest rcs0: SUCCESS (0.114s)
[165.693519] Starting dynamic subtest: bcs0
[165.755487] Dynamic subtest bcs0: SUCCESS (0.072s)
[165.766405] Starting dynamic subtest: vcs0
[167.142655] Dynamic subtest vcs0: SUCCESS (1.380s)
[167.171045] Starting dynamic subtest: vcs1
[169.127417] Dynamic subtest vcs1: SUCCESS (1.980s)
[169.138691] Starting dynamic subtest: vecs0
[171.111063] Dynamic subtest vecs0: SUCCESS (1.979s)
[171.122705] Starting dynamic subtest: ccs0
[171.290825] Dynamic subtest ccs0: SUCCESS (0.179s)
[171.293329] Subtest engines-queued: SUCCESS (5.715s)
[171.462022] [027/131] (857s left) gem_exec_balancer (bonded-pair)
[171.532759] Starting subtest: bonded-pair
[171.537191] Subtest bonded-pair: SKIP (0.000s)
[171.880958] [028/131] (857s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[172.143952] Starting subtest: parallel-dmabuf-import-out-fence
[173.415301] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.270s)
[173.571825] [029/131] (855s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[173.621090] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[173.726052] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.104s)
[173.827932] [030/131] (855s left) gem_exec_fence (parallel)
[174.011099] Starting subtest: parallel
[174.014067] Starting dynamic subtest: rcs0
[176.163165] Dynamic subtest rcs0: SUCCESS (2.150s)
[176.173854] Starting dynamic subtest: bcs0
[178.318752] Dynamic subtest bcs0: SUCCESS (2.153s)
[178.328720] Starting dynamic subtest: vcs0
[180.470600] Dynamic subtest vcs0: SUCCESS (2.150s)
[180.480937] Starting dynamic subtest: vcs1
[182.623894] Dynamic subtest vcs1: SUCCESS (2.151s)
[182.634190] Starting dynamic subtest: vecs0
[184.777186] Dynamic subtest vecs0: SUCCESS (2.151s)
[184.787530] Starting dynamic subtest: ccs0
[186.929903] Dynamic subtest ccs0: SUCCESS (2.150s)
[186.931972] Subtest parallel: SUCCESS (12.909s)
[189.283390] [FACT gem_exec_fence (parallel)] new: kernel.kmod_is_loaded.vgem: true
[189.286803] [031/131] (840s left) kms_atomic (plane-invalid-params)
[189.390976] Starting subtest: plane-invalid-params
[189.393306] Starting dynamic subtest: pipe-A-eDP-1
[189.781695] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.390s)
[189.784068] Subtest plane-invalid-params: SUCCESS (0.391s)
[190.640050] [032/131] (838s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[190.750136] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[190.754101] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[190.873030] [033/131] (838s left) gem_pxp (verify-pxp-stale-buf-execution)
[190.986763] Starting subtest: verify-pxp-stale-buf-execution
[192.047705] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.062s)
[192.224311] [034/131] (837s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[192.323342] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs
[192.325653] Starting dynamic subtest: pipe-A-eDP-1
[192.348728] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[192.360867] Starting dynamic subtest: pipe-B-eDP-1
[192.382172] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[192.390941] Starting dynamic subtest: pipe-C-eDP-1
[192.414026] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[192.428405] Starting dynamic subtest: pipe-D-eDP-1
[192.450343] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[192.454773] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[194.511474] [035/131] (834s left) gem_pwrite (basic-self)
[194.577529] Subtest basic-self: SKIP (0.000s)
[194.648385] [036/131] (834s left) kms_psr (fbc-psr-suspend)
[194.744560] Starting subtest: fbc-psr-suspend
[194.746817] Starting dynamic subtest: eDP-1
[194.750966] Dynamic subtest eDP-1: SKIP (0.000s)
[194.755105] Subtest fbc-psr-suspend: SKIP (0.001s)
[194.843703] [037/131] (834s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[194.945749] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[198.648642] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.704s)
[199.831249] [038/131] (829s left) gen9_exec_parse (allowed-single)
[199.896041] Subtest allowed-single: SKIP (0.000s)
[199.994217] [039/131] (829s left) perf_pmu (faulting-read)
[200.030289] Starting subtest: faulting-read
[200.032580] Starting dynamic subtest: wb
[200.034774] Dynamic subtest wb: SUCCESS (0.001s)
[200.045047] Starting dynamic subtest: wc
[200.047115] Dynamic subtest wc: SUCCESS (0.000s)
[200.056232] Starting dynamic subtest: uc
[200.058342] Dynamic subtest uc: SUCCESS (0.000s)
[200.060454] Subtest faulting-read: SUCCESS (0.003s)
[200.170816] [040/131] (829s left) gem_gpgpu_fill (offset-16x16)
[200.232178] Starting subtest: offset-16x16
[200.237962] Subtest offset-16x16: SUCCESS (0.008s)
[200.417349] [041/131] (829s left) kms_universal_plane (universal-plane-pageflip-windowed)
[200.519244] Starting subtest: universal-plane-pageflip-windowed
[200.521419] Starting dynamic subtest: pipe-A-eDP-1
[201.114407] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.593s)
[201.127422] Starting dynamic subtest: pipe-B-eDP-1
[202.324384] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.208s)
[202.335277] Starting dynamic subtest: pipe-C-eDP-1
[203.536498] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.208s)
[203.547236] Starting dynamic subtest: pipe-D-eDP-1
[204.767400] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.230s)
[204.769851] Subtest universal-plane-pageflip-windowed: SUCCESS (4.245s)
[205.639169] [042/131] (824s left) kms_properties (plane-properties-legacy)
[205.736744] Starting subtest: plane-properties-legacy
[205.738607] Starting dynamic subtest: pipe-A-eDP-1
[206.289998] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.550s)
[206.300374] Starting dynamic subtest: pipe-B-eDP-1
[207.595474] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.305s)
[207.606102] Starting dynamic subtest: pipe-C-eDP-1
[208.824927] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.226s)
[208.835519] Starting dynamic subtest: pipe-D-eDP-1
[210.060584] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.237s)
[210.062804] Subtest plane-properties-legacy: SUCCESS (4.323s)
[210.888118] [043/131] (818s left) api_intel_bb (full-batch)
[210.947591] Starting subtest: full-batch
[210.952674] Subtest full-batch: SUCCESS (0.006s)
[211.121815] [044/131] (818s left) syncobj_timeline (signal)
[211.188904] Starting subtest: signal
[211.191202] Subtest signal: SUCCESS (0.001s)
[211.325235] [045/131] (818s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[211.428382] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[211.442182] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.013s)
[211.546257] [046/131] (818s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[211.646773] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[212.026992] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[214.837009] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.807s)
[214.848966] Starting dynamic subtest: pipe-A-eDP-1-4
[217.014013] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.174s)
[217.026311] Starting dynamic subtest: pipe-A-eDP-1-4
[219.024930] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[219.037065] Starting dynamic subtest: pipe-A-eDP-1-x
[221.216423] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.189s)
[221.583902] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[224.366371] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.790s)
[224.379018] Starting dynamic subtest: pipe-B-eDP-1-4
[226.554003] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.184s)
[226.566388] Starting dynamic subtest: pipe-B-eDP-1-4
[228.565154] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[228.576552] Starting dynamic subtest: pipe-B-eDP-1-x
[230.756753] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[231.138805] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[233.899376] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.767s)
[233.912006] Starting dynamic subtest: pipe-C-eDP-1-4
[236.073023] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s)
[236.083896] Starting dynamic subtest: pipe-C-eDP-1-4
[238.082477] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[238.094905] Starting dynamic subtest: pipe-C-eDP-1-x
[240.260341] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s)
[240.624808] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[243.423810] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.806s)
[243.436934] Starting dynamic subtest: pipe-D-eDP-1-4
[245.620225] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.196s)
[245.632448] Starting dynamic subtest: pipe-D-eDP-1-4
[247.630047] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[247.642797] Starting dynamic subtest: pipe-D-eDP-1-x
[249.808390] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.177s)
[249.811161] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.158s)
[251.037118] [047/131] (778s left) gem_ccs (block-copy-compressed)
[251.101378] Starting subtest: block-copy-compressed
[251.105454] Subtest block-copy-compressed: SKIP (0.000s)
[251.241456] [048/131] (778s left) kms_pm_rpm (fences-dpms)
[253.283491] Starting subtest: fences-dpms
[253.288420] Subtest fences-dpms: SKIP (0.000s)
[253.678749] [049/131] (776s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[253.804539] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[253.808831] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[253.954387] [050/131] (776s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[254.059750] Starting subtest: invalidate-primary-flip-overlay
[264.792103] Subtest invalidate-primary-flip-overlay: SUCCESS (10.736s)
[264.934011] [051/131] (765s left) gem_userptr_blits (userfault)
[265.002691] Starting subtest: userfault
[265.004615] Subtest userfault: SUCCESS (0.006s)
[265.178398] [052/131] (765s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[265.236298] Starting subtest: invalid-multi-wait-unsubmitted
[265.238214] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[265.369842] [053/131] (764s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[265.463887] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[265.467221] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[265.596507] [054/131] (764s left) drm_read (short-buffer-wakeup)
[265.761007] Starting subtest: short-buffer-wakeup
[297.980412] Subtest short-buffer-wakeup: SUCCESS (32.215s)
[298.165387] [055/131] (732s left) kms_addfb_basic (bad-pitch-1024)
[298.229096] Starting subtest: bad-pitch-1024
[298.231362] Subtest bad-pitch-1024: SUCCESS (0.000s)
[298.405624] [056/131] (731s left) gem_ctx_bad_destroy (invalid-ctx)
[298.458022] Starting subtest: invalid-ctx
[298.460336] Subtest invalid-ctx: SUCCESS (0.000s)
[298.561123] [057/131] (731s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[298.690241] Starting subtest: cursorB-vs-flipA-atomic
[298.694726] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s)
[298.859437] [058/131] (731s left) i915_selftest (mock)
[302.284453] Starting subtest: mock
[302.286646] Starting dynamic subtest: sanitycheck
[302.979480] Dynamic subtest sanitycheck: SUCCESS (0.714s)
[302.989322] Starting dynamic subtest: shmem
[303.718196] Dynamic subtest shmem: SUCCESS (0.736s)
[303.728054] Starting dynamic subtest: fence
[311.328199] Dynamic subtest fence: SUCCESS (7.605s)
[311.338018] Starting dynamic subtest: scatterlist
[313.043048] Dynamic subtest scatterlist: SUCCESS (1.712s)
[313.053385] Starting dynamic subtest: syncmap
[316.464934] Dynamic subtest syncmap: SUCCESS (3.419s)
[316.474841] Starting dynamic subtest: uncore
[317.274456] Dynamic subtest uncore: SUCCESS (0.780s)
[317.285291] Starting dynamic subtest: ring
[317.954921] Dynamic subtest ring: SUCCESS (0.706s)
[317.964969] Starting dynamic subtest: engine
[318.677084] Dynamic subtest engine: SUCCESS (0.719s)
[318.687012] Starting dynamic subtest: timelines
[322.719768] Dynamic subtest timelines: SUCCESS (4.039s)
[322.729605] Starting dynamic subtest: requests
[326.129174] Dynamic subtest requests: SUCCESS (3.405s)
[326.139242] Starting dynamic subtest: objects
[327.017227] Dynamic subtest objects: SUCCESS (0.887s)
[327.027577] Starting dynamic subtest: phys
[327.862701] Dynamic subtest phys: SUCCESS (0.843s)
[327.873133] Starting dynamic subtest: dmabuf
[328.714727] Dynamic subtest dmabuf: SUCCESS (0.850s)
[328.724135] Starting dynamic subtest: vma
[334.197884] Dynamic subtest vma: SUCCESS (5.478s)
[334.207784] Starting dynamic subtest: evict
[335.729185] Dynamic subtest evict: SUCCESS (1.529s)
[335.739239] Starting dynamic subtest: gtt
[338.993341] Dynamic subtest gtt: SUCCESS (3.260s)
[339.003533] Starting dynamic subtest: hugepages
[339.941781] Dynamic subtest hugepages: SUCCESS (0.947s)
[339.952066] Starting dynamic subtest: memory_region
[342.537328] Dynamic subtest memory_region: SUCCESS (2.591s)
[342.540051] Subtest mock: SUCCESS (40.260s)
[342.571845] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[342.572540] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[342.575653] [059/131] (687s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[344.178897] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[350.920033] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.743s)
[351.061063] [FACT kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[351.062267] [FACT kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)] new: kernel.kmod_is_loaded.i915: true
[351.066059] [060/131] (679s left) gem_exec_gttfill (all-engines)
[351.142776] Starting subtest: all-engines
[375.054684] Subtest all-engines: SUCCESS (23.912s)
[375.272409] [061/131] (655s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[375.442250] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[375.446705] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[375.612524] [062/131] (654s left) kms_pm_rpm (pm-caching)
[377.367043] Starting subtest: pm-caching
[377.372006] Subtest pm-caching: SKIP (0.000s)
[377.943004] [063/131] (652s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[378.048451] Starting subtest: y-tiled-16bpp-rotate-90
[378.052509] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[378.189275] [064/131] (652s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[378.258899] Starting subtest: multi-wait-for-submit-unsubmitted
[378.365400] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[378.463676] [065/131] (652s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[378.572592] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[385.576927] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (7.007s)
[385.760359] [066/131] (645s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[385.858484] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[385.862671] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[385.987042] [067/131] (644s left) gem_exec_params (invalid-bsd-ring)
[386.053886] Starting subtest: invalid-bsd-ring
[386.056264] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[386.198635] [068/131] (644s left) sysfs_preempt_timeout (idempotent)
[386.262652] Starting subtest: idempotent
[386.265000] Starting dynamic subtest: vecs0
[386.267239] Dynamic subtest vecs0: SUCCESS (0.000s)
[386.278712] Starting dynamic subtest: ccs0
[386.280850] Dynamic subtest ccs0: SUCCESS (0.000s)
[386.290196] Starting dynamic subtest: vcs0
[386.292321] Dynamic subtest vcs0: SUCCESS (0.000s)
[386.301515] Starting dynamic subtest: bcs0
[386.303732] Dynamic subtest bcs0: SUCCESS (0.000s)
[386.313057] Starting dynamic subtest: rcs0
[386.315233] Dynamic subtest rcs0: SUCCESS (0.000s)
[386.324487] Starting dynamic subtest: vcs1
[386.326777] Dynamic subtest vcs1: SUCCESS (0.000s)
[386.328711] Subtest idempotent: SUCCESS (0.006s)
[386.409994] [069/131] (644s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[386.468506] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[386.472585] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[386.671769] [070/131] (644s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[386.936611] Starting subtest: cursor-rapid-movement-512x170
[386.940857] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[387.097954] [071/131] (643s left) kms_dirtyfb (default-dirtyfb-ioctl)
[387.189813] Starting subtest: default-dirtyfb-ioctl
[387.192003] Starting dynamic subtest: A-eDP-1
[388.816933] Dynamic subtest A-eDP-1: SUCCESS (1.627s)
[388.819169] Subtest default-dirtyfb-ioctl: SUCCESS (1.628s)
[389.677759] [072/131] (641s left) kms_flip (2x-blocking-wf_vblank)
[389.782700] Starting subtest: 2x-blocking-wf_vblank
[389.793613] Subtest 2x-blocking-wf_vblank: SKIP (0.013s)
[389.897506] [073/131] (641s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[390.004320] Starting subtest: x-tiled-16bpp-rotate-270
[390.024657] Subtest x-tiled-16bpp-rotate-270: SKIP (0.020s)
[390.175789] [074/131] (640s left) core_setmaster_vs_auth
[390.368754] [075/131] (640s left) kms_addfb_basic (bad-pitch-65536)
[390.425319] Starting subtest: bad-pitch-65536
[390.427603] Subtest bad-pitch-65536: SUCCESS (0.000s)
[390.595685] [076/131] (640s left) gem_mmap_gtt (cpuset-big-copy-odd)
[390.655293] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[390.721638] [077/131] (640s left) gem_eio (context-create)
[390.945076] Starting subtest: context-create
[391.271808] Subtest context-create: SUCCESS (0.326s)
[391.434159] [078/131] (639s left) kms_properties (get_properties-sanity-atomic)
[391.529425] Starting subtest: get_properties-sanity-atomic
[391.531300] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[391.628427] [079/131] (639s left) gem_exec_gttfill (basic)
[391.681880] Starting subtest: basic
[394.064423] Subtest basic: SUCCESS (2.382s)
[394.282930] [080/131] (637s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[394.438226] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[398.440215] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (4.005s)
[399.593752] [081/131] (631s left) kms_big_fb (4-tiled-addfb-size-overflow)
[399.698403] Starting subtest: 4-tiled-addfb-size-overflow
[399.700704] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[399.825840] [082/131] (631s left) gem_exec_reloc (basic-cpu-gtt-active)
[399.893398] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[399.965013] [083/131] (631s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[400.072830] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[400.077166] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[400.217160] [084/131] (631s left) kms_vblank (ts-continuation-modeset-rpm)
[400.311644] Starting subtest: ts-continuation-modeset-rpm
[400.313769] Starting dynamic subtest: pipe-A-eDP-1
[402.846418] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.534s)
[402.861519] Starting dynamic subtest: pipe-D-eDP-1
[405.101730] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.253s)
[405.104085] Subtest ts-continuation-modeset-rpm: SUCCESS (4.791s)
[405.922653] [085/131] (625s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[406.017664] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[406.022221] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[406.141812] [086/131] (625s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[406.246015] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[412.871557] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.627s)
[413.059561] [087/131] (618s left) kms_addfb_basic (unused-offsets)
[413.117781] Starting subtest: unused-offsets
[413.120244] Subtest unused-offsets: SUCCESS (0.000s)
[413.284950] [088/131] (618s left) syncobj_wait (single-wait-for-submit-signaled)
[413.344566] Starting subtest: single-wait-for-submit-signaled
[413.346805] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[413.457912] [089/131] (618s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[413.551055] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[413.555108] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[413.670263] [090/131] (618s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[413.775047] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[414.998952] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: FAIL (0.641s)
[415.039539] [091/131] (616s left) kms_draw_crc (draw-method-blt)
[415.147045] Starting subtest: draw-method-blt
[415.148884] Starting dynamic subtest: xrgb8888-untiled
[415.401351] Dynamic subtest xrgb8888-untiled: SUCCESS (0.255s)
[415.411344] Starting dynamic subtest: rgb565-untiled
[415.612617] Dynamic subtest rgb565-untiled: SUCCESS (0.210s)
[415.622506] Starting dynamic subtest: xrgb2101010-untiled
[415.879339] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.266s)
[415.889151] Starting dynamic subtest: xbgr16161616f-untiled
[416.090381] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.210s)
[416.102095] Starting dynamic subtest: xrgb8888-xtiled
[416.201533] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.110s)
[416.211368] Starting dynamic subtest: rgb565-xtiled
[416.312658] Dynamic subtest rgb565-xtiled: SUCCESS (0.110s)
[416.322113] Starting dynamic subtest: xrgb2101010-xtiled
[416.423815] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s)
[416.433661] Starting dynamic subtest: xbgr16161616f-xtiled
[416.534901] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.110s)
[416.544749] Starting dynamic subtest: xrgb8888-4tiled
[416.657030] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.121s)
[416.667321] Starting dynamic subtest: rgb565-4tiled
[416.779343] Dynamic subtest rgb565-4tiled: SUCCESS (0.122s)
[416.789276] Starting dynamic subtest: xrgb2101010-4tiled
[416.879943] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.099s)
[416.891410] Starting dynamic subtest: xbgr16161616f-4tiled
[416.990515] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.110s)
[416.992386] Subtest draw-method-blt: SUCCESS (1.845s)
[417.153594] [092/131] (614s left) gem_exec_schedule (u-submit-early-slice)
[417.229352] Starting subtest: u-submit-early-slice
[417.231419] Starting dynamic subtest: rcs0
[417.266460] Dynamic subtest rcs0: SUCCESS (0.042s)
[417.279320] Starting dynamic subtest: bcs0
[417.305582] Dynamic subtest bcs0: SUCCESS (0.038s)
[417.315927] Starting dynamic subtest: vcs0
[417.344913] Dynamic subtest vcs0: SUCCESS (0.039s)
[417.355601] Starting dynamic subtest: vcs1
[417.385812] Dynamic subtest vcs1: SUCCESS (0.040s)
[417.396432] Starting dynamic subtest: vecs0
[417.426006] Dynamic subtest vecs0: SUCCESS (0.040s)
[417.436454] Starting dynamic subtest: ccs0
[417.467512] Dynamic subtest ccs0: SUCCESS (0.041s)
[417.469559] Subtest u-submit-early-slice: SUCCESS (0.244s)
[419.285217] [093/131] (612s left) kms_plane (planar-pixel-format-settings)
[419.389149] Starting subtest: planar-pixel-format-settings
[419.430365] Subtest planar-pixel-format-settings: SUCCESS (0.042s)
[419.565857] [094/131] (612s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[419.660626] Starting subtest: fbc-psr2-sprite-mmap-cpu
[419.662955] Starting dynamic subtest: eDP-1
[419.667356] Dynamic subtest eDP-1: SKIP (0.000s)
[419.671799] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[419.759883] [095/131] (612s left) gem_softpin (allocator-basic-reserve)
[419.841658] Starting subtest: allocator-basic-reserve
[419.926959] Subtest allocator-basic-reserve: SUCCESS (0.087s)
[420.101954] [096/131] (611s left) gem_exec_schedule (noreorder-priority)
[420.285395] Starting subtest: noreorder-priority
[420.287870] Starting dynamic subtest: rcs0
[421.443347] Dynamic subtest rcs0: SUCCESS (1.157s)
[421.457230] Starting dynamic subtest: vcs0
[423.202558] Dynamic subtest vcs0: SUCCESS (1.756s)
[423.215805] Starting dynamic subtest: vcs1
[425.184336] Dynamic subtest vcs1: SUCCESS (1.980s)
[425.197243] Starting dynamic subtest: vecs0
[427.130728] Dynamic subtest vecs0: SUCCESS (1.943s)
[427.143758] Starting dynamic subtest: ccs0
[428.296344] Dynamic subtest ccs0: SUCCESS (1.164s)
[428.299238] Subtest noreorder-priority: SUCCESS (8.012s)
[428.512413] [097/131] (603s left) kms_atomic_interruptible (legacy-dpms)
[428.615156] Starting subtest: legacy-dpms
[428.617427] Starting dynamic subtest: pipe-A-eDP-1
[436.058776] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.441s)
[436.061042] Subtest legacy-dpms: SUCCESS (7.442s)
[436.906911] [098/131] (595s left) gem_mmap_offset (bad-extensions)
[436.978088] Starting subtest: bad-extensions
[436.980457] Subtest bad-extensions: SUCCESS (0.000s)
[437.117728] [099/131] (595s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[437.216118] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[437.219002] Starting dynamic subtest: pipe-A-default-mode
[439.896190] Dynamic subtest pipe-A-default-mode: SUCCESS (2.678s)
[439.898510] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.680s)
[440.789656] [100/131] (591s left) perf_pmu (busy-no-semaphores)
[440.836845] Starting subtest: busy-no-semaphores
[440.839120] Starting dynamic subtest: rcs0
[441.432395] Dynamic subtest rcs0: SUCCESS (0.596s)
[441.445086] Starting dynamic subtest: bcs0
[441.980756] Dynamic subtest bcs0: SUCCESS (0.546s)
[441.991708] Starting dynamic subtest: vcs0
[442.528888] Dynamic subtest vcs0: SUCCESS (0.545s)
[442.539954] Starting dynamic subtest: vcs1
[443.659063] Dynamic subtest vcs1: SUCCESS (1.126s)
[443.672057] Starting dynamic subtest: vecs0
[445.646426] Dynamic subtest vecs0: SUCCESS (1.984s)
[445.660369] Starting dynamic subtest: ccs0
[447.692467] Dynamic subtest ccs0: SUCCESS (2.043s)
[447.695174] Subtest busy-no-semaphores: SUCCESS (6.857s)
[447.835885] [101/131] (584s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[452.837957] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf
[452.840280] Starting dynamic subtest: pipe-A-eDP-1
[453.630295] Dynamic subtest pipe-A-eDP-1: SKIP (0.790s)
[453.642141] Starting dynamic subtest: pipe-B-eDP-1
[454.768192] Dynamic subtest pipe-B-eDP-1: SKIP (1.135s)
[454.772794] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.929s)
[455.979953] [102/131] (576s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[456.093737] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[456.098071] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[456.238466] [103/131] (576s left) kms_fence_pin_leak
[456.420947] [104/131] (575s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[456.518863] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[456.521238] Starting dynamic subtest: pipe-A-eDP-1
[456.530315] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[456.551609] Starting dynamic subtest: pipe-B-eDP-1
[456.561270] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[456.580359] Starting dynamic subtest: pipe-C-eDP-1
[456.589365] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[456.608425] Starting dynamic subtest: pipe-D-eDP-1
[456.617589] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[456.621811] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[458.835444] [105/131] (573s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[458.942189] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[458.946415] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[459.101445] [106/131] (573s left) kms_cursor_edge_walk (256x256-left-edge)
[459.212662] Starting subtest: 256x256-left-edge
[459.214894] Starting dynamic subtest: pipe-A-eDP-1
[462.672803] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.460s)
[462.683509] Starting dynamic subtest: pipe-D-eDP-1
[465.791428] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.115s)
[465.793668] Subtest 256x256-left-edge: SUCCESS (6.578s)
[466.627794] [107/131] (565s left) vgem_basic (setversion)
[466.677649] Starting subtest: setversion
[466.681828] Subtest setversion: SUCCESS (0.000s)
[466.758025] [108/131] (565s left) kms_atomic_transition (plane-all-transition-fencing)
[466.860990] Starting subtest: plane-all-transition-fencing
[466.863293] Starting dynamic subtest: pipe-A-eDP-1
[469.356834] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.497s)
[469.676768] Starting dynamic subtest: pipe-B-eDP-1
[472.934426] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.268s)
[473.231028] Subtest plane-all-transition-fencing: SUCCESS (6.370s)
[474.081399] [109/131] (558s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[474.177285] Starting subtest: yf-tiled-32bpp-rotate-0
[474.181622] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[474.298199] [110/131] (558s left) gem_workarounds (suspend-resume-fd)
[474.369380] Starting subtest: suspend-resume-fd
[490.539807] Subtest suspend-resume-fd: SUCCESS (2.327s)
[499.738087] [111/131] (541s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[499.850452] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[499.854816] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[500.978138] [112/131] (540s left) gem_eio (in-flight-external)
[501.189735] Starting subtest: in-flight-external
[503.068128] Subtest in-flight-external: SUCCESS (1.838s)
[503.232688] [113/131] (538s left) i915_drm_fdinfo (busy-hang)
[503.278768] Starting subtest: busy-hang
[503.281133] Starting dynamic subtest: rcs0
[503.330423] Dynamic subtest rcs0: SKIP (0.049s)
[503.343453] Starting dynamic subtest: bcs0
[503.347893] Dynamic subtest bcs0: SKIP (0.001s)
[503.357777] Starting dynamic subtest: vcs0
[503.361936] Dynamic subtest vcs0: SKIP (0.001s)
[503.372014] Starting dynamic subtest: vcs1
[503.376457] Dynamic subtest vcs1: SKIP (0.000s)
[503.387324] Starting dynamic subtest: vecs0
[503.391494] Dynamic subtest vecs0: SKIP (0.000s)
[503.401174] Starting dynamic subtest: ccs0
[503.405340] Dynamic subtest ccs0: SKIP (0.000s)
[503.409481] Subtest busy-hang: SKIP (0.058s)
[503.446788] [114/131] (538s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[503.565428] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[503.569513] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[503.703227] [115/131] (538s left) kms_chamelium_hpd (hdmi-hpd-storm)
[504.108607] Subtest hdmi-hpd-storm: SKIP (0.000s)
[504.940286] [116/131] (536s left) kms_invalid_mode (zero-vdisplay)
[505.051296] Starting subtest: zero-vdisplay
[505.053645] Starting dynamic subtest: pipe-A-eDP-1
[505.341236] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[505.352373] Starting dynamic subtest: pipe-B-eDP-1
[505.354678] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[505.365265] Starting dynamic subtest: pipe-C-eDP-1
[505.367251] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[505.377164] Starting dynamic subtest: pipe-D-eDP-1
[505.379215] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[505.381616] Subtest zero-vdisplay: SUCCESS (0.290s)
[506.225286] [117/131] (535s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[506.339547] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[513.410016] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.017s)
[513.586039] [118/131] (528s left) kms_atomic_interruptible (legacy-pageflip)
[513.697512] Starting subtest: legacy-pageflip
[513.699864] Starting dynamic subtest: pipe-A-eDP-1
[521.110411] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.388s)
[521.112880] Subtest legacy-pageflip: SUCCESS (7.390s)
[521.987697] [119/131] (520s left) prime_mmap (test_refcounting)
[522.056441] Starting subtest: test_refcounting
[522.058749] Starting dynamic subtest: test_refcounting-smem
[522.085004] Dynamic subtest test_refcounting-smem: SUCCESS (0.030s)
[522.087320] Subtest test_refcounting: SUCCESS (0.031s)
[522.215091] [120/131] (519s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[527.259653] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[527.264287] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.003s)
[528.143271] [121/131] (513s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[528.250332] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[528.254497] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[528.385584] [122/131] (513s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[528.767736] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[529.547789] [123/131] (512s left) gem_ctx_param (vm)
[529.607661] Starting subtest: vm
[529.652768] Subtest vm: SUCCESS (0.045s)
[529.833043] [124/131] (512s left) kms_pipe_stress (stress-xrgb8888-untiled)
[529.941297] Starting subtest: stress-xrgb8888-untiled
[535.772489] Subtest stress-xrgb8888-untiled: SUCCESS (5.829s)
[535.828839] [125/131] (506s left) api_intel_bb (blit-noreloc-purge-cache)
[535.884543] Starting subtest: blit-noreloc-purge-cache
[535.892092] Subtest blit-noreloc-purge-cache: SUCCESS (0.010s)
[536.053658] [126/131] (506s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[536.152041] Starting subtest: psr-rgb565-draw-mmap-wc
[542.964015] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.814s)
[543.114025] [127/131] (499s left) syncobj_timeline (single-wait-all-signaled)
[543.172086] Starting subtest: single-wait-all-signaled
[543.174269] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[543.298544] [128/131] (499s left) kms_flip (2x-flip-vs-expired-vblank)
[543.399525] Starting subtest: 2x-flip-vs-expired-vblank
[543.408424] Subtest 2x-flip-vs-expired-vblank: SKIP (0.011s)
[543.547709] [129/131] (498s left) prime_mmap_coherency (read)
[543.615493] Starting subtest: read
[548.993465] Subtest read: SUCCESS (5.376s)
[549.124763] [130/131] (493s left) perf (invalid-oa-exponent)
[549.286020] Starting subtest: invalid-oa-exponent
[549.301987] Subtest invalid-oa-exponent: SUCCESS (0.014s)
[549.347300] [131/131] (493s left) prime_busy (after-wait)
[549.412640] Starting subtest: after-wait
[549.414935] Starting dynamic subtest: rcs0
[549.455531] Dynamic subtest rcs0: SUCCESS (0.042s)
[549.469082] Starting dynamic subtest: bcs0
[549.515429] Dynamic subtest bcs0: SUCCESS (0.058s)
[549.527625] Starting dynamic subtest: vcs0
[549.558957] Dynamic subtest vcs0: SUCCESS (0.044s)
[549.571066] Starting dynamic subtest: vcs1
[549.602310] Dynamic subtest vcs1: SUCCESS (0.042s)
[549.614520] Starting dynamic subtest: vecs0
[549.643756] Dynamic subtest vecs0: SUCCESS (0.041s)
[549.655512] Starting dynamic subtest: ccs0
[549.685732] Dynamic subtest ccs0: SUCCESS (0.041s)
[549.794358] Subtest after-wait: SUCCESS (0.382s)
[549.893520] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_schedule
results: parsing output: 1/ for test: kms_psr
results: parsing output: 2/ for test: kms_flip
results: parsing output: 3/ for test: kms_content_protection
results: parsing output: 4/ for test: kms_lease
results: parsing output: 5/ for test: kms_psr
results: parsing output: 6/ for test: kms_plane_scaling
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: kms_psr
results: parsing output: 9/ for test: i915_pm_rpm
results: parsing output: 10/ for test: gem_caching
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_ctx_engines
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: syncobj_wait
results: parsing output: 15/ for test: kms_feature_discovery
results: parsing output: 16/ for test: kms_cursor_crc
results: parsing output: 17/ for test: kms_chamelium_frames
results: parsing output: 18/ for test: i915_drm_fdinfo
results: parsing output: 19/ for test: prime_self_import
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_pm_backlight
results: parsing output: 23/ for test: kms_flip
results: parsing output: 24/ for test: kms_cursor_legacy
results: parsing output: 25/ for test: gem_ctx_persistence
results: parsing output: 26/ for test: gem_exec_balancer
results: parsing output: 27/ for test: gem_exec_balancer
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: gem_exec_fence
results: parsing output: 30/ for test: kms_atomic
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_pxp
results: parsing output: 33/ for test: kms_ccs
results: parsing output: 34/ for test: gem_pwrite
results: parsing output: 35/ for test: kms_psr
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gen9_exec_parse
results: parsing output: 38/ for test: perf_pmu
results: parsing output: 39/ for test: gem_gpgpu_fill
results: parsing output: 40/ for test: kms_universal_plane
results: parsing output: 41/ for test: kms_properties
results: parsing output: 42/ for test: api_intel_bb
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: kms_flip
results: parsing output: 45/ for test: kms_async_flips
results: parsing output: 46/ for test: gem_ccs
results: parsing output: 47/ for test: kms_pm_rpm
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_psr_stress_test
results: parsing output: 50/ for test: gem_userptr_blits
results: parsing output: 51/ for test: syncobj_timeline
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: drm_read
results: parsing output: 54/ for test: kms_addfb_basic
results: parsing output: 55/ for test: gem_ctx_bad_destroy
results: parsing output: 56/ for test: kms_cursor_legacy
results: parsing output: 57/ for test: i915_selftest
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_exec_gttfill
results: parsing output: 60/ for test: kms_cursor_legacy
results: parsing output: 61/ for test: kms_pm_rpm
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: syncobj_wait
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_exec_params
results: parsing output: 67/ for test: sysfs_preempt_timeout
results: parsing output: 68/ for test: gem_render_copy
results: parsing output: 69/ for test: kms_cursor_crc
results: parsing output: 70/ for test: kms_dirtyfb
results: parsing output: 71/ for test: kms_flip
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: core_setmaster_vs_auth
results: parsing output: 74/ for test: kms_addfb_basic
results: parsing output: 75/ for test: gem_mmap_gtt
results: parsing output: 76/ for test: gem_eio
results: parsing output: 77/ for test: kms_properties
results: parsing output: 78/ for test: gem_exec_gttfill
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: gem_exec_reloc
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: kms_vblank
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_addfb_basic
results: parsing output: 87/ for test: syncobj_wait
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: kms_draw_crc
results: parsing output: 91/ for test: gem_exec_schedule
results: parsing output: 92/ for test: kms_plane
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: gem_softpin
results: parsing output: 95/ for test: gem_exec_schedule
results: parsing output: 96/ for test: kms_atomic_interruptible
results: parsing output: 97/ for test: gem_mmap_offset
results: parsing output: 98/ for test: kms_flip_scaled_crc
results: parsing output: 99/ for test: perf_pmu
results: parsing output: 100/ for test: kms_psr2_sf
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_fence_pin_leak
results: parsing output: 103/ for test: kms_ccs
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_cursor_edge_walk
results: parsing output: 106/ for test: vgem_basic
results: parsing output: 107/ for test: kms_atomic_transition
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: gem_workarounds
results: parsing output: 110/ for test: kms_ccs
results: parsing output: 111/ for test: gem_eio
results: parsing output: 112/ for test: i915_drm_fdinfo
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_chamelium_hpd
results: parsing output: 115/ for test: kms_invalid_mode
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_atomic_interruptible
results: parsing output: 118/ for test: prime_mmap
results: parsing output: 119/ for test: kms_psr2_sf
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_chamelium_edid
results: parsing output: 122/ for test: gem_ctx_param
results: parsing output: 123/ for test: kms_pipe_stress
results: parsing output: 124/ for test: api_intel_bb
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: syncobj_timeline
results: parsing output: 127/ for test: kms_flip
results: parsing output: 128/ for test: prime_mmap_coherency
results: parsing output: 129/ for test: perf
results: parsing output: 130/ for test: prime_busy
Done.