[61.394867] Initializing watchdogs
[61.394933]   /dev/watchdog0
[61.415242] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[61.426008] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[61.430197] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.432745] [001/131] (960s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[61.626580] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.000s)
[61.676954] [002/131] (960s left) vgem_basic (create)
[61.772478] Starting subtest: create
[61.773400] Subtest create: SUCCESS (0.000s)
[61.916402] [FACT vgem_basic (create)] new: kernel.kmod_is_loaded.vgem: true
[61.918136] [003/131] (960s left) gem_exec_alignment (many)
[62.015535] Starting subtest: many
[90.504999] Subtest many: SUCCESS (28.504s)
[91.238325] [004/131] (930s left) gem_userptr_blits (create-destroy-sync)
[91.374485] Starting subtest: create-destroy-sync
[96.397501] Subtest create-destroy-sync: SUCCESS (5.023s)
[96.622959] [005/131] (925s left) perf_pmu (busy-double-start)
[96.695246] Starting subtest: busy-double-start
[96.696170] Starting dynamic subtest: rcs0
[100.327475] Dynamic subtest rcs0: SUCCESS (3.631s)
[100.339810] Starting dynamic subtest: bcs0
[103.925432] Dynamic subtest bcs0: SUCCESS (3.597s)
[103.937271] Starting dynamic subtest: vcs0
[107.531280] Dynamic subtest vcs0: SUCCESS (3.605s)
[107.543770] Starting dynamic subtest: vcs1
[111.133187] Dynamic subtest vcs1: SUCCESS (3.601s)
[111.145604] Starting dynamic subtest: vecs0
[114.729378] Dynamic subtest vecs0: SUCCESS (3.595s)
[114.741518] Starting dynamic subtest: vecs1
[118.337272] Dynamic subtest vecs1: SUCCESS (3.607s)
[118.349538] Starting dynamic subtest: ccs0
[121.943070] Dynamic subtest ccs0: SUCCESS (3.605s)
[121.944856] Subtest busy-double-start: SUCCESS (25.248s)
[122.121125] [006/131] (900s left) prime_mmap (test_aperture_limit)
[122.202962] Starting subtest: test_aperture_limit
[122.203882] Starting dynamic subtest: test_aperture_limit-smem
[122.217760] Dynamic subtest test_aperture_limit-smem: SKIP (0.015s)
[122.219767] Subtest test_aperture_limit: SKIP (0.015s)
[122.389925] [007/131] (899s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[122.585718] Starting subtest: psr-farfromfence-mmap-gtt
[122.587413] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[122.790967] [008/131] (899s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[122.980883] Starting subtest: invalid-modeset-force-ultra-joiner
[122.982519] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[123.148931] [009/131] (899s left) gem_exec_schedule (pi-distinct-iova)
[123.365530] Starting subtest: pi-distinct-iova
[123.366438] Starting dynamic subtest: rcs0
[123.626414] Dynamic subtest rcs0: SUCCESS (0.261s)
[123.635509] Starting dynamic subtest: bcs0
[123.806782] Dynamic subtest bcs0: SUCCESS (0.180s)
[123.815776] Starting dynamic subtest: vcs0
[123.993246] Dynamic subtest vcs0: SUCCESS (0.186s)
[124.002297] Starting dynamic subtest: vcs1
[124.180572] Dynamic subtest vcs1: SUCCESS (0.187s)
[124.189797] Starting dynamic subtest: vecs0
[124.367834] Dynamic subtest vecs0: SUCCESS (0.187s)
[124.377044] Starting dynamic subtest: vecs1
[124.555127] Dynamic subtest vecs1: SUCCESS (0.187s)
[124.564324] Starting dynamic subtest: ccs0
[124.746974] Dynamic subtest ccs0: SUCCESS (0.191s)
[124.748008] Subtest pi-distinct-iova: SUCCESS (1.382s)
[125.175412] [010/131] (897s left) gem_exec_whisper (basic-fds-forked)
[125.266392] Starting subtest: basic-fds-forked
[147.958768] Subtest basic-fds-forked: SUCCESS (22.690s)
[148.236172] [011/131] (874s left) gem_lmem_swapping (parallel-random)
[151.010019] Starting subtest: parallel-random
[151.012961] Starting dynamic subtest: lmem0
[195.550470] Dynamic subtest lmem0: SUCCESS (44.540s)
[195.551589] Subtest parallel-random: SUCCESS (44.540s)
[196.601777] [FACT gem_lmem_swapping (parallel-random)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[196.602893] [FACT gem_lmem_swapping (parallel-random)] deleted: kernel.kmod_is_loaded.i915: true
[196.604640] [012/131] (826s left) kms_content_protection (atomic-dpms-hdcp14)
[198.424890] Starting subtest: atomic-dpms-hdcp14
[198.470137] Starting dynamic subtest: pipe-A-DP-3
[319.503545] Dynamic subtest pipe-A-DP-3: FAIL (120.874s)
[319.504507] Subtest atomic-dpms-hdcp14: FAIL (121.025s)
[319.635173] [FACT kms_content_protection (atomic-dpms-hdcp14)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[319.637856] [FACT kms_content_protection (atomic-dpms-hdcp14)] new: kernel.kmod_is_loaded.i915: true
[319.640142] [013/131] (703s left) gem_exec_schedule (fifo)
[319.735388] Starting subtest: fifo
[319.736223] Starting dynamic subtest: rcs0
[320.018424] Dynamic subtest rcs0: SUCCESS (0.283s)
[320.028301] Starting dynamic subtest: bcs0
[320.219933] Dynamic subtest bcs0: SUCCESS (0.201s)
[320.230165] Starting dynamic subtest: vcs0
[320.429503] Dynamic subtest vcs0: SUCCESS (0.206s)
[320.439392] Starting dynamic subtest: vcs1
[320.637603] Dynamic subtest vcs1: SUCCESS (0.206s)
[320.647354] Starting dynamic subtest: vecs0
[320.847912] Dynamic subtest vecs0: SUCCESS (0.205s)
[320.858432] Starting dynamic subtest: vecs1
[321.055824] Dynamic subtest vecs1: SUCCESS (0.205s)
[321.065601] Starting dynamic subtest: ccs0
[321.248133] Dynamic subtest ccs0: SUCCESS (0.204s)
[321.249203] Subtest fifo: SUCCESS (1.512s)
[321.713028] [014/131] (701s left) kms_chamelium_color (ctm-0-25)
[321.902121] Subtest ctm-0-25: SKIP (0.000s)
[321.958316] [015/131] (700s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[322.158903] Starting subtest: x-tiled-32bpp-rotate-180
[323.964603] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.806s)
[324.183168] [016/131] (698s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[324.391432] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[325.448075] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (1.057s)
[325.728278] [017/131] (697s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[325.808250] Starting subtest: invalid-signal-one-illegal-handle
[325.809229] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[326.014255] [018/131] (697s left) gem_linear_blits (interruptible)
[326.246338] Starting subtest: interruptible
[333.470983] Subtest interruptible: SUCCESS (7.227s)
[333.852258] [019/131] (689s left) gem_workarounds (reset-context)
[333.995975] Starting subtest: reset-context
[334.214898] Subtest reset-context: SUCCESS (0.219s)
[334.410555] [020/131] (688s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc)
[334.599473] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc
[334.600397] Starting dynamic subtest: pipe-A-DP-3
[334.608535] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[334.619026] Starting dynamic subtest: pipe-B-DP-3
[334.627160] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[334.637548] Starting dynamic subtest: pipe-C-DP-3
[334.645887] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[334.656342] Starting dynamic subtest: pipe-D-DP-3
[334.666517] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[334.668527] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[335.094926] [021/131] (688s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[335.282478] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[335.283397] Starting dynamic subtest: pipe-A-DP-3
[335.291610] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[335.302213] Starting dynamic subtest: pipe-B-DP-3
[335.310607] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[335.321065] Starting dynamic subtest: pipe-C-DP-3
[335.329165] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[335.339763] Starting dynamic subtest: pipe-D-DP-3
[335.349481] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[335.351383] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SKIP (0.004s)
[335.776542] [022/131] (687s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[335.965943] Starting subtest: short-flip-after-cursor-toggle
[337.036178] Subtest short-flip-after-cursor-toggle: SUCCESS (1.069s)
[337.409970] [023/131] (686s left) kms_psr (fbc-psr2-primary-render)
[337.598614] Subtest fbc-psr2-primary-render: SKIP (0.000s)
[337.652639] [024/131] (685s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[337.842430] Starting subtest: plane-primary-toggle-with-vblank-wait
[337.844333] Starting dynamic subtest: pipe-A-DP-3
[338.059601] Dynamic subtest pipe-A-DP-3: SUCCESS (0.215s)
[338.189827] Starting dynamic subtest: pipe-B-DP-3
[338.457438] Dynamic subtest pipe-B-DP-3: SUCCESS (0.284s)
[338.585866] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (0.742s)
[338.886871] [025/131] (684s left) gem_exec_fence (submit-chain)
[339.096028] Starting subtest: submit-chain
[339.149067] Subtest submit-chain: SUCCESS (0.057s)
[339.970580] [026/131] (683s left) gem_render_copy (y-tiled-to-vebox-linear)
[340.060501] Starting subtest: y-tiled-to-vebox-linear
[340.062409] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[340.316638] [027/131] (683s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[340.510434] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[340.512120] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[340.721189] [028/131] (683s left) syncobj_timeline (single-wait-available-submitted)
[340.800175] Starting subtest: single-wait-available-submitted
[340.801159] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[340.953534] [029/131] (683s left) sysfs_heartbeat_interval (nopreempt)
[341.036899] Starting subtest: nopreempt
[341.037783] Starting dynamic subtest: vecs0
[345.400202] Dynamic subtest vecs0: SUCCESS (4.362s)
[345.412744] Starting dynamic subtest: ccs0
[349.624182] Dynamic subtest ccs0: SUCCESS (4.223s)
[349.635487] Starting dynamic subtest: vcs0
[353.845231] Dynamic subtest vcs0: SUCCESS (4.221s)
[353.857273] Starting dynamic subtest: bcs0
[358.026061] Dynamic subtest bcs0: SUCCESS (4.180s)
[358.038026] Starting dynamic subtest: vecs1
[362.266395] Dynamic subtest vecs1: SUCCESS (4.240s)
[362.277645] Starting dynamic subtest: rcs0
[366.570056] Dynamic subtest rcs0: SUCCESS (4.303s)
[366.581211] Starting dynamic subtest: vcs1
[370.738552] Dynamic subtest vcs1: SUCCESS (4.168s)
[370.739484] Subtest nopreempt: SUCCESS (29.702s)
[370.932368] [030/131] (653s left) sw_sync (sync_busy_fork)
[370.982172] Starting subtest: sync_busy_fork
[371.995489] Subtest sync_busy_fork: SUCCESS (1.013s)
[372.104839] [031/131] (651s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[372.305277] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[372.307022] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[372.502945] [032/131] (651s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[372.706550] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[372.708267] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[372.903137] [033/131] (651s left) kms_prime (basic-modeset-hybrid)
[373.092127] Subtest basic-modeset-hybrid: SKIP (0.000s)
[373.258769] [034/131] (651s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[373.444436] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[373.445392] Starting dynamic subtest: pipe-A-DP-3
[373.453817] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[373.465197] Starting dynamic subtest: pipe-B-DP-3
[373.473705] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[373.484501] Starting dynamic subtest: pipe-C-DP-3
[373.492729] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[373.503574] Starting dynamic subtest: pipe-D-DP-3
[373.513496] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[373.515372] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.007s)
[373.944638] [035/131] (650s left) kms_feature_discovery (display)
[374.131366] Starting subtest: display
[374.132273] Subtest display: SUCCESS (0.000s)
[374.295824] [036/131] (650s left) gem_create (create-ext-placement-all)
[374.494958] Starting subtest: create-ext-placement-all
[374.496080] Subtest create-ext-placement-all: SUCCESS (0.000s)
[374.641391] [037/131] (649s left) prime_mmap (test_reprime)
[374.721556] Starting subtest: test_reprime
[374.722441] Starting dynamic subtest: test_reprime-smem
[374.768572] Dynamic subtest test_reprime-smem: SUCCESS (0.047s)
[374.780377] Starting dynamic subtest: test_reprime-lmem0
[374.969997] Dynamic subtest test_reprime-lmem0: SUCCESS (0.193s)
[374.971184] Subtest test_reprime: SUCCESS (0.241s)
[375.125604] [038/131] (649s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[375.321525] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[375.323195] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[375.528163] [039/131] (649s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[375.721213] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[375.722130] Starting dynamic subtest: pipe-A-valid-mode
[375.850363] Dynamic subtest pipe-A-valid-mode: SKIP (0.128s)
[375.852981] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.130s)
[376.163367] [040/131] (648s left) gem_softpin (full)
[376.254778] Starting subtest: full
[376.271205] Subtest full: SUCCESS (0.016s)
[376.452676] [041/131] (648s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[376.643839] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[376.645471] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[376.855318] [042/131] (648s left) kms_psr (psr2-sprite-blt)
[377.046175] Subtest psr2-sprite-blt: SKIP (0.000s)
[377.106033] [043/131] (647s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[377.296954] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[382.145560] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.849s)
[382.359064] [044/131] (642s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[382.548767] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[382.550468] Subtest psr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[382.745877] [045/131] (642s left) kms_setmode (invalid-clone-single-crtc-stealing)
[382.836293] Starting subtest: invalid-clone-single-crtc-stealing
[382.839172] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[383.027498] [046/131] (642s left) api_intel_bb (crc32)
[383.106225] Starting subtest: crc32
[383.107204] Starting dynamic subtest: rcs0-lmem0
[383.350065] Dynamic subtest rcs0-lmem0: SUCCESS (0.243s)
[383.368588] Starting dynamic subtest: rcs0-smem0
[383.662562] Dynamic subtest rcs0-smem0: SUCCESS (0.310s)
[383.681128] Starting dynamic subtest: bcs0-lmem0
[383.890810] Dynamic subtest bcs0-lmem0: SUCCESS (0.225s)
[383.909650] Starting dynamic subtest: bcs0-smem0
[384.214948] Dynamic subtest bcs0-smem0: SUCCESS (0.321s)
[384.229787] Starting dynamic subtest: vcs0-lmem0
[384.565395] Dynamic subtest vcs0-lmem0: SUCCESS (0.347s)
[384.585135] Starting dynamic subtest: vcs0-smem0
[385.046947] Dynamic subtest vcs0-smem0: SUCCESS (0.478s)
[385.062098] Starting dynamic subtest: vcs1-lmem0
[385.395104] Dynamic subtest vcs1-lmem0: SUCCESS (0.345s)
[385.414303] Starting dynamic subtest: vcs1-smem0
[385.874048] Dynamic subtest vcs1-smem0: SUCCESS (0.476s)
[385.888699] Starting dynamic subtest: vecs0-lmem0
[386.228910] Dynamic subtest vecs0-lmem0: SUCCESS (0.352s)
[386.248181] Starting dynamic subtest: vecs0-smem0
[386.711545] Dynamic subtest vecs0-smem0: SUCCESS (0.480s)
[386.726217] Starting dynamic subtest: vecs1-lmem0
[387.061491] Dynamic subtest vecs1-lmem0: SUCCESS (0.347s)
[387.105943] Starting dynamic subtest: vecs1-smem0
[387.572046] Dynamic subtest vecs1-smem0: SUCCESS (0.507s)
[387.586639] Starting dynamic subtest: ccs0-lmem0
[387.809326] Dynamic subtest ccs0-lmem0: SUCCESS (0.235s)
[387.828196] Starting dynamic subtest: ccs0-smem0
[388.142415] Dynamic subtest ccs0-smem0: SUCCESS (0.330s)
[388.144158] Subtest crc32: SUCCESS (5.038s)
[388.350710] [047/131] (636s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[388.541904] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[388.557265] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.014s)
[388.746260] [048/131] (636s left) kms_frontbuffer_tracking (basic)
[388.936781] Starting subtest: basic
[391.629191] Subtest basic: SUCCESS (2.693s)
[391.826827] [049/131] (633s left) gem_partial_pwrite_pread (write)
[391.911293] Subtest write: SKIP (0.000s)
[391.989681] [050/131] (633s left) gem_exec_schedule (u-fairslice)
[392.081657] Starting subtest: u-fairslice
[392.082536] Starting dynamic subtest: rcs0
[394.132827] Dynamic subtest rcs0: SUCCESS (2.050s)
[394.144616] Starting dynamic subtest: bcs0
[396.153029] Dynamic subtest bcs0: SUCCESS (2.019s)
[396.164662] Starting dynamic subtest: vcs0
[398.174044] Dynamic subtest vcs0: SUCCESS (2.021s)
[398.185701] Starting dynamic subtest: vcs1
[400.216399] Dynamic subtest vcs1: SUCCESS (2.041s)
[400.231482] Starting dynamic subtest: vecs0
[402.239956] Dynamic subtest vecs0: SUCCESS (2.022s)
[402.251700] Starting dynamic subtest: vecs1
[404.261941] Dynamic subtest vecs1: SUCCESS (2.021s)
[404.273352] Starting dynamic subtest: ccs0
[406.281082] Dynamic subtest ccs0: SUCCESS (2.019s)
[406.281953] Subtest u-fairslice: SUCCESS (14.199s)
[406.697644] [051/131] (618s left) i915_hangman (gt-error-state-capture)
[406.799491] Starting subtest: gt-error-state-capture
[406.800430] Starting dynamic subtest: rcs0
[417.122118] Dynamic subtest rcs0: SUCCESS (10.323s)
[417.133716] Starting dynamic subtest: bcs0
[427.050990] Dynamic subtest bcs0: SUCCESS (9.928s)
[427.062405] Starting dynamic subtest: vcs0
[437.073739] Dynamic subtest vcs0: SUCCESS (10.022s)
[437.085603] Starting dynamic subtest: vcs1
[447.090248] Dynamic subtest vcs1: SUCCESS (10.016s)
[447.101724] Starting dynamic subtest: vecs0
[457.080388] Dynamic subtest vecs0: SUCCESS (9.989s)
[457.091532] Starting dynamic subtest: vecs1
[467.066660] Dynamic subtest vecs1: SUCCESS (9.985s)
[467.078209] Starting dynamic subtest: ccs0
[477.060369] Dynamic subtest ccs0: SUCCESS (9.993s)
[477.061299] Subtest gt-error-state-capture: SUCCESS (70.261s)
[477.281197] [052/131] (548s left) gem_exec_fence (basic-wait)
[477.517848] Starting subtest: basic-wait
[477.519286] Starting dynamic subtest: rcs0
[477.644322] Dynamic subtest rcs0: SUCCESS (0.127s)
[477.660789] Starting dynamic subtest: bcs0
[477.706630] Dynamic subtest bcs0: SUCCESS (0.060s)
[477.747209] Starting dynamic subtest: vcs0
[477.767401] Dynamic subtest vcs0: SUCCESS (0.059s)
[477.787600] Starting dynamic subtest: vcs1
[477.821798] Dynamic subtest vcs1: SUCCESS (0.053s)
[477.847559] Starting dynamic subtest: vecs0
[477.877776] Dynamic subtest vecs0: SUCCESS (0.054s)
[477.914966] Starting dynamic subtest: vecs1
[477.936349] Dynamic subtest vecs1: SUCCESS (0.057s)
[477.953174] Starting dynamic subtest: ccs0
[477.991647] Dynamic subtest ccs0: SUCCESS (0.054s)
[477.992892] Subtest basic-wait: SUCCESS (0.477s)
[478.765027] [053/131] (546s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[478.976663] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[478.978292] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[479.182692] [054/131] (546s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[479.381805] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[479.383382] Subtest fbcpsr-rgb565-draw-mmap-wc: SKIP (0.000s)
[479.563180] [055/131] (546s left) i915_drm_fdinfo (idle)
[479.634205] Starting subtest: idle
[479.635167] Starting dynamic subtest: rcs0
[480.212936] Dynamic subtest rcs0: SUCCESS (0.578s)
[480.230593] Starting dynamic subtest: bcs0
[480.720271] Dynamic subtest bcs0: SUCCESS (0.504s)
[480.734409] Starting dynamic subtest: vcs0
[481.227184] Dynamic subtest vcs0: SUCCESS (0.503s)
[481.240704] Starting dynamic subtest: vcs1
[481.733450] Dynamic subtest vcs1: SUCCESS (0.503s)
[481.747553] Starting dynamic subtest: vecs0
[482.240224] Dynamic subtest vecs0: SUCCESS (0.503s)
[482.253525] Starting dynamic subtest: vecs1
[482.746389] Dynamic subtest vecs1: SUCCESS (0.503s)
[482.759786] Starting dynamic subtest: ccs0
[483.252665] Dynamic subtest ccs0: SUCCESS (0.503s)
[483.254388] Subtest idle: SUCCESS (3.619s)
[483.397707] [056/131] (542s left) prime_vgem (coherency-blt)
[483.485974] Starting subtest: coherency-blt
[485.770178] Subtest coherency-blt: SUCCESS (2.284s)
[486.012423] [057/131] (539s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[486.204551] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[486.206224] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[486.416339] [058/131] (539s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[486.603063] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[486.603906] Starting dynamic subtest: pipe-A-valid-mode
[486.990366] Dynamic subtest pipe-A-valid-mode: SKIP (0.386s)
[486.992379] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.388s)
[487.293803] [059/131] (538s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[487.489426] Starting subtest: y-tiled-8bpp-rotate-90
[487.491167] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[487.697228] [060/131] (538s left) i915_pm_rps (reset)
[487.813852] Starting subtest: reset
[492.897126] Subtest reset: SUCCESS (5.080s)
[493.062426] [061/131] (533s left) kms_chamelium_hpd (hdmi-hpd-storm)
[493.339372] Subtest hdmi-hpd-storm: SKIP (0.000s)
[493.494991] [062/131] (532s left) kms_dp_link_training (uhbr-mst)
[493.685761] Starting subtest: uhbr-mst
[493.687447] Subtest uhbr-mst: SKIP (0.000s)
[493.841812] [063/131] (532s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[494.039867] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[499.138477] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (5.099s)
[499.421414] [064/131] (527s left) kms_psr (psr-sprite-plane-onoff)
[499.610450] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[499.699050] [065/131] (526s left) gem_ctx_isolation (preservation-s3)
[499.795407] Starting subtest: preservation-S3
[499.796227] Starting dynamic subtest: rcs0
[519.860887] Dynamic subtest rcs0: SUCCESS (4.166s)
[519.875469] Starting dynamic subtest: bcs0
[539.180284] Dynamic subtest bcs0: SUCCESS (3.916s)
[539.195103] Starting dynamic subtest: vcs0
[558.547296] Dynamic subtest vcs0: SUCCESS (3.973s)
[558.562577] Starting dynamic subtest: vcs1
[577.908221] Dynamic subtest vcs1: SUCCESS (3.948s)
[577.923610] Starting dynamic subtest: vecs0
[597.316165] Dynamic subtest vecs0: SUCCESS (3.940s)
[597.330450] Starting dynamic subtest: vecs1
[616.608142] Dynamic subtest vecs1: SUCCESS (3.923s)
[616.622685] Starting dynamic subtest: ccs0
[635.963566] Dynamic subtest ccs0: SUCCESS (3.906s)
[635.964499] Subtest preservation-S3: SUCCESS (27.779s)
[636.312853] [066/131] (390s left) gem_ctx_persistence (engines-queued)
[636.403645] Starting subtest: engines-queued
[636.404521] Starting dynamic subtest: rcs0
[636.499250] Dynamic subtest rcs0: SUCCESS (0.095s)
[636.514982] Starting dynamic subtest: bcs0
[636.529160] Dynamic subtest bcs0: SUCCESS (0.029s)
[636.544533] Starting dynamic subtest: vcs0
[636.584288] Dynamic subtest vcs0: SUCCESS (0.054s)
[636.599947] Starting dynamic subtest: vcs1
[636.632243] Dynamic subtest vcs1: SUCCESS (0.047s)
[636.647910] Starting dynamic subtest: vecs0
[636.729684] Dynamic subtest vecs0: SUCCESS (0.096s)
[636.778586] Starting dynamic subtest: vecs1
[636.789230] Dynamic subtest vecs1: SUCCESS (0.057s)
[636.805326] Starting dynamic subtest: ccs0
[636.991319] Dynamic subtest ccs0: SUCCESS (0.201s)
[636.992333] Subtest engines-queued: SUCCESS (0.588s)
[637.214268] [067/131] (389s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[637.412566] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[637.414309] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[637.613515] [068/131] (389s left) perf (create-destroy-userspace-config)
[638.052522] Starting subtest: create-destroy-userspace-config
[638.080436] Subtest create-destroy-userspace-config: SUCCESS (0.028s)
[638.144764] [069/131] (388s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[638.353908] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[638.355568] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[638.564328] [070/131] (388s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[638.650575] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[638.724442] [071/131] (388s left) gem_mmap_gtt (big-copy-odd)
[638.805194] Subtest big-copy-odd: SKIP (0.000s)
[638.876040] [072/131] (388s left) kms_vblank (query-idle)
[639.062959] Starting subtest: query-idle
[639.065146] Starting dynamic subtest: pipe-A-DP-3
[641.387508] Dynamic subtest pipe-A-DP-3: SUCCESS (2.322s)
[641.406989] Starting dynamic subtest: pipe-D-DP-3
[643.785618] Dynamic subtest pipe-D-DP-3: SUCCESS (2.393s)
[643.786480] Subtest query-idle: SUCCESS (4.722s)
[644.053170] [073/131] (383s left) kms_cursor_edge_walk (256x256-top-edge)
[644.244258] Starting subtest: 256x256-top-edge
[644.245154] Starting dynamic subtest: pipe-A-DP-3
[647.696342] Dynamic subtest pipe-A-DP-3: SUCCESS (3.450s)
[647.717605] Starting dynamic subtest: pipe-D-DP-3
[651.027692] Dynamic subtest pipe-D-DP-3: SUCCESS (3.330s)
[651.028550] Subtest 256x256-top-edge: SUCCESS (6.784s)
[651.342636] [074/131] (375s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[651.421400] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[651.422339] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[651.592431] [075/131] (375s left) dumb_buffer (create-valid-dumb)
[651.671333] Starting subtest: create-valid-dumb
[651.672240] Subtest create-valid-dumb: SUCCESS (0.000s)
[651.873526] [076/131] (375s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[652.066902] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[652.068602] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[652.277064] [077/131] (375s left) kms_pm_dc (dc5-dpms)
[653.497409] Starting subtest: dc5-dpms
[654.772762] Subtest dc5-dpms: SUCCESS (1.274s)
[654.906931] [078/131] (372s left) perf (per-context-mode-unprivileged)
[655.169065] Starting subtest: per-context-mode-unprivileged
[655.171429] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[655.236617] [079/131] (372s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[655.323382] Starting subtest: invalid-bsd2-flag-on-vebox
[655.324299] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[655.522483] [080/131] (372s left) syncobj_timeline (invalid-transfer-illegal-handle)
[655.600374] Starting subtest: invalid-transfer-illegal-handle
[655.601376] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[655.803461] [081/131] (372s left) kms_flip (2x-flip-vs-fences-interruptible)
[655.998323] Starting subtest: 2x-flip-vs-fences-interruptible
[656.000045] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[656.206855] [082/131] (371s left) kms_atomic (plane-overlay-legacy)
[656.393432] Starting subtest: plane-overlay-legacy
[656.394338] Starting dynamic subtest: pipe-A-DP-3
[657.113008] Dynamic subtest pipe-A-DP-3: SUCCESS (0.719s)
[657.114071] Subtest plane-overlay-legacy: SUCCESS (0.722s)
[657.462939] [083/131] (370s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[657.664544] Starting subtest: 4-tiled-8bpp-rotate-90
[657.726420] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.061s)
[657.968708] [084/131] (370s left) gem_lmem_swapping (verify-random)
[660.887709] Starting subtest: verify-random
[660.888502] Starting dynamic subtest: lmem0
[669.735417] Dynamic subtest lmem0: SUCCESS (8.848s)
[669.736382] Subtest verify-random: SUCCESS (8.849s)
[670.901529] [FACT gem_lmem_swapping (verify-random)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[670.902502] [FACT gem_lmem_swapping (verify-random)] deleted: kernel.kmod_is_loaded.i915: true
[670.904437] [085/131] (357s left) gem_mmap_offset (mmap-unmap)
[672.569348] Starting subtest: mmap-unmap
[672.570083] Starting dynamic subtest: lmem0
[673.530974] Dynamic subtest lmem0: SUCCESS (0.963s)
[673.544845] Starting dynamic subtest: smem0
[674.887678] Dynamic subtest smem0: SUCCESS (1.355s)
[674.890209] Subtest mmap-unmap: SUCCESS (2.322s)
[675.068829] [FACT gem_mmap_offset (mmap-unmap)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[675.071213] [FACT gem_mmap_offset (mmap-unmap)] new: kernel.kmod_is_loaded.i915: true
[675.073869] [086/131] (353s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[675.159223] Subtest flip-primary-invalidate-overlay: SKIP (0.000s)
[675.239080] [087/131] (353s left) kms_plane_multiple (tiling-x)
[675.427827] Starting subtest: tiling-x
[675.430415] Starting dynamic subtest: pipe-A-DP-3
[676.593231] Dynamic subtest pipe-A-DP-3: SUCCESS (1.164s)
[676.609895] Starting dynamic subtest: pipe-B-DP-3
[677.848458] Dynamic subtest pipe-B-DP-3: SUCCESS (1.253s)
[677.881315] Starting dynamic subtest: pipe-C-DP-3
[679.377450] Dynamic subtest pipe-C-DP-3: SUCCESS (1.525s)
[679.391792] Starting dynamic subtest: pipe-D-DP-3
[680.482449] Dynamic subtest pipe-D-DP-3: SUCCESS (1.102s)
[680.483365] Subtest tiling-x: SUCCESS (5.054s)
[680.848156] [088/131] (347s left) gem_exec_flush (basic-batch-kernel-default-uc)
[680.941465] Subtest basic-batch-kernel-default-uc: SKIP (0.000s)
[681.049607] [089/131] (347s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[681.240408] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[681.242064] Subtest psr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[681.447942] [090/131] (347s left) kms_vblank (wait-forked)
[681.639947] Starting subtest: wait-forked
[681.642312] Starting dynamic subtest: pipe-A-DP-3
[684.015557] Dynamic subtest pipe-A-DP-3: SUCCESS (2.372s)
[684.047023] Starting dynamic subtest: pipe-D-DP-3
[686.347601] Dynamic subtest pipe-D-DP-3: SUCCESS (2.320s)
[686.348643] Subtest wait-forked: SUCCESS (4.707s)
[686.661477] [091/131] (341s left) kms_color (ctm-signed)
[686.847768] Starting subtest: ctm-signed
[686.848613] Starting dynamic subtest: pipe-A-DP-3
[688.083140] Dynamic subtest pipe-A-DP-3: SUCCESS (1.233s)
[688.103447] Starting dynamic subtest: pipe-B-DP-3
[689.237730] Dynamic subtest pipe-B-DP-3: SUCCESS (1.153s)
[689.251820] Starting dynamic subtest: pipe-C-DP-3
[690.349363] Dynamic subtest pipe-C-DP-3: SUCCESS (1.111s)
[690.369911] Starting dynamic subtest: pipe-D-DP-3
[691.535629] Dynamic subtest pipe-D-DP-3: SUCCESS (1.184s)
[691.536536] Subtest ctm-signed: SUCCESS (4.688s)
[691.869840] [092/131] (336s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[692.064172] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[692.143935] [093/131] (336s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[692.337148] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[692.338944] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[692.544840] [094/131] (336s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[692.736249] Starting subtest: fbc-rgb101010-draw-mmap-wc
[692.737988] Subtest fbc-rgb101010-draw-mmap-wc: SKIP (0.000s)
[692.944140] [095/131] (336s left) kms_cursor_crc (cursor-random-128x42)
[693.336561] Starting subtest: cursor-random-128x42
[693.341598] Starting dynamic subtest: pipe-A-DP-3
[697.856466] Dynamic subtest pipe-A-DP-3: SUCCESS (4.513s)
[697.908583] Starting dynamic subtest: pipe-D-DP-3
[702.438947] Dynamic subtest pipe-D-DP-3: SUCCESS (4.541s)
[702.439957] Subtest cursor-random-128x42: SUCCESS (9.102s)
[702.912940] [096/131] (326s left) gem_basic (create-fd-close)
[702.995389] Starting subtest: create-fd-close
[702.997163] Subtest create-fd-close: SUCCESS (0.000s)
[703.208746] [097/131] (325s left) gem_bad_reloc (negative-reloc)
[703.298773] Subtest negative-reloc: SKIP (0.000s)
[703.424036] [098/131] (325s left) gem_exec_reloc (basic-write-gtt-noreloc)
[703.508104] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[703.602526] [099/131] (325s left) vgem_basic (dmabuf-mmap)
[703.654522] Starting subtest: dmabuf-mmap
[703.683736] Subtest dmabuf-mmap: SUCCESS (0.029s)
[703.849295] [100/131] (325s left) perf (unprivileged-single-ctx-counters)
[704.278248] Starting subtest: unprivileged-single-ctx-counters
[704.279919] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[704.338462] [101/131] (325s left) gem_mmap_gtt (basic-small-copy)
[704.419243] Subtest basic-small-copy: SKIP (0.000s)
[704.533071] [102/131] (324s left) kms_async_flips (async-flip-suspend-resume)
[704.722428] Starting subtest: async-flip-suspend-resume
[704.957453] Starting dynamic subtest: pipe-A-DP-3
[725.161668] Dynamic subtest pipe-A-DP-3: SUCCESS (4.954s)
[725.364532] Starting dynamic subtest: pipe-B-DP-3
[745.329621] Dynamic subtest pipe-B-DP-3: SUCCESS (4.547s)
[745.508726] Starting dynamic subtest: pipe-C-DP-3
[766.361817] Dynamic subtest pipe-C-DP-3: SUCCESS (4.569s)
[766.532168] Starting dynamic subtest: pipe-D-DP-3
[786.585135] Dynamic subtest pipe-D-DP-3: SUCCESS (4.648s)
[786.586034] Subtest async-flip-suspend-resume: SUCCESS (19.484s)
[787.053506] [103/131] (242s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[787.328377] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[787.485343] [104/131] (242s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[787.681104] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[787.682877] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[787.879585] [105/131] (241s left) i915_query (engine-info-invalid)
[787.966833] Starting subtest: engine-info-invalid
[787.967813] Subtest engine-info-invalid: SUCCESS (0.000s)
[788.175876] [106/131] (241s left) perf (polling-parameterized)
[788.422885] Starting subtest: polling-parameterized
[808.458451] Subtest polling-parameterized: SUCCESS (20.035s)
[808.525282] [107/131] (221s left) api_intel_allocator (fork-simple-once)
[808.605242] Starting subtest: fork-simple-once
[808.647031] Subtest fork-simple-once: SUCCESS (0.042s)
[808.877103] [108/131] (221s left) kms_cursor_crc (cursor-sliding-32x32)
[809.164681] Starting subtest: cursor-sliding-32x32
[809.216866] Subtest cursor-sliding-32x32: SKIP (0.050s)
[809.665891] [109/131] (220s left) gem_mmap_wc (read)
[809.751084] Subtest read: SKIP (0.000s)
[809.828113] [110/131] (220s left) kms_psr (fbc-pr-sprite-render)
[810.018596] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[810.089607] [111/131] (220s left) gem_vm_create (execbuf)
[810.176660] Starting subtest: execbuf
[810.183788] Subtest execbuf: SUCCESS (0.007s)
[810.405940] [112/131] (219s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[810.609703] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[811.641281] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (1.032s)
[811.895761] [113/131] (218s left) gem_render_copy (linear-to-vebox-y-tiled)
[811.983649] Starting subtest: linear-to-vebox-y-tiled
[811.985434] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[812.242228] [114/131] (218s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[812.437241] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[812.489484] [115/131] (217s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[812.678854] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[812.681345] Starting dynamic subtest: pipe-A-DP-3
[812.684815] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[812.697934] Starting dynamic subtest: pipe-B-DP-3
[812.701475] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[812.714356] Starting dynamic subtest: pipe-C-DP-3
[812.717953] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[812.730150] Starting dynamic subtest: pipe-D-DP-3
[812.733549] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[812.735683] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SKIP (0.008s)
[813.173335] [116/131] (217s left) kms_plane_alpha_blend (constant-alpha-max)
[813.361215] Starting subtest: constant-alpha-max
[813.616040] Starting dynamic subtest: pipe-A-DP-3
[814.512386] Dynamic subtest pipe-A-DP-3: SUCCESS (0.896s)
[814.532567] Starting dynamic subtest: pipe-D-DP-3
[815.464636] Dynamic subtest pipe-D-DP-3: SUCCESS (0.950s)
[815.465512] Subtest constant-alpha-max: SUCCESS (2.105s)
[815.792083] [117/131] (214s left) gem_flink_basic (double-flink)
[815.871502] Starting subtest: double-flink
[815.872398] Subtest double-flink: SUCCESS (0.000s)
[816.074901] [118/131] (214s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[816.266210] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[816.267095] Starting dynamic subtest: pipe-A
[816.352280] Dynamic subtest pipe-A: SUCCESS (0.086s)
[816.371365] Starting dynamic subtest: pipe-B
[816.582460] Dynamic subtest pipe-B: SUCCESS (0.228s)
[816.598563] Starting dynamic subtest: pipe-C
[816.778858] Dynamic subtest pipe-C: SUCCESS (0.195s)
[816.802213] Starting dynamic subtest: pipe-D
[816.992034] Dynamic subtest pipe-D: SUCCESS (0.211s)
[816.993124] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SUCCESS (0.728s)
[817.341987] [119/131] (213s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[817.424179] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[817.510736] [120/131] (213s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[817.705365] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[817.707047] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[817.896763] [121/131] (213s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[818.084347] Starting subtest: cursorA-vs-flipA-atomic-transitions
[829.056191] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (10.972s)
[829.387511] [122/131] (201s left) gem_pread (self)
[829.472182] Subtest self: SKIP (0.000s)
[829.546547] [123/131] (201s left) gem_exec_reloc (basic-cpu-wc)
[829.633737] Subtest basic-cpu-wc: SKIP (0.000s)
[829.712987] [124/131] (201s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[829.798543] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[829.902266] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.103s)
[830.089118] [125/131] (201s left) kms_lease (master-vs-lease)
[830.282398] Starting subtest: master-vs-lease
[830.284818] Subtest master-vs-lease: SUCCESS (0.003s)
[830.512098] [126/131] (200s left) gem_exec_balancer (busy)
[830.612256] Starting subtest: busy
[831.526289] Subtest busy: SUCCESS (0.914s)
[831.986353] [127/131] (199s left) gen9_exec_parse (bb-start-param)
[832.074615] Subtest bb-start-param: SKIP (0.000s)
[832.201209] [128/131] (199s left) kms_pm_rpm (i2c)
[833.830711] Starting subtest: i2c
[835.106555] Subtest i2c: SUCCESS (1.276s)
[835.411342] [129/131] (196s left) kms_flip (plain-flip-ts-check)
[835.601341] Starting subtest: plain-flip-ts-check
[835.604752] Starting dynamic subtest: A-DP3
[843.737752] Dynamic subtest A-DP3: SUCCESS (8.133s)
[843.754959] Starting dynamic subtest: B-DP3
[851.816245] Dynamic subtest B-DP3: SUCCESS (8.076s)
[851.833468] Starting dynamic subtest: C-DP3
[859.864905] Dynamic subtest C-DP3: SUCCESS (8.044s)
[859.880114] Starting dynamic subtest: D-DP3
[867.920181] Dynamic subtest D-DP3: SUCCESS (8.053s)
[867.925156] Subtest plain-flip-ts-check: SUCCESS (32.325s)
[868.305454] [130/131] (163s left) gem_exec_params (invalid-ring2)
[868.391275] Starting subtest: invalid-ring2
[868.392270] Subtest invalid-ring2: SUCCESS (0.000s)
[868.599420] [131/131] (163s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[868.791316] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[868.792991] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[868.985713] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: vgem_basic
results: parsing output: 2/ for test: gem_exec_alignment
results: parsing output: 3/ for test: gem_userptr_blits
results: parsing output: 4/ for test: perf_pmu
results: parsing output: 5/ for test: prime_mmap
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_joiner
results: parsing output: 8/ for test: gem_exec_schedule
results: parsing output: 9/ for test: gem_exec_whisper
results: parsing output: 10/ for test: gem_lmem_swapping
results: parsing output: 11/ for test: kms_content_protection
results: parsing output: 12/ for test: gem_exec_schedule
results: parsing output: 13/ for test: kms_chamelium_color
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: syncobj_timeline
results: parsing output: 17/ for test: gem_linear_blits
results: parsing output: 18/ for test: gem_workarounds
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: kms_ccs
results: parsing output: 21/ for test: kms_cursor_legacy
results: parsing output: 22/ for test: kms_psr
results: parsing output: 23/ for test: kms_atomic_transition
results: parsing output: 24/ for test: gem_exec_fence
results: parsing output: 25/ for test: gem_render_copy
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: sysfs_heartbeat_interval
results: parsing output: 29/ for test: sw_sync
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_prime
results: parsing output: 33/ for test: kms_ccs
results: parsing output: 34/ for test: kms_feature_discovery
results: parsing output: 35/ for test: gem_create
results: parsing output: 36/ for test: prime_mmap
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_flip_scaled_crc
results: parsing output: 39/ for test: gem_softpin
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_psr
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_setmode
results: parsing output: 45/ for test: api_intel_bb
results: parsing output: 46/ for test: kms_flip
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gem_partial_pwrite_pread
results: parsing output: 49/ for test: gem_exec_schedule
results: parsing output: 50/ for test: i915_hangman
results: parsing output: 51/ for test: gem_exec_fence
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: i915_drm_fdinfo
results: parsing output: 55/ for test: prime_vgem
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_flip_scaled_crc
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: i915_pm_rps
results: parsing output: 60/ for test: kms_chamelium_hpd
results: parsing output: 61/ for test: kms_dp_link_training
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_psr
results: parsing output: 64/ for test: gem_ctx_isolation
results: parsing output: 65/ for test: gem_ctx_persistence
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: perf
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: gem_fenced_exec_thrash
results: parsing output: 70/ for test: gem_mmap_gtt
results: parsing output: 71/ for test: kms_vblank
results: parsing output: 72/ for test: kms_cursor_edge_walk
results: parsing output: 73/ for test: syncobj_wait
results: parsing output: 74/ for test: dumb_buffer
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_pm_dc
results: parsing output: 77/ for test: perf
results: parsing output: 78/ for test: gem_exec_params
results: parsing output: 79/ for test: syncobj_timeline
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: kms_atomic
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: gem_lmem_swapping
results: parsing output: 84/ for test: gem_mmap_offset
results: parsing output: 85/ for test: kms_psr_stress_test
results: parsing output: 86/ for test: kms_plane_multiple
results: parsing output: 87/ for test: gem_exec_flush
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_vblank
results: parsing output: 90/ for test: kms_color
results: parsing output: 91/ for test: kms_psr2_sf
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_cursor_crc
results: parsing output: 95/ for test: gem_basic
results: parsing output: 96/ for test: gem_bad_reloc
results: parsing output: 97/ for test: gem_exec_reloc
results: parsing output: 98/ for test: vgem_basic
results: parsing output: 99/ for test: perf
results: parsing output: 100/ for test: gem_mmap_gtt
results: parsing output: 101/ for test: kms_async_flips
results: parsing output: 102/ for test: kms_chamelium_edid
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: i915_query
results: parsing output: 105/ for test: perf
results: parsing output: 106/ for test: api_intel_allocator
results: parsing output: 107/ for test: kms_cursor_crc
results: parsing output: 108/ for test: gem_mmap_wc
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: gem_vm_create
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: gem_render_copy
results: parsing output: 113/ for test: kms_psr2_sf
results: parsing output: 114/ for test: kms_ccs
results: parsing output: 115/ for test: kms_plane_alpha_blend
results: parsing output: 116/ for test: gem_flink_basic
results: parsing output: 117/ for test: kms_plane_scaling
results: parsing output: 118/ for test: kms_pipe_b_c_ivb
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_cursor_legacy
results: parsing output: 121/ for test: gem_pread
results: parsing output: 122/ for test: gem_exec_reloc
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: kms_lease
results: parsing output: 125/ for test: gem_exec_balancer
results: parsing output: 126/ for test: gen9_exec_parse
results: parsing output: 127/ for test: kms_pm_rpm
results: parsing output: 128/ for test: kms_flip
results: parsing output: 129/ for test: gem_exec_params
results: parsing output: 130/ for test: kms_frontbuffer_tracking
Done.