[63.570252] Initializing watchdogs
[63.570325]   /dev/watchdog0
[63.590912] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[63.601971] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[63.605990] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.608171] [001/131] (960s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[65.115137] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.000s)
[65.161537] [002/131] (958s left) vgem_basic (create)
[65.276015] Starting subtest: create
[65.276988] Subtest create: SUCCESS (0.000s)
[65.425886] [FACT vgem_basic (create)] new: kernel.kmod_is_loaded.vgem: true
[65.427534] [003/131] (958s left) gem_exec_alignment (many)
[65.521814] Starting subtest: many
[93.795363] Subtest many: SUCCESS (28.273s)
[94.550790] [004/131] (929s left) gem_userptr_blits (create-destroy-sync)
[94.694937] Starting subtest: create-destroy-sync
[99.707172] Subtest create-destroy-sync: SUCCESS (5.012s)
[99.928542] [005/131] (924s left) perf_pmu (busy-double-start)
[100.000506] Starting subtest: busy-double-start
[100.001443] Starting dynamic subtest: rcs0
[103.627257] Dynamic subtest rcs0: SUCCESS (3.626s)
[103.639067] Starting dynamic subtest: bcs0
[107.220224] Dynamic subtest bcs0: SUCCESS (3.592s)
[107.230578] Starting dynamic subtest: vcs0
[110.823366] Dynamic subtest vcs0: FAIL (3.581s)
[110.833107] Starting dynamic subtest: vcs1
[114.391380] Dynamic subtest vcs1: FAIL (3.565s)
[114.401894] Starting dynamic subtest: vecs0
[117.955387] Dynamic subtest vecs0: FAIL (3.563s)
[117.965856] Starting dynamic subtest: vecs1
[121.520065] Dynamic subtest vecs1: FAIL (3.565s)
[121.530486] Starting dynamic subtest: ccs0
[125.098170] Dynamic subtest ccs0: SUCCESS (3.601s)
[125.099932] Subtest busy-double-start: FAIL (25.098s)
[125.287789] [006/131] (899s left) prime_mmap (test_aperture_limit)
[125.369713] Starting subtest: test_aperture_limit
[125.370568] Starting dynamic subtest: test_aperture_limit-smem
[125.386231] Dynamic subtest test_aperture_limit-smem: SKIP (0.015s)
[125.388008] Subtest test_aperture_limit: SKIP (0.016s)
[125.550608] [007/131] (898s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[127.071723] Starting subtest: psr-farfromfence-mmap-gtt
[127.073421] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[127.299625] [008/131] (897s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[128.816046] Starting subtest: invalid-modeset-force-ultra-joiner
[128.817702] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[128.983496] [009/131] (895s left) gem_exec_schedule (pi-distinct-iova)
[129.222474] Starting subtest: pi-distinct-iova
[129.223400] Starting dynamic subtest: rcs0
[129.479138] Dynamic subtest rcs0: SUCCESS (0.257s)
[129.487525] Starting dynamic subtest: bcs0
[129.653983] Dynamic subtest bcs0: SUCCESS (0.175s)
[129.662495] Starting dynamic subtest: vcs0
[129.840386] Dynamic subtest vcs0: SUCCESS (0.186s)
[129.848679] Starting dynamic subtest: vcs1
[130.028655] Dynamic subtest vcs1: SUCCESS (0.188s)
[130.037203] Starting dynamic subtest: vecs0
[130.214749] Dynamic subtest vecs0: SUCCESS (0.186s)
[130.223329] Starting dynamic subtest: vecs1
[130.402037] Dynamic subtest vecs1: SUCCESS (0.187s)
[130.410649] Starting dynamic subtest: ccs0
[130.587888] Dynamic subtest ccs0: SUCCESS (0.186s)
[130.588853] Subtest pi-distinct-iova: SUCCESS (1.366s)
[131.003997] [010/131] (893s left) gem_exec_whisper (basic-fds-forked)
[131.092984] Starting subtest: basic-fds-forked
[153.966768] Subtest basic-fds-forked: SUCCESS (22.872s)
[154.207935] [011/131] (870s left) gem_lmem_swapping (parallel-random)
[158.785953] Starting subtest: parallel-random
[158.787234] Starting dynamic subtest: lmem0
[200.003091] Dynamic subtest lmem0: SUCCESS (41.215s)
[200.004817] Subtest parallel-random: SUCCESS (41.216s)
[201.040473] [FACT gem_lmem_swapping (parallel-random)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[201.041399] [FACT gem_lmem_swapping (parallel-random)] deleted: kernel.kmod_is_loaded.i915: true
[201.042892] [012/131] (823s left) kms_content_protection (atomic-dpms-hdcp14)
[206.031637] Starting subtest: atomic-dpms-hdcp14
[206.038753] Subtest atomic-dpms-hdcp14: SKIP (0.005s)
[206.160847] [FACT kms_content_protection (atomic-dpms-hdcp14)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[206.164300] [FACT kms_content_protection (atomic-dpms-hdcp14)] new: kernel.kmod_is_loaded.i915: true
[206.166722] [013/131] (818s left) gem_exec_schedule (fifo)
[206.270624] Starting subtest: fifo
[206.271506] Starting dynamic subtest: rcs0
[206.580148] Dynamic subtest rcs0: SUCCESS (0.309s)
[206.589393] Starting dynamic subtest: bcs0
[206.788515] Dynamic subtest bcs0: SUCCESS (0.198s)
[206.797556] Starting dynamic subtest: vcs0
[206.999457] Dynamic subtest vcs0: SUCCESS (0.210s)
[207.009776] Starting dynamic subtest: vcs1
[207.203552] Dynamic subtest vcs1: SUCCESS (0.214s)
[207.212567] Starting dynamic subtest: vecs0
[207.412223] Dynamic subtest vecs0: SUCCESS (0.208s)
[207.421429] Starting dynamic subtest: vecs1
[207.626741] Dynamic subtest vecs1: SUCCESS (0.214s)
[207.636075] Starting dynamic subtest: ccs0
[207.836937] Dynamic subtest ccs0: SUCCESS (0.210s)
[207.837855] Subtest fifo: SUCCESS (1.566s)
[208.250919] [014/131] (816s left) kms_chamelium_color (ctm-0-25)
[209.763876] Subtest ctm-0-25: SKIP (0.000s)
[209.826008] [015/131] (815s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[211.358943] Starting subtest: x-tiled-32bpp-rotate-180
[213.267833] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.909s)
[213.516255] [016/131] (811s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[215.041208] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[216.133384] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (1.092s)
[216.354311] [017/131] (808s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[216.433274] Starting subtest: invalid-signal-one-illegal-handle
[216.434215] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[216.630103] [018/131] (808s left) gem_linear_blits (interruptible)
[216.843360] Starting subtest: interruptible
[224.198636] Subtest interruptible: SUCCESS (7.355s)
[224.450093] [019/131] (800s left) gem_workarounds (reset-context)
[224.601255] Starting subtest: reset-context
[224.826299] Subtest reset-context: SUCCESS (0.225s)
[224.994338] [020/131] (800s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc)
[226.508172] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc
[226.509046] Starting dynamic subtest: pipe-A-HDMI-A-3
[226.517320] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[226.527371] Starting dynamic subtest: pipe-B-HDMI-A-3
[226.535811] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[226.546009] Starting dynamic subtest: pipe-C-HDMI-A-3
[226.554158] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[226.564167] Starting dynamic subtest: pipe-D-HDMI-A-3
[226.573249] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[226.574959] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[226.825481] [021/131] (798s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[228.337988] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[228.338949] Starting dynamic subtest: pipe-A-HDMI-A-3
[228.347381] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[228.357510] Starting dynamic subtest: pipe-B-HDMI-A-3
[228.366174] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[228.375965] Starting dynamic subtest: pipe-C-HDMI-A-3
[228.384260] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[228.394234] Starting dynamic subtest: pipe-D-HDMI-A-3
[228.403895] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[228.405574] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SKIP (0.004s)
[228.634101] [022/131] (796s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[230.157133] Starting subtest: short-flip-after-cursor-toggle
[231.170489] Subtest short-flip-after-cursor-toggle: SUCCESS (1.013s)
[231.424654] [023/131] (794s left) kms_psr (fbc-psr2-primary-render)
[232.937608] Subtest fbc-psr2-primary-render: SKIP (0.000s)
[232.989463] [024/131] (792s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[234.510280] Starting subtest: plane-primary-toggle-with-vblank-wait
[234.511168] Starting dynamic subtest: pipe-A-HDMI-A-3
[234.728845] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.218s)
[234.854540] Starting dynamic subtest: pipe-B-HDMI-A-3
[235.114998] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.296s)
[235.187967] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (0.678s)
[235.411599] [025/131] (790s left) gem_exec_fence (submit-chain)
[235.623781] Starting subtest: submit-chain
[235.696978] Subtest submit-chain: SUCCESS (0.073s)
[236.466682] [026/131] (789s left) gem_render_copy (y-tiled-to-vebox-linear)
[236.554448] Starting subtest: y-tiled-to-vebox-linear
[236.556556] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[236.801180] [027/131] (789s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[238.317868] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[238.319550] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[238.550052] [028/131] (787s left) syncobj_timeline (single-wait-available-submitted)
[238.630187] Starting subtest: single-wait-available-submitted
[238.631177] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[238.814563] [029/131] (787s left) sysfs_heartbeat_interval (nopreempt)
[238.901297] Starting subtest: nopreempt
[238.902210] Starting dynamic subtest: vecs0
[243.244223] Dynamic subtest vecs0: SUCCESS (4.342s)
[243.256108] Starting dynamic subtest: ccs0
[247.509498] Dynamic subtest ccs0: SUCCESS (4.265s)
[247.519750] Starting dynamic subtest: vcs0
[251.731233] Dynamic subtest vcs0: SUCCESS (4.221s)
[251.741682] Starting dynamic subtest: bcs0
[255.912184] Dynamic subtest bcs0: SUCCESS (4.180s)
[255.922456] Starting dynamic subtest: vecs1
[260.112386] Dynamic subtest vecs1: SUCCESS (4.200s)
[260.122577] Starting dynamic subtest: rcs0
[264.419259] Dynamic subtest rcs0: SUCCESS (4.306s)
[264.429896] Starting dynamic subtest: vcs1
[268.620341] Dynamic subtest vcs1: SUCCESS (4.200s)
[268.621400] Subtest nopreempt: SUCCESS (29.719s)
[268.799596] [030/131] (757s left) sw_sync (sync_busy_fork)
[268.848485] Starting subtest: sync_busy_fork
[269.861057] Subtest sync_busy_fork: SUCCESS (1.012s)
[269.972861] [031/131] (756s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[271.492546] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[271.494229] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[271.712931] [032/131] (754s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[273.231541] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[273.233239] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[273.434177] [033/131] (753s left) kms_prime (basic-modeset-hybrid)
[274.957266] Subtest basic-modeset-hybrid: SKIP (0.000s)
[275.171928] [034/131] (751s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[276.713433] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[276.714326] Starting dynamic subtest: pipe-A-HDMI-A-3
[276.722839] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s)
[276.733439] Starting dynamic subtest: pipe-B-HDMI-A-3
[276.741818] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s)
[276.752245] Starting dynamic subtest: pipe-C-HDMI-A-3
[276.760420] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s)
[276.771068] Starting dynamic subtest: pipe-D-HDMI-A-3
[276.779487] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s)
[276.781386] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.007s)
[277.004014] [035/131] (749s left) kms_feature_discovery (display)
[278.539173] Starting subtest: display
[278.540064] Subtest display: SUCCESS (0.000s)
[278.714666] [036/131] (748s left) gem_create (create-ext-placement-all)
[278.930251] Starting subtest: create-ext-placement-all
[278.931446] Subtest create-ext-placement-all: SUCCESS (0.000s)
[279.112801] [037/131] (747s left) prime_mmap (test_reprime)
[279.194863] Starting subtest: test_reprime
[279.195771] Starting dynamic subtest: test_reprime-smem
[279.241127] Dynamic subtest test_reprime-smem: SUCCESS (0.046s)
[279.251384] Starting dynamic subtest: test_reprime-lmem0
[279.430374] Dynamic subtest test_reprime-lmem0: SUCCESS (0.188s)
[279.431447] Subtest test_reprime: SUCCESS (0.236s)
[279.631708] [038/131] (747s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[281.145218] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[281.146967] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[281.354332] [039/131] (745s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[282.874517] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[282.875407] Starting dynamic subtest: pipe-A-valid-mode
[282.973459] Dynamic subtest pipe-A-valid-mode: SKIP (0.098s)
[282.975998] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.099s)
[283.229405] [040/131] (743s left) gem_softpin (full)
[283.314693] Starting subtest: full
[283.331297] Subtest full: SUCCESS (0.016s)
[283.545666] [041/131] (743s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[285.063162] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[285.064908] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[285.303374] [042/131] (742s left) kms_psr (psr2-sprite-blt)
[286.814271] Subtest psr2-sprite-blt: SKIP (0.000s)
[286.878007] [043/131] (740s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[288.400737] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[291.734453] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (3.334s)
[291.983862] [044/131] (735s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[293.501889] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[293.503506] Subtest psr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[293.730341] [045/131] (733s left) kms_setmode (invalid-clone-single-crtc-stealing)
[293.809255] Starting subtest: invalid-clone-single-crtc-stealing
[293.811977] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[294.012776] [046/131] (733s left) api_intel_bb (crc32)
[294.098376] Starting subtest: crc32
[294.099309] Starting dynamic subtest: rcs0-lmem0
[294.353744] Dynamic subtest rcs0-lmem0: SUCCESS (0.254s)
[294.368834] Starting dynamic subtest: rcs0-smem0
[294.674102] Dynamic subtest rcs0-smem0: SUCCESS (0.318s)
[294.689374] Starting dynamic subtest: bcs0-lmem0
[294.913982] Dynamic subtest bcs0-lmem0: SUCCESS (0.237s)
[294.928564] Starting dynamic subtest: bcs0-smem0
[295.246343] Dynamic subtest bcs0-smem0: SUCCESS (0.330s)
[295.259987] Starting dynamic subtest: vcs0-lmem0
[295.665101] Dynamic subtest vcs0-lmem0: SUCCESS (0.416s)
[295.678507] Starting dynamic subtest: vcs0-smem0
[296.215635] Dynamic subtest vcs0-smem0: SUCCESS (0.548s)
[296.228469] Starting dynamic subtest: vcs1-lmem0
[296.640895] Dynamic subtest vcs1-lmem0: SUCCESS (0.423s)
[296.655815] Starting dynamic subtest: vcs1-smem0
[297.192104] Dynamic subtest vcs1-smem0: SUCCESS (0.549s)
[297.205980] Starting dynamic subtest: vecs0-lmem0
[297.621641] Dynamic subtest vecs0-lmem0: SUCCESS (0.427s)
[297.636628] Starting dynamic subtest: vecs0-smem0
[298.175193] Dynamic subtest vecs0-smem0: SUCCESS (0.551s)
[298.188918] Starting dynamic subtest: vecs1-lmem0
[298.608305] Dynamic subtest vecs1-lmem0: SUCCESS (0.431s)
[298.622402] Starting dynamic subtest: vecs1-smem0
[299.146719] Dynamic subtest vecs1-smem0: SUCCESS (0.536s)
[299.162054] Starting dynamic subtest: ccs0-lmem0
[299.398606] Dynamic subtest ccs0-lmem0: SUCCESS (0.249s)
[299.413999] Starting dynamic subtest: ccs0-smem0
[299.743528] Dynamic subtest ccs0-smem0: SUCCESS (0.342s)
[299.745378] Subtest crc32: SUCCESS (5.646s)
[299.918862] [047/131] (727s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[301.434192] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[301.447652] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.013s)
[301.642473] [048/131] (726s left) kms_frontbuffer_tracking (basic)
[303.167052] Starting subtest: basic
[305.901703] Subtest basic: SUCCESS (2.735s)
[306.157612] [049/131] (721s left) gem_partial_pwrite_pread (write)
[306.242837] Subtest write: SKIP (0.000s)
[306.312696] [050/131] (721s left) gem_exec_schedule (u-fairslice)
[306.405078] Starting subtest: u-fairslice
[306.406036] Starting dynamic subtest: rcs0
[308.455419] Dynamic subtest rcs0: SUCCESS (2.049s)
[308.466551] Starting dynamic subtest: bcs0
[310.476323] Dynamic subtest bcs0: SUCCESS (2.020s)
[310.487141] Starting dynamic subtest: vcs0
[312.497043] Dynamic subtest vcs0: SUCCESS (2.020s)
[312.507808] Starting dynamic subtest: vcs1
[314.515389] Dynamic subtest vcs1: SUCCESS (2.018s)
[314.528446] Starting dynamic subtest: vecs0
[316.537934] Dynamic subtest vecs0: SUCCESS (2.022s)
[316.548580] Starting dynamic subtest: vecs1
[318.557662] Dynamic subtest vecs1: SUCCESS (2.019s)
[318.568631] Starting dynamic subtest: ccs0
[320.577966] Dynamic subtest ccs0: SUCCESS (2.020s)
[320.578931] Subtest u-fairslice: SUCCESS (14.172s)
[320.985232] [051/131] (707s left) i915_hangman (gt-error-state-capture)
[321.084293] Starting subtest: gt-error-state-capture
[321.085179] Starting dynamic subtest: rcs0
[331.093338] Dynamic subtest rcs0: SUCCESS (10.009s)
[331.104061] Starting dynamic subtest: bcs0
[341.049581] Dynamic subtest bcs0: SUCCESS (9.956s)
[341.060553] Starting dynamic subtest: vcs0
[351.141757] Dynamic subtest vcs0: SUCCESS (10.091s)
[351.155202] Starting dynamic subtest: vcs1
[361.105805] Dynamic subtest vcs1: SUCCESS (9.963s)
[361.125979] Starting dynamic subtest: vecs0
[371.068385] Dynamic subtest vecs0: SUCCESS (9.962s)
[371.079167] Starting dynamic subtest: vecs1
[381.144515] Dynamic subtest vecs1: SUCCESS (10.075s)
[381.157222] Starting dynamic subtest: ccs0
[391.147730] Dynamic subtest ccs0: SUCCESS (10.002s)
[391.148906] Subtest gt-error-state-capture: SUCCESS (70.064s)
[391.351072] [052/131] (636s left) gem_exec_fence (basic-wait)
[391.583085] Starting subtest: basic-wait
[391.584505] Starting dynamic subtest: rcs0
[391.710869] Dynamic subtest rcs0: SUCCESS (0.128s)
[391.756825] Starting dynamic subtest: bcs0
[391.770733] Dynamic subtest bcs0: SUCCESS (0.058s)
[391.787819] Starting dynamic subtest: vcs0
[391.827263] Dynamic subtest vcs0: SUCCESS (0.056s)
[391.845849] Starting dynamic subtest: vcs1
[391.881544] Dynamic subtest vcs1: SUCCESS (0.053s)
[391.916080] Starting dynamic subtest: vecs0
[391.938725] Dynamic subtest vecs0: SUCCESS (0.056s)
[391.960552] Starting dynamic subtest: vecs1
[391.993865] Dynamic subtest vecs1: SUCCESS (0.054s)
[392.018124] Starting dynamic subtest: ccs0
[392.048682] Dynamic subtest ccs0: SUCCESS (0.053s)
[392.049965] Subtest basic-wait: SUCCESS (0.469s)
[392.765531] [053/131] (635s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[394.282965] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[394.284713] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[394.518213] [054/131] (633s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[396.041292] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[396.043181] Subtest fbcpsr-rgb565-draw-mmap-wc: SKIP (0.000s)
[396.259684] [055/131] (632s left) i915_drm_fdinfo (idle)
[396.333984] Starting subtest: idle
[396.335005] Starting dynamic subtest: rcs0
[396.940483] Dynamic subtest rcs0: SUCCESS (0.606s)
[396.954485] Starting dynamic subtest: bcs0
[397.446395] Dynamic subtest bcs0: SUCCESS (0.504s)
[397.459229] Starting dynamic subtest: vcs0
[397.950792] Dynamic subtest vcs0: SUCCESS (0.502s)
[397.964138] Starting dynamic subtest: vcs1
[398.455829] Dynamic subtest vcs1: SUCCESS (0.503s)
[398.468886] Starting dynamic subtest: vecs0
[398.962150] Dynamic subtest vecs0: SUCCESS (0.504s)
[398.974708] Starting dynamic subtest: vecs1
[399.468199] Dynamic subtest vecs1: SUCCESS (0.503s)
[399.481149] Starting dynamic subtest: ccs0
[399.974068] Dynamic subtest ccs0: SUCCESS (0.503s)
[399.975805] Subtest idle: SUCCESS (3.640s)
[400.105980] [056/131] (628s left) prime_vgem (coherency-blt)
[400.208582] Starting subtest: coherency-blt
[402.524360] Subtest coherency-blt: SUCCESS (2.315s)
[402.703588] [057/131] (625s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[404.225217] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[404.226940] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[404.448240] [058/131] (624s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[405.962472] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[405.963304] Starting dynamic subtest: pipe-A-valid-mode
[406.226231] Dynamic subtest pipe-A-valid-mode: SKIP (0.263s)
[406.228981] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.264s)
[406.500407] [059/131] (622s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[408.022628] Starting subtest: y-tiled-8bpp-rotate-90
[408.024477] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[408.250700] [060/131] (620s left) i915_pm_rps (reset)
[408.343968] Starting subtest: reset
[413.161852] Subtest reset: SUCCESS (4.818s)
[413.369294] [061/131] (615s left) kms_chamelium_hpd (hdmi-hpd-storm)
[414.932232] Subtest hdmi-hpd-storm: SKIP (0.000s)
[415.033813] [062/131] (614s left) kms_dp_link_training (uhbr-mst)
[416.554484] Starting subtest: uhbr-mst
[416.556167] Subtest uhbr-mst: SKIP (0.000s)
[416.719299] [063/131] (612s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[418.255138] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[423.248439] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.993s)
[423.496917] [064/131] (605s left) kms_psr (psr-sprite-plane-onoff)
[425.008238] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[425.076201] [065/131] (604s left) gem_ctx_isolation (preservation-s3)
[425.168532] Starting subtest: preservation-S3
[425.169479] Starting dynamic subtest: rcs0
[444.685398] Dynamic subtest rcs0: SUCCESS (4.197s)
[444.697788] Starting dynamic subtest: bcs0
[464.627027] Dynamic subtest bcs0: SUCCESS (3.834s)
[464.639370] Starting dynamic subtest: vcs0
[484.635813] Dynamic subtest vcs0: SUCCESS (3.838s)
[484.649251] Starting dynamic subtest: vcs1
[504.632671] Dynamic subtest vcs1: SUCCESS (3.763s)
[504.646131] Starting dynamic subtest: vecs0
[524.645781] Dynamic subtest vecs0: SUCCESS (3.893s)
[524.658433] Starting dynamic subtest: vecs1
[544.636873] Dynamic subtest vecs1: SUCCESS (4.243s)
[544.649961] Starting dynamic subtest: ccs0
[564.613587] Dynamic subtest ccs0: SUCCESS (3.776s)
[564.614455] Subtest preservation-S3: SUCCESS (27.549s)
[570.971872] [066/131] (464s left) gem_ctx_persistence (engines-queued)
[571.062811] Starting subtest: engines-queued
[571.063679] Starting dynamic subtest: rcs0
[571.176841] Dynamic subtest rcs0: SUCCESS (0.110s)
[571.191363] Starting dynamic subtest: bcs0
[571.235679] Dynamic subtest bcs0: SUCCESS (0.056s)
[571.261249] Starting dynamic subtest: vcs0
[571.273784] Dynamic subtest vcs0: SUCCESS (0.036s)
[571.298706] Starting dynamic subtest: vcs1
[571.359780] Dynamic subtest vcs1: SUCCESS (0.082s)
[571.377390] Starting dynamic subtest: vecs0
[571.429662] Dynamic subtest vecs0: SUCCESS (0.066s)
[571.463749] Starting dynamic subtest: vecs1
[571.503058] Dynamic subtest vecs1: SUCCESS (0.069s)
[571.544007] Starting dynamic subtest: ccs0
[571.719521] Dynamic subtest ccs0: SUCCESS (0.208s)
[571.720540] Subtest engines-queued: SUCCESS (0.636s)
[571.960935] [067/131] (463s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[574.197728] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[574.199631] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[574.421967] [068/131] (461s left) perf (create-destroy-userspace-config)
[574.874456] Starting subtest: create-destroy-userspace-config
[574.902347] Subtest create-destroy-userspace-config: SUCCESS (0.028s)
[574.960545] [069/131] (460s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[576.511740] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[576.513584] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[576.757417] [070/131] (458s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[576.848361] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[576.927192] [071/131] (458s left) gem_mmap_gtt (big-copy-odd)
[577.009256] Subtest big-copy-odd: SKIP (0.000s)
[577.079951] [072/131] (458s left) kms_vblank (query-idle)
[578.615098] Starting subtest: query-idle
[578.615978] Starting dynamic subtest: pipe-A-HDMI-A-3
[580.902661] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.261s)
[580.918695] Starting dynamic subtest: pipe-D-HDMI-A-3
[583.088616] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.163s)
[583.089731] Subtest query-idle: SUCCESS (4.429s)
[583.276903] [073/131] (452s left) kms_cursor_edge_walk (256x256-top-edge)
[584.801174] Starting subtest: 256x256-top-edge
[584.802091] Starting dynamic subtest: pipe-A-HDMI-A-3
[588.155631] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (3.337s)
[588.171348] Starting dynamic subtest: pipe-D-HDMI-A-3
[591.397749] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (3.230s)
[591.398818] Subtest 256x256-top-edge: SUCCESS (6.570s)
[591.651353] [074/131] (444s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[591.728814] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[591.729704] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[591.925244] [075/131] (444s left) dumb_buffer (create-valid-dumb)
[592.012377] Starting subtest: create-valid-dumb
[592.013642] Subtest create-valid-dumb: SUCCESS (0.000s)
[592.239524] [076/131] (443s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[593.754997] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[593.756578] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[593.984318] [077/131] (442s left) kms_pm_dc (dc5-dpms)
[596.511270] Starting subtest: dc5-dpms
[597.708084] Subtest dc5-dpms: SUCCESS (1.194s)
[597.854191] [078/131] (438s left) perf (per-context-mode-unprivileged)
[598.128769] Starting subtest: per-context-mode-unprivileged
[598.130516] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[598.187106] [079/131] (438s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[598.272893] Starting subtest: invalid-bsd2-flag-on-vebox
[598.273752] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[598.470036] [080/131] (438s left) syncobj_timeline (invalid-transfer-illegal-handle)
[598.547624] Starting subtest: invalid-transfer-illegal-handle
[598.548533] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[598.755967] [081/131] (437s left) kms_flip (2x-flip-vs-fences-interruptible)
[600.270417] Starting subtest: 2x-flip-vs-fences-interruptible
[600.272295] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[600.506895] [082/131] (436s left) kms_atomic (plane-overlay-legacy)
[602.027357] Starting subtest: plane-overlay-legacy
[602.028261] Starting dynamic subtest: pipe-A-HDMI-A-3
[602.683752] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.654s)
[602.684676] Subtest plane-overlay-legacy: SUCCESS (0.656s)
[602.942631] [083/131] (433s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[604.467665] Starting subtest: 4-tiled-8bpp-rotate-90
[604.515494] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.048s)
[604.744040] [084/131] (432s left) gem_lmem_swapping (verify-random)
[609.315156] Starting subtest: verify-random
[609.315887] Starting dynamic subtest: lmem0
[617.321978] Dynamic subtest lmem0: SUCCESS (8.005s)
[617.322812] Subtest verify-random: SUCCESS (8.006s)
[618.321094] [FACT gem_lmem_swapping (verify-random)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[618.322435] [FACT gem_lmem_swapping (verify-random)] deleted: kernel.kmod_is_loaded.i915: true
[618.324753] [085/131] (418s left) gem_mmap_offset (mmap-unmap)
[621.800235] Starting subtest: mmap-unmap
[621.801043] Starting dynamic subtest: lmem0
[622.734251] Dynamic subtest lmem0: SUCCESS (0.938s)
[622.746283] Starting dynamic subtest: smem0
[624.125981] Dynamic subtest smem0: SUCCESS (1.390s)
[624.126830] Subtest mmap-unmap: SUCCESS (2.330s)
[624.272087] [FACT gem_mmap_offset (mmap-unmap)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[624.275018] [FACT gem_mmap_offset (mmap-unmap)] new: kernel.kmod_is_loaded.i915: true
[624.277634] [086/131] (412s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[624.357523] Subtest flip-primary-invalidate-overlay: SKIP (0.000s)
[624.474070] [087/131] (412s left) kms_plane_multiple (tiling-x)
[625.990455] Starting subtest: tiling-x
[625.991148] Starting dynamic subtest: pipe-A-HDMI-A-3
[626.716963] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.726s)
[626.766387] Starting dynamic subtest: pipe-B-HDMI-A-3
[627.469033] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.746s)
[627.481401] Starting dynamic subtest: pipe-C-HDMI-A-3
[628.171193] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.700s)
[628.185614] Starting dynamic subtest: pipe-D-HDMI-A-3
[628.796976] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.623s)
[628.797657] Subtest tiling-x: SUCCESS (2.807s)
[629.020552] [088/131] (408s left) gem_exec_flush (basic-batch-kernel-default-uc)
[629.118009] Subtest basic-batch-kernel-default-uc: SKIP (0.000s)
[629.205336] [089/131] (408s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[630.724109] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[630.725694] Subtest psr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[630.954821] [090/131] (406s left) kms_vblank (wait-forked)
[632.472392] Starting subtest: wait-forked
[632.473307] Starting dynamic subtest: pipe-A-HDMI-A-3
[634.828796] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.354s)
[634.847186] Starting dynamic subtest: pipe-D-HDMI-A-3
[637.069704] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.235s)
[637.070574] Subtest wait-forked: SUCCESS (4.597s)
[637.303629] [091/131] (400s left) kms_color (ctm-signed)
[638.819679] Starting subtest: ctm-signed
[638.820679] Starting dynamic subtest: pipe-A-HDMI-A-3
[639.976623] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (1.156s)
[639.989471] Starting dynamic subtest: pipe-B-HDMI-A-3
[640.923113] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.945s)
[640.935405] Starting dynamic subtest: pipe-C-HDMI-A-3
[641.874114] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.949s)
[641.886393] Starting dynamic subtest: pipe-D-HDMI-A-3
[642.792848] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.917s)
[642.793675] Subtest ctm-signed: SUCCESS (3.973s)
[643.041242] [092/131] (394s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[644.562042] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[644.618086] [093/131] (392s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[646.136220] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[646.138040] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[646.387737] [094/131] (391s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[647.905201] Starting subtest: fbc-rgb101010-draw-mmap-wc
[647.906959] Subtest fbc-rgb101010-draw-mmap-wc: SKIP (0.000s)
[648.147405] [095/131] (389s left) kms_cursor_crc (cursor-random-128x42)
[649.870138] Starting subtest: cursor-random-128x42
[649.875263] Starting dynamic subtest: pipe-A-HDMI-A-3
[654.300191] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (4.423s)
[654.338916] Starting dynamic subtest: pipe-D-HDMI-A-3
[658.676648] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (4.348s)
[658.677513] Subtest cursor-random-128x42: SUCCESS (8.803s)
[659.076798] [096/131] (378s left) gem_basic (create-fd-close)
[659.161913] Starting subtest: create-fd-close
[659.163849] Subtest create-fd-close: SUCCESS (0.000s)
[659.358803] [097/131] (378s left) gem_bad_reloc (negative-reloc)
[659.446627] Subtest negative-reloc: SKIP (0.000s)
[659.552051] [098/131] (378s left) gem_exec_reloc (basic-write-gtt-noreloc)
[659.639621] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[659.752810] [099/131] (378s left) vgem_basic (dmabuf-mmap)
[659.806539] Starting subtest: dmabuf-mmap
[659.836229] Subtest dmabuf-mmap: SUCCESS (0.030s)
[660.001813] [100/131] (378s left) perf (unprivileged-single-ctx-counters)
[660.400667] Starting subtest: unprivileged-single-ctx-counters
[660.402365] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[660.455518] [101/131] (377s left) gem_mmap_gtt (basic-small-copy)
[660.541653] Subtest basic-small-copy: SKIP (0.000s)
[660.605915] [102/131] (377s left) kms_async_flips (async-flip-suspend-resume)
[662.117278] Starting subtest: async-flip-suspend-resume
[662.349657] Starting dynamic subtest: pipe-A-HDMI-A-3
[682.452989] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (4.886s)
[682.619955] Starting dynamic subtest: pipe-B-HDMI-A-3
[702.470307] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (4.398s)
[702.617058] Starting dynamic subtest: pipe-C-HDMI-A-3
[722.465639] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (4.453s)
[722.622612] Starting dynamic subtest: pipe-D-HDMI-A-3
[742.442758] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (4.389s)
[742.443697] Subtest async-flip-suspend-resume: SUCCESS (18.802s)
[751.846178] [103/131] (295s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[753.406034] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[753.510572] [104/131] (293s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[755.037930] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[755.039626] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[755.285705] [105/131] (292s left) i915_query (engine-info-invalid)
[755.366158] Starting subtest: engine-info-invalid
[755.367060] Subtest engine-info-invalid: SUCCESS (0.000s)
[755.568457] [106/131] (292s left) perf (polling-parameterized)
[755.845215] Starting subtest: polling-parameterized
[775.881942] Subtest polling-parameterized: SUCCESS (20.027s)
[775.948409] [107/131] (271s left) api_intel_allocator (fork-simple-once)
[776.029294] Starting subtest: fork-simple-once
[776.077173] Subtest fork-simple-once: SUCCESS (0.048s)
[776.300585] [108/131] (271s left) kms_cursor_crc (cursor-sliding-32x32)
[777.912420] Starting subtest: cursor-sliding-32x32
[777.960318] Subtest cursor-sliding-32x32: SKIP (0.046s)
[778.408452] [109/131] (269s left) gem_mmap_wc (read)
[778.494007] Subtest read: SKIP (0.000s)
[778.569100] [110/131] (269s left) kms_psr (fbc-pr-sprite-render)
[780.084272] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[780.147696] [111/131] (267s left) gem_vm_create (execbuf)
[780.234253] Starting subtest: execbuf
[780.242565] Subtest execbuf: SUCCESS (0.008s)
[780.465763] [112/131] (267s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[781.990295] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[783.117846] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (1.127s)
[783.346395] [113/131] (264s left) gem_render_copy (linear-to-vebox-y-tiled)
[783.436386] Starting subtest: linear-to-vebox-y-tiled
[783.438372] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[783.723229] [114/131] (264s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[785.241458] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[785.298808] [115/131] (263s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[786.818948] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[786.819889] Starting dynamic subtest: pipe-A-HDMI-A-3
[786.823313] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[786.835822] Starting dynamic subtest: pipe-B-HDMI-A-3
[786.839215] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[786.851266] Starting dynamic subtest: pipe-C-HDMI-A-3
[786.854809] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[786.866495] Starting dynamic subtest: pipe-D-HDMI-A-3
[786.870125] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[786.872259] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SKIP (0.008s)
[787.146983] [116/131] (261s left) kms_plane_alpha_blend (constant-alpha-max)
[788.658829] Starting subtest: constant-alpha-max
[788.903871] Starting dynamic subtest: pipe-A-HDMI-A-3
[789.771495] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.868s)
[789.785020] Starting dynamic subtest: pipe-D-HDMI-A-3
[790.641198] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.868s)
[790.642128] Subtest constant-alpha-max: SUCCESS (1.984s)
[790.883525] [117/131] (257s left) gem_flink_basic (double-flink)
[790.974531] Starting subtest: double-flink
[790.975354] Subtest double-flink: SUCCESS (0.000s)
[791.185118] [118/131] (257s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[792.704194] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[792.705071] Starting dynamic subtest: pipe-A
[792.785545] Dynamic subtest pipe-A: SUCCESS (0.081s)
[792.803386] Starting dynamic subtest: pipe-B
[792.932005] Dynamic subtest pipe-B: SUCCESS (0.145s)
[792.953658] Starting dynamic subtest: pipe-C
[793.075739] Dynamic subtest pipe-C: SUCCESS (0.142s)
[793.090019] Starting dynamic subtest: pipe-D
[793.201296] Dynamic subtest pipe-D: SUCCESS (0.124s)
[793.202229] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SUCCESS (0.498s)
[793.462376] [119/131] (255s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[793.543053] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[793.634743] [120/131] (255s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[795.150720] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[795.152489] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[795.403302] [121/131] (253s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[796.919952] Starting subtest: cursorA-vs-flipA-atomic-transitions
[807.850721] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (10.930s)
[808.099146] [122/131] (240s left) gem_pread (self)
[808.181024] Subtest self: SKIP (0.000s)
[808.253474] [123/131] (240s left) gem_exec_reloc (basic-cpu-wc)
[808.340486] Subtest basic-cpu-wc: SKIP (0.000s)
[808.425625] [124/131] (240s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[808.508310] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[808.611201] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.103s)
[808.788842] [125/131] (240s left) kms_lease (master-vs-lease)
[810.303193] Starting subtest: master-vs-lease
[810.305550] Subtest master-vs-lease: SUCCESS (0.003s)
[810.562842] [126/131] (238s left) gem_exec_balancer (busy)
[810.652692] Starting subtest: busy
[811.576300] Subtest busy: SUCCESS (0.923s)
[812.052851] [127/131] (237s left) gen9_exec_parse (bb-start-param)
[812.138929] Subtest bb-start-param: SKIP (0.000s)
[812.220719] [128/131] (237s left) kms_pm_rpm (i2c)
[816.478896] Starting subtest: i2c
[820.151276] Subtest i2c: SUCCESS (3.672s)
[821.102337] [129/131] (228s left) kms_flip (plain-flip-ts-check)
[822.625974] Starting subtest: plain-flip-ts-check
[822.630336] Starting dynamic subtest: A-HDMI-A3
[830.667414] Dynamic subtest A-HDMI-A3: SUCCESS (8.034s)
[830.683006] Starting dynamic subtest: B-HDMI-A3
[838.635823] Dynamic subtest B-HDMI-A3: SUCCESS (7.963s)
[838.653157] Starting dynamic subtest: C-HDMI-A3
[846.604883] Dynamic subtest C-HDMI-A3: SUCCESS (7.964s)
[846.619349] Starting dynamic subtest: D-HDMI-A3
[854.585975] Dynamic subtest D-HDMI-A3: SUCCESS (7.982s)
[854.586960] Subtest plain-flip-ts-check: SUCCESS (31.954s)
[854.875218] [130/131] (194s left) gem_exec_params (invalid-ring2)
[854.955618] Starting subtest: invalid-ring2
[854.956549] Subtest invalid-ring2: SUCCESS (0.000s)
[855.164388] [131/131] (194s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[856.680802] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[856.682408] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[856.902009] 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.