[89.047614] Initializing watchdogs
[89.047861]   /dev/watchdog0
[89.087120] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3184 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 605]
[89.101338] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[89.107919] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[89.113529] [001/133] (960s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[89.239111] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[89.324147] [002/133] (960s left) prime_mmap (test_userptr)
[89.423929] Starting subtest: test_userptr
[89.425324] Starting dynamic subtest: test_userptr-smem
[89.426372] Dynamic subtest test_userptr-smem: SUCCESS (0.001s)
[89.428777] Subtest test_userptr: SUCCESS (0.003s)
[89.578772] [003/133] (960s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[89.775833] Starting subtest: yf-tiled-64bpp-rotate-270
[89.777749] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.002s)
[89.913669] [004/133] (959s left) gem_exec_schedule (noreorder)
[90.165198] Starting subtest: noreorder
[90.166390] Starting dynamic subtest: rcs0
[90.226737] Dynamic subtest rcs0: SUCCESS (0.061s)
[90.246786] Starting dynamic subtest: bcs0
[90.289174] Dynamic subtest bcs0: SUCCESS (0.061s)
[90.308571] Starting dynamic subtest: vcs0
[90.346582] Dynamic subtest vcs0: SUCCESS (0.056s)
[90.364075] Starting dynamic subtest: vecs0
[90.406265] Dynamic subtest vecs0: SUCCESS (0.058s)
[90.408069] Subtest noreorder: SUCCESS (0.242s)
[90.645681] [005/133] (959s left) syncobj_eventfd (binary-wait-signaled)
[90.742303] Starting subtest: binary-wait-signaled
[90.743441] Subtest binary-wait-signaled: SUCCESS (0.002s)
[90.881858] [006/133] (959s left) gem_mmap_gtt (basic-read-write-distinct)
[90.981190] Starting subtest: basic-read-write-distinct
[91.010743] Subtest basic-read-write-distinct: SUCCESS (0.034s)
[91.164164] [007/133] (958s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[91.351093] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[93.888022] Subtest fbc-2p-scndscrn-cur-indfb-move: SUCCESS (2.541s)
[94.111192] [008/133] (956s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[94.286356] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[94.287266] Starting dynamic subtest: pipe-A-valid-mode
[95.156488] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.866s)
[95.157384] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SUCCESS (0.868s)
[95.412725] [009/133] (954s left) sw_sync (alloc_timeline)
[95.505846] Starting subtest: alloc_timeline
[95.506973] Subtest alloc_timeline: SUCCESS (0.000s)
[95.612516] [010/133] (954s left) kms_prime (d3hot)
[95.800313] Subtest D3hot: SKIP (0.000s)
[96.014859] [FACT kms_prime (d3hot)] new: kernel.kmod_is_loaded.vgem: true
[96.018263] [011/133] (954s left) gem_exec_schedule (u-submit-early-slice)
[96.144552] Starting subtest: u-submit-early-slice
[96.146408] Starting dynamic subtest: rcs0
[96.200821] Dynamic subtest rcs0: SUCCESS (0.058s)
[96.219281] Starting dynamic subtest: bcs0
[96.251892] Dynamic subtest bcs0: SUCCESS (0.048s)
[96.272184] Starting dynamic subtest: vcs0
[96.294788] Dynamic subtest vcs0: SUCCESS (0.045s)
[96.315885] Starting dynamic subtest: vecs0
[96.347676] Dynamic subtest vecs0: SUCCESS (0.052s)
[96.350197] Subtest u-submit-early-slice: SUCCESS (0.206s)
[96.739378] [012/133] (953s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[96.904269] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[96.905300] Starting dynamic subtest: pipe-A
[98.188872] Dynamic subtest pipe-A: SUCCESS (1.284s)
[98.211408] Starting dynamic subtest: pipe-B
[99.511311] Dynamic subtest pipe-B: SUCCESS (1.323s)
[99.528553] Starting dynamic subtest: pipe-C
[99.942940] Dynamic subtest pipe-C: SUCCESS (0.427s)
[99.944135] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (3.037s)
[100.449752] [013/133] (950s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[100.623737] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[100.625685] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[102.804967] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (2.179s)
[102.822252] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[104.562067] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (1.743s)
[104.577695] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[106.246778] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (1.693s)
[106.247623] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (5.624s)
[106.532871] [014/133] (944s left) kms_flip (2x-flip-vs-dpms-on-nop)
[106.706486] Starting subtest: 2x-flip-vs-dpms-on-nop
[106.710103] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[108.387814] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (1.678s)
[108.406744] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[110.004952] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (1.614s)
[110.023193] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[111.613694] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (1.606s)
[111.616184] Subtest 2x-flip-vs-dpms-on-nop: SUCCESS (4.910s)
[112.193779] [015/133] (938s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[112.381958] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[114.881275] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SUCCESS (2.496s)
[115.060633] [016/133] (935s left) kms_vblank (wait-idle-hang)
[115.231390] Starting subtest: wait-idle-hang
[115.232311] Starting dynamic subtest: pipe-A-HDMI-A-1
[122.938523] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (7.701s)
[122.957288] Starting dynamic subtest: pipe-A-HDMI-A-2
[129.910900] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (6.968s)
[129.932052] Starting dynamic subtest: pipe-C-HDMI-A-1
[136.863767] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (6.951s)
[136.881940] Starting dynamic subtest: pipe-C-HDMI-A-2
[143.919649] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (7.050s)
[143.924789] Subtest wait-idle-hang: SUCCESS (28.690s)
[144.219793] [017/133] (906s left) gem_exec_schedule (fifo)
[144.339911] Starting subtest: fifo
[144.340975] Starting dynamic subtest: rcs0
[144.464355] Dynamic subtest rcs0: SUCCESS (0.120s)
[144.483772] Starting dynamic subtest: bcs0
[144.584660] Dynamic subtest bcs0: SUCCESS (0.121s)
[144.604884] Starting dynamic subtest: vcs0
[144.693255] Dynamic subtest vcs0: SUCCESS (0.107s)
[144.711480] Starting dynamic subtest: vecs0
[144.803588] Dynamic subtest vecs0: SUCCESS (0.105s)
[144.805479] Subtest fifo: SUCCESS (0.462s)
[145.202174] [018/133] (905s left) gem_mmap (bad-offset)
[145.296171] Starting subtest: bad-offset
[145.297823] Subtest bad-offset: SUCCESS (0.001s)
[145.454412] [019/133] (905s left) syncobj_wait (wait-any-snapshot)
[145.552582] Starting subtest: wait-any-snapshot
[145.638334] Subtest wait-any-snapshot: SUCCESS (0.084s)
[145.771908] [020/133] (905s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[145.950582] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[145.952665] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[146.085689] [021/133] (905s left) sw_sync (sync_merge)
[146.179644] Starting subtest: sync_merge
[146.180654] Subtest sync_merge: SUCCESS (0.001s)
[146.301940] [022/133] (905s left) kms_feature_discovery (display)
[146.469276] Starting subtest: display
[146.470464] Subtest display: SUCCESS (0.000s)
[146.603295] [023/133] (904s left) kms_flip (flip-vs-absolute-wf_vblank)
[146.769771] Starting subtest: flip-vs-absolute-wf_vblank
[146.772120] Starting dynamic subtest: A-HDMI-A1
[152.668819] Dynamic subtest A-HDMI-A1: SUCCESS (5.897s)
[152.687111] Starting dynamic subtest: B-HDMI-A1
[158.336315] Dynamic subtest B-HDMI-A1: SUCCESS (5.664s)
[158.357809] Starting dynamic subtest: C-HDMI-A1
[164.000236] Dynamic subtest C-HDMI-A1: SUCCESS (5.662s)
[164.018828] Starting dynamic subtest: A-HDMI-A2
[169.679831] Dynamic subtest A-HDMI-A2: SUCCESS (5.677s)
[169.698720] Starting dynamic subtest: B-HDMI-A2
[175.342813] Dynamic subtest B-HDMI-A2: SUCCESS (5.659s)
[175.362302] Starting dynamic subtest: C-HDMI-A2
[181.174876] Dynamic subtest C-HDMI-A2: SUCCESS (5.828s)
[181.179696] Subtest flip-vs-absolute-wf_vblank: SUCCESS (34.405s)
[181.640484] [024/133] (869s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[181.832215] Starting subtest: cursor-rapid-movement-max-size
[181.835293] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[181.988911] [025/133] (869s left) gem_exec_fence (syncobj-export)
[182.517990] Starting subtest: syncobj-export
[182.522614] Subtest syncobj-export: SUCCESS (0.006s)
[182.921804] [026/133] (868s left) gem_exec_reloc (basic-cpu-gtt-active)
[183.027898] Starting subtest: basic-cpu-gtt-active
[183.170998] Subtest basic-cpu-gtt-active: SUCCESS (0.143s)
[183.389163] [027/133] (868s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[183.571304] Starting subtest: x-tiled-16bpp-rotate-270
[183.854416] Subtest x-tiled-16bpp-rotate-270: SKIP (0.281s)
[184.087833] [028/133] (867s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[184.272434] Starting subtest: 4-tiled-addfb-size-offset-overflow
[184.274203] Subtest 4-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[184.420863] [029/133] (867s left) gem_ctx_shared (q-out-order)
[184.534205] Starting subtest: Q-out-order
[184.536202] Starting dynamic subtest: rcs0
[184.624734] Dynamic subtest rcs0: SUCCESS (0.087s)
[184.645262] Starting dynamic subtest: bcs0
[184.717160] Dynamic subtest bcs0: SUCCESS (0.090s)
[184.738572] Starting dynamic subtest: vcs0
[184.801180] Dynamic subtest vcs0: SUCCESS (0.079s)
[184.823696] Starting dynamic subtest: vecs0
[184.880079] Dynamic subtest vecs0: SUCCESS (0.076s)
[184.881259] Subtest Q-out-order: SUCCESS (0.344s)
[185.173907] [030/133] (866s left) gem_exec_balancer (sliced)
[185.294404] Starting subtest: sliced
[189.405367] Subtest sliced: SUCCESS (4.110s)
[189.656832] [031/133] (862s left) gem_ctx_persistence (heartbeat-hang)
[189.760799] Starting subtest: heartbeat-hang
[190.967625] Subtest heartbeat-hang: SUCCESS (1.206s)
[191.106374] [032/133] (861s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[191.289400] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[193.807032] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SUCCESS (2.516s)
[194.060223] [033/133] (858s left) i915_pm_rpm (gem-mmap-type)
[195.950493] Starting subtest: gem-mmap-type
[195.951467] Starting dynamic subtest: gtt-smem0
[198.236214] Dynamic subtest gtt-smem0: SUCCESS (2.285s)
[198.253534] Starting dynamic subtest: wb-smem0
[199.392861] Dynamic subtest wb-smem0: SUCCESS (1.158s)
[199.412783] Starting dynamic subtest: wc-smem0
[200.539278] Dynamic subtest wc-smem0: SUCCESS (1.138s)
[200.557240] Starting dynamic subtest: uc-smem0
[201.697577] Dynamic subtest uc-smem0: SUCCESS (1.157s)
[201.700703] Subtest gem-mmap-type: SUCCESS (5.755s)
[201.989218] [034/133] (850s left) prime_vgem (basic-read)
[202.122542] Starting subtest: basic-read
[202.188914] Subtest basic-read: SUCCESS (0.068s)
[202.339758] [035/133] (850s left) gem_exec_balancer (bonded-sync)
[202.460398] Starting subtest: bonded-sync
[206.604401] Subtest bonded-sync: SUCCESS (4.144s)
[206.872920] [036/133] (845s left) gem_wait (invalid-buf)
[206.981547] Starting subtest: invalid-buf
[206.984189] Subtest invalid-buf: SUCCESS (0.000s)
[207.273871] [037/133] (845s left) kms_plane (pixel-format-4-tiled-modifier)
[207.443137] Starting subtest: pixel-format-4-tiled-modifier
[207.445365] Subtest pixel-format-4-tiled-modifier: SKIP (0.000s)
[207.572318] [038/133] (845s left) gem_userptr_blits (sync-overlap)
[207.694230] Starting subtest: sync-overlap
[207.695253] Subtest sync-overlap: SUCCESS (0.000s)
[207.874506] [039/133] (844s left) kms_universal_plane (cursor-fb-leak)
[208.046421] Starting subtest: cursor-fb-leak
[208.047428] Starting dynamic subtest: pipe-A-HDMI-A-1
[208.634972] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.588s)
[208.657250] Starting dynamic subtest: pipe-B-HDMI-A-2
[209.151893] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.510s)
[209.173193] Starting dynamic subtest: pipe-C-HDMI-A-1
[209.703761] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.546s)
[209.705181] Subtest cursor-fb-leak: SUCCESS (1.662s)
[210.152660] [040/133] (842s left) syncobj_wait (wait-all-delayed-signal)
[210.251770] Starting subtest: wait-all-delayed-signal
[210.358364] Subtest wait-all-delayed-signal: SUCCESS (0.104s)
[210.500501] [041/133] (842s left) gem_render_copy (linear-to-vebox-yf-tiled)
[210.609889] Starting subtest: linear-to-vebox-yf-tiled
[210.612087] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[210.850264] [042/133] (842s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[211.022940] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[211.024583] Starting dynamic subtest: pipe-A-HDMI-A-1
[211.033501] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s)
[211.051175] Starting dynamic subtest: pipe-A-HDMI-A-2
[211.059399] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.002s)
[211.076760] Starting dynamic subtest: pipe-B-HDMI-A-1
[211.085676] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s)
[211.102873] Starting dynamic subtest: pipe-B-HDMI-A-2
[211.112818] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.002s)
[211.130153] Starting dynamic subtest: pipe-C-HDMI-A-1
[211.139936] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[211.157235] Starting dynamic subtest: pipe-C-HDMI-A-2
[211.165358] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.002s)
[211.166979] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.040s)
[211.956736] [043/133] (841s left) gem_softpin (evict-active-interruptible)
[212.076574] Starting subtest: evict-active-interruptible
[212.097964] Subtest evict-active-interruptible: SUCCESS (0.023s)
[212.260505] [044/133] (841s left) gem_partial_pwrite_pread (writes-after-reads)
[212.368127] Starting subtest: writes-after-reads
[231.201396] Subtest writes-after-reads: SUCCESS (18.833s)
[231.362481] [045/133] (821s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[231.532975] Starting subtest: cursorA-vs-flipB-atomic
[242.810985] Subtest cursorA-vs-flipB-atomic: SUCCESS (11.276s)
[243.100628] [046/133] (810s left) gen7_exec_parse (basic-allowed)
[243.203283] Subtest basic-allowed: SKIP (0.000s)
[243.310459] [047/133] (810s left) kms_chamelium_frames (hdmi-crc-fast)
[243.849502] Subtest hdmi-crc-fast: SKIP (0.000s)
[244.099743] [048/133] (809s left) kms_chamelium_frames (vga-frame-dump)
[244.637225] Subtest vga-frame-dump: SKIP (0.000s)
[244.887695] [049/133] (808s left) gem_caching (reads)
[244.992289] Starting subtest: reads
[250.659640] Subtest reads: SUCCESS (5.667s)
[250.823646] [050/133] (802s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[250.925236] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[250.926400] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.001s)
[251.086811] [051/133] (802s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[251.256146] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[251.257364] Starting dynamic subtest: pipe-A-HDMI-A-1
[251.265881] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[251.284333] Starting dynamic subtest: pipe-A-HDMI-A-2
[251.292943] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s)
[251.312242] Starting dynamic subtest: pipe-B-HDMI-A-1
[251.320278] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[251.338266] Starting dynamic subtest: pipe-B-HDMI-A-2
[251.346649] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s)
[251.364397] Starting dynamic subtest: pipe-C-HDMI-A-1
[251.372392] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[251.390223] Starting dynamic subtest: pipe-C-HDMI-A-2
[251.398025] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[251.400249] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SKIP (0.032s)
[252.167414] [052/133] (801s left) kms_async_flips (invalid-async-flip-atomic)
[252.335073] Starting subtest: invalid-async-flip-atomic
[252.898391] Starting dynamic subtest: pipe-A-HDMI-A-1
[253.211737] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.312s)
[253.495257] Starting dynamic subtest: pipe-A-HDMI-A-2
[253.829997] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.351s)
[254.119470] Starting dynamic subtest: pipe-B-HDMI-A-1
[254.415021] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.304s)
[254.686699] Starting dynamic subtest: pipe-B-HDMI-A-2
[254.978125] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.303s)
[255.254775] Starting dynamic subtest: pipe-C-HDMI-A-1
[255.545164] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.301s)
[255.833488] Starting dynamic subtest: pipe-C-HDMI-A-2
[256.125849] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.302s)
[256.132142] Subtest invalid-async-flip-atomic: SUCCESS (3.787s)
[256.658592] [053/133] (797s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[256.773612] Starting subtest: y-tiled-to-vebox-yf-tiled
[256.775615] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[257.025550] [054/133] (797s left) gem_create (create-ext-set-pat)
[257.248514] Starting subtest: create-ext-set-pat
[257.252191] Subtest create-ext-set-pat: SKIP (0.000s)
[257.391350] [055/133] (796s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[257.577181] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[257.791913] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.211s)
[258.039529] [056/133] (796s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[258.138587] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[258.240149] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.101s)
[258.375827] [057/133] (796s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[258.562656] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[258.564640] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[258.711156] [058/133] (795s left) gem_pread (self)
[258.808587] Starting subtest: self
[258.852671] Subtest self: SUCCESS (0.045s)
[259.008902] [059/133] (795s left) gem_exec_reloc (basic-softpin)
[259.118570] Starting subtest: basic-softpin
[259.123180] Subtest basic-softpin: SUCCESS (0.005s)
[259.342374] [060/133] (795s left) prime_vgem (fence-read-hang)
[259.481679] Subtest fence-read-hang: SKIP (0.000s)
[259.639834] [061/133] (795s left) kms_plane_alpha_blend (alpha-transparent-fb)
[259.808594] Starting subtest: alpha-transparent-fb
[260.045522] Starting dynamic subtest: pipe-A-HDMI-A-1
[260.697640] Dynamic subtest pipe-A-HDMI-A-1: FAIL (0.446s)
[260.715445] Starting dynamic subtest: pipe-C-HDMI-A-1
[261.206265] Dynamic subtest pipe-C-HDMI-A-1: FAIL (0.461s)
[261.207192] Subtest alpha-transparent-fb: FAIL (1.153s)
[261.435249] [062/133] (793s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[261.623392] Starting subtest: fbc-rgb565-draw-pwrite
[264.645513] Subtest fbc-rgb565-draw-pwrite: SUCCESS (3.023s)
[264.916844] [063/133] (790s left) kms_joiner (basic-max-non-joiner)
[265.087360] Starting subtest: basic-max-non-joiner
[265.089223] Subtest basic-max-non-joiner: SKIP (0.000s)
[265.233948] [064/133] (789s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[265.404623] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[265.405639] Starting dynamic subtest: pipe-A-HDMI-A-1
[265.418306] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[265.436341] Starting dynamic subtest: pipe-A-HDMI-A-2
[265.461451] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s)
[265.480875] Starting dynamic subtest: pipe-B-HDMI-A-1
[265.489866] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[265.509424] Starting dynamic subtest: pipe-B-HDMI-A-2
[265.519251] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s)
[265.537872] Starting dynamic subtest: pipe-C-HDMI-A-1
[265.546801] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[265.564247] Starting dynamic subtest: pipe-C-HDMI-A-2
[265.573547] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[265.575473] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SKIP (0.034s)
[266.329880] [065/133] (788s left) kms_cursor_edge_walk (256x256-top-edge)
[266.497686] Starting subtest: 256x256-top-edge
[266.500061] Starting dynamic subtest: pipe-A-HDMI-A-1
[270.354973] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.855s)
[270.379167] Starting dynamic subtest: pipe-C-HDMI-A-1
[273.760979] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.398s)
[273.763142] Subtest 256x256-top-edge: SUCCESS (7.264s)
[274.041357] [066/133] (781s left) kms_content_protection (atomic-dpms-hdcp14)
[274.243426] Starting subtest: atomic-dpms-hdcp14
[274.260456] Subtest atomic-dpms-hdcp14: SKIP (0.010s)
[274.407453] [067/133] (780s left) perf_pmu (gt-awake)
[274.509042] Starting subtest: gt-awake
[277.084984] Subtest gt-awake: SUCCESS (2.575s)
[277.222243] [068/133] (778s left) kms_getfb (getfb2-handle-not-fb)
[277.392445] Starting subtest: getfb2-handle-not-fb
[277.393634] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[277.542297] [069/133] (777s left) gen9_exec_parse (batch-invalid-length)
[277.662612] Starting subtest: batch-invalid-length
[277.669398] Subtest batch-invalid-length: SUCCESS (0.009s)
[277.944661] [070/133] (777s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[278.110776] Starting subtest: plane-upscale-20x20-with-pixel-format
[278.111834] Starting dynamic subtest: pipe-A
[279.133416] Dynamic subtest pipe-A: SUCCESS (1.023s)
[279.155255] Starting dynamic subtest: pipe-B
[280.196827] Dynamic subtest pipe-B: SUCCESS (1.061s)
[280.221311] Starting dynamic subtest: pipe-C
[280.610980] Dynamic subtest pipe-C: SUCCESS (0.411s)
[280.614613] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (2.504s)
[281.097867] [071/133] (774s left) kms_rotation_crc (primary-rotation-180)
[281.270456] Starting subtest: primary-rotation-180
[292.577701] Subtest primary-rotation-180: SUCCESS (11.309s)
[292.828353] [072/133] (762s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[293.017305] Starting subtest: yf-tiled-32bpp-rotate-0
[297.892284] Subtest yf-tiled-32bpp-rotate-0: SUCCESS (4.875s)
[298.419938] [073/133] (757s left) device_reset (unbind-cold-reset-rebind)
[298.544225] Starting subtest: unbind-cold-reset-rebind
[298.547104] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[298.683744] [074/133] (757s left) kms_psr (psr2-no-drrs)
[298.848361] Subtest psr2-no-drrs: SKIP (0.000s)
[298.958553] [075/133] (757s left) gem_fence_thrash (bo-write-verify-threaded-y)
[299.047359] Starting subtest: bo-write-verify-threaded-y
[303.663903] Subtest bo-write-verify-threaded-y: SUCCESS (4.616s)
[303.803804] [076/133] (752s left) kms_lease (master-vs-lease)
[303.980790] Starting subtest: master-vs-lease
[303.981984] Subtest master-vs-lease: SUCCESS (0.003s)
[304.117675] [077/133] (752s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[304.305159] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[304.308323] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[304.450609] [078/133] (751s left) kms_big_fb (linear-8bpp-rotate-270)
[304.641229] Starting subtest: linear-8bpp-rotate-270
[304.928801] Subtest linear-8bpp-rotate-270: SKIP (0.290s)
[305.182702] [079/133] (751s left) kms_cursor_crc (cursor-offscreen-512x170)
[305.378320] Starting subtest: cursor-offscreen-512x170
[305.380668] Subtest cursor-offscreen-512x170: SKIP (0.003s)
[305.532468] [080/133] (750s left) gem_exec_reloc (basic-write-wc-active)
[305.638863] Starting subtest: basic-write-wc-active
[305.777624] Subtest basic-write-wc-active: SUCCESS (0.139s)
[305.982032] [081/133] (750s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[306.164398] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[306.166438] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[306.300748] [082/133] (750s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[306.485658] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[306.487703] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[306.632908] [083/133] (750s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[306.803978] Starting subtest: primary-4-tiled-reflect-x-0
[306.808318] Subtest primary-4-tiled-reflect-x-0: SKIP (0.003s)
[306.950826] [084/133] (749s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[307.135651] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[309.660633] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (2.524s)
[309.948502] [085/133] (747s left) prime_mmap_coherency (ioctl-errors)
[310.057303] Starting subtest: ioctl-errors
[323.374873] Subtest ioctl-errors: SUCCESS (13.318s)
[323.559195] [086/133] (733s left) kms_pm_dc (dc5-dpms)
[324.864507] Starting subtest: dc5-dpms
[326.605951] Subtest dc5-dpms: SUCCESS (1.744s)
[326.758400] [087/133] (730s left) gem_busy (extended)
[327.012984] Starting subtest: extended
[327.017188] Starting dynamic subtest: rcs0
[327.048343] Dynamic subtest rcs0: SUCCESS (0.033s)
[327.071860] Starting dynamic subtest: bcs0
[327.073027] Dynamic subtest bcs0: SUCCESS (0.018s)
[327.094233] Starting dynamic subtest: vcs0
[327.095610] Dynamic subtest vcs0: SUCCESS (0.014s)
[327.115808] Starting dynamic subtest: vecs0
[327.117098] Dynamic subtest vecs0: SUCCESS (0.017s)
[327.118334] Subtest extended: SUCCESS (0.095s)
[327.390263] [088/133] (729s left) kms_cursor_legacy (torture-move)
[327.561103] Starting subtest: torture-move
[327.562283] Starting dynamic subtest: pipe-A
[333.054507] Dynamic subtest pipe-A: SUCCESS (5.491s)
[333.082126] Starting dynamic subtest: pipe-B
[338.588572] Dynamic subtest pipe-B: SUCCESS (5.530s)
[338.610897] Starting dynamic subtest: pipe-C
[344.099588] Dynamic subtest pipe-C: SUCCESS (5.508s)
[344.128065] Starting dynamic subtest: all-pipes
[349.611251] Dynamic subtest all-pipes: SUCCESS (5.506s)
[349.613405] Subtest torture-move: SUCCESS (22.049s)
[349.757631] [089/133] (707s left) prime_mmap (test_refcounting)
[349.853460] Starting subtest: test_refcounting
[349.854449] Starting dynamic subtest: test_refcounting-smem
[349.862059] Dynamic subtest test_refcounting-smem: SUCCESS (0.008s)
[349.865785] Subtest test_refcounting: SUCCESS (0.011s)
[350.021570] [090/133] (707s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[350.195797] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[350.298119] [091/133] (707s left) syncobj_timeline (invalid-signal-zero-handles)
[350.397538] Starting subtest: invalid-signal-zero-handles
[350.398561] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[350.572664] [092/133] (707s left) kms_big_fb (y-tiled-addfb)
[350.765820] Starting subtest: y-tiled-addfb
[350.767468] Subtest y-tiled-addfb: SUCCESS (0.001s)
[350.920931] [093/133] (706s left) i915_drm_fdinfo (busy)
[351.024278] Starting subtest: busy
[351.025290] Starting dynamic subtest: rcs0
[351.559696] Dynamic subtest rcs0: SUCCESS (0.534s)
[351.583046] Starting dynamic subtest: bcs0
[352.095335] Dynamic subtest bcs0: SUCCESS (0.533s)
[352.119062] Starting dynamic subtest: vcs0
[352.630713] Dynamic subtest vcs0: SUCCESS (0.532s)
[352.653981] Starting dynamic subtest: vecs0
[353.169698] Dynamic subtest vecs0: SUCCESS (0.536s)
[353.173458] Subtest busy: SUCCESS (2.148s)
[353.305410] [094/133] (704s left) i915_drm_fdinfo (virtual-busy-idle-all)
[353.411133] Starting subtest: virtual-busy-idle-all
[353.413169] Subtest virtual-busy-idle-all: SUCCESS (0.001s)
[353.555584] [095/133] (704s left) gem_close (many-handles-one-vma)
[353.659278] Starting subtest: many-handles-one-vma
[353.736747] Subtest many-handles-one-vma: SUCCESS (0.078s)
[353.906193] [096/133] (704s left) api_intel_bb (reset-bb)
[354.002018] Starting subtest: reset-bb
[354.004999] Subtest reset-bb: SUCCESS (0.005s)
[354.153397] [097/133] (703s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[354.336084] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[354.339108] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[354.488380] [098/133] (703s left) prime_mmap (test_invalid_sync_flags)
[354.582254] Starting subtest: test_invalid_sync_flags
[354.583277] Starting dynamic subtest: test_invalid_sync_flags-smem
[354.584198] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[354.585185] Subtest test_invalid_sync_flags: SUCCESS (0.003s)
[354.722731] [099/133] (703s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[354.889396] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[354.891306] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[355.021704] [100/133] (703s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[355.192985] Starting subtest: flip-vs-cursor-atomic-transitions
[373.653255] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (18.455s)
[373.948576] [101/133] (684s left) kms_psr (fbc-psr2-cursor-render)
[374.127117] Subtest fbc-psr2-cursor-render: SKIP (0.000s)
[374.236825] [102/133] (684s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[374.406625] Starting subtest: plane-lut1d-ctm3x4
[375.853403] Subtest plane-lut1d-ctm3x4: SKIP (1.447s)
[376.122677] [103/133] (682s left) gem_mmap_gtt (hang-busy)
[376.218394] Starting subtest: hang-busy
[391.138424] Subtest hang-busy: SUCCESS (14.917s)
[391.306657] [104/133] (667s left) kms_plane_lowres (tiling-none)
[391.476272] Starting subtest: tiling-none
[391.477278] Starting dynamic subtest: pipe-A-HDMI-A-1
[398.066644] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.588s)
[398.308116] Starting dynamic subtest: pipe-A-HDMI-A-2
[404.579446] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (6.293s)
[404.816145] Starting dynamic subtest: pipe-B-HDMI-A-1
[410.836924] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (6.040s)
[411.060138] Starting dynamic subtest: pipe-B-HDMI-A-2
[417.068573] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (6.033s)
[417.286725] Starting dynamic subtest: pipe-C-HDMI-A-1
[423.301106] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (6.034s)
[423.549034] Starting dynamic subtest: pipe-C-HDMI-A-2
[429.596375] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (6.067s)
[429.822875] Subtest tiling-none: SUCCESS (38.346s)
[430.279504] [105/133] (628s left) gem_ctx_isolation (nonpriv)
[430.407177] Starting subtest: nonpriv
[430.408736] Starting dynamic subtest: rcs0
[432.405588] Dynamic subtest rcs0: SUCCESS (1.997s)
[432.429724] Starting dynamic subtest: bcs0
[434.853239] Dynamic subtest bcs0: SUCCESS (2.445s)
[434.878512] Starting dynamic subtest: vcs0
[436.788717] Dynamic subtest vcs0: SUCCESS (1.933s)
[436.812228] Starting dynamic subtest: vecs0
[438.705509] Dynamic subtest vecs0: SUCCESS (1.914s)
[438.709057] Subtest nonpriv: SUCCESS (8.300s)
[438.969693] [106/133] (619s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[439.140604] Starting subtest: addfb25-x-tiled-mismatch-legacy
[439.141633] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[439.296641] [107/133] (619s left) prime_busy (before)
[439.400317] Starting subtest: before
[439.413179] Starting dynamic subtest: rcs0
[439.423084] Dynamic subtest rcs0: SUCCESS (0.010s)
[439.446892] Starting dynamic subtest: bcs0
[439.447963] Dynamic subtest bcs0: SUCCESS (0.019s)
[439.469768] Starting dynamic subtest: vcs0
[439.470844] Dynamic subtest vcs0: SUCCESS (0.018s)
[439.492799] Starting dynamic subtest: vecs0
[439.494075] Dynamic subtest vecs0: SUCCESS (0.007s)
[439.588742] Subtest before: SUCCESS (0.188s)
[439.731325] [108/133] (619s left) kms_cdclk (plane-scaling)
[439.827444] Subtest plane-scaling: SKIP (0.000s)
[439.939998] [109/133] (619s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[440.123817] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[443.188833] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SUCCESS (3.064s)
[443.413676] [110/133] (615s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[443.600419] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[443.603390] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[443.762419] [111/133] (615s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[443.947571] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[443.949731] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[444.112719] [112/133] (615s left) gem_softpin (allocator-nopin-reserve)
[444.221573] Starting subtest: allocator-nopin-reserve
[444.429557] Subtest allocator-nopin-reserve: SUCCESS (0.210s)
[444.636354] [113/133] (614s left) perf (gen12-unprivileged-single-ctx-counters)
[444.874462] Starting subtest: gen12-unprivileged-single-ctx-counters
[444.877052] Subtest gen12-unprivileged-single-ctx-counters: SKIP (0.000s)
[444.980674] [114/133] (614s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[445.160995] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[445.162864] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[445.313469] [115/133] (614s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[445.482315] Starting subtest: primary-x-tiled-reflect-x-180
[445.484276] Subtest primary-x-tiled-reflect-x-180: SKIP (0.003s)
[445.629388] [116/133] (614s left) sysfs_heartbeat_interval (mixed)
[445.737079] Starting subtest: mixed
[445.740509] Starting dynamic subtest: vecs0
[450.943626] Dynamic subtest vecs0: SUCCESS (5.206s)
[450.967517] Starting dynamic subtest: vcs0
[456.129531] Dynamic subtest vcs0: SUCCESS (5.182s)
[456.153251] Starting dynamic subtest: bcs0
[461.350573] Dynamic subtest bcs0: SUCCESS (5.217s)
[461.374871] Starting dynamic subtest: rcs0
[466.581904] Dynamic subtest rcs0: SUCCESS (5.227s)
[466.585762] Subtest mixed: SUCCESS (20.849s)
[466.733187] [117/133] (593s left) i915_selftest (live)
[468.398626] Starting subtest: live
[468.399917] Starting dynamic subtest: sanitycheck
[470.952430] Dynamic subtest sanitycheck: SUCCESS (2.552s)
[470.975378] Starting dynamic subtest: uncore
[473.512581] Dynamic subtest uncore: SUCCESS (2.556s)
[473.536283] Starting dynamic subtest: workarounds
[476.293316] Dynamic subtest workarounds: SUCCESS (2.777s)
[476.318415] Starting dynamic subtest: gt_engines
[479.399326] Dynamic subtest gt_engines: SUCCESS (3.102s)
[479.423580] Starting dynamic subtest: gt_timelines
[494.213430] Dynamic subtest gt_timelines: SUCCESS (14.810s)
[494.238429] Starting dynamic subtest: gt_contexts
[496.843399] Dynamic subtest gt_contexts: SUCCESS (2.626s)
[496.866537] Starting dynamic subtest: gt_lrc
[501.955747] Dynamic subtest gt_lrc: SUCCESS (5.109s)
[501.979121] Starting dynamic subtest: gt_mocs
[504.558514] Dynamic subtest gt_mocs: SUCCESS (2.599s)
[504.584422] Starting dynamic subtest: gt_pm
[517.110625] Dynamic subtest gt_pm: SUCCESS (12.548s)
[517.134598] Starting dynamic subtest: gt_heartbeat
[519.611494] Dynamic subtest gt_heartbeat: SUCCESS (2.496s)
[519.636369] Starting dynamic subtest: gt_tlb
[523.483308] Dynamic subtest gt_tlb: SUCCESS (3.868s)
[523.507382] Starting dynamic subtest: requests
[532.535897] Dynamic subtest requests: SUCCESS (9.048s)
[532.559496] Starting dynamic subtest: migrate
[537.974738] Dynamic subtest migrate: SUCCESS (5.435s)
[537.998412] Starting dynamic subtest: active
[540.429798] Dynamic subtest active: SUCCESS (2.449s)
[540.450357] Starting dynamic subtest: objects
[544.456702] Dynamic subtest objects: SUCCESS (4.026s)
[544.480257] Starting dynamic subtest: mman
[552.252531] Dynamic subtest mman: SUCCESS (7.792s)
[552.277363] Starting dynamic subtest: dmabuf
[554.776500] Dynamic subtest dmabuf: SUCCESS (2.521s)
[554.800665] Starting dynamic subtest: vma
[557.207913] Dynamic subtest vma: SUCCESS (2.428s)
[557.231575] Starting dynamic subtest: coherency
[562.497679] Dynamic subtest coherency: SUCCESS (5.285s)
[562.521377] Starting dynamic subtest: gtt
[572.657707] Dynamic subtest gtt: SUCCESS (10.157s)
[572.681119] Starting dynamic subtest: gem
[575.567308] Dynamic subtest gem: SUCCESS (2.906s)
[575.591079] Starting dynamic subtest: evict
[580.834897] Dynamic subtest evict: SUCCESS (5.264s)
[580.858493] Starting dynamic subtest: hugepages
[589.051768] Dynamic subtest hugepages: SUCCESS (8.214s)
[589.076067] Starting dynamic subtest: gem_contexts
[608.938709] Dynamic subtest gem_contexts: SUCCESS (19.884s)
[608.961724] Starting dynamic subtest: client
[611.485503] Dynamic subtest client: SUCCESS (2.544s)
[611.509948] Starting dynamic subtest: gem_migrate
[613.925120] Dynamic subtest gem_migrate: SUCCESS (2.435s)
[613.950474] Starting dynamic subtest: reset
[620.142644] Dynamic subtest reset: SUCCESS (6.214s)
[620.165734] Starting dynamic subtest: memory_region
[622.659355] Dynamic subtest memory_region: SUCCESS (2.513s)
[622.683507] Starting dynamic subtest: hangcheck
[648.112386] Dynamic subtest hangcheck: SUCCESS (25.449s)
[648.137338] Starting dynamic subtest: execlists
[659.799372] Dynamic subtest execlists: SUCCESS (11.684s)
[659.824392] Starting dynamic subtest: ring_submission
[662.228501] Dynamic subtest ring_submission: SUCCESS (2.425s)
[662.252071] Starting dynamic subtest: perf
[665.004070] Dynamic subtest perf: SUCCESS (2.772s)
[665.028983] Starting dynamic subtest: slpc
[667.499311] Dynamic subtest slpc: SUCCESS (2.491s)
[667.522875] Starting dynamic subtest: guc
[669.746405] Dynamic subtest guc: SUCCESS (2.243s)
[669.771502] Starting dynamic subtest: guc_multi_lrc
[672.147967] Dynamic subtest guc_multi_lrc: SUCCESS (2.397s)
[672.172387] Starting dynamic subtest: guc_hang
[674.594860] Dynamic subtest guc_hang: SUCCESS (2.443s)
[674.618726] Starting dynamic subtest: late_gt_pm
[677.191202] Dynamic subtest late_gt_pm: SUCCESS (2.593s)
[677.194840] Subtest live: SUCCESS (208.794s)
[677.261423] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[677.264396] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[677.268792] [118/133] (382s left) gem_exec_flush (basic-uc-set-default)
[679.606057] Starting subtest: basic-uc-set-default
[685.119614] Subtest basic-uc-set-default: SUCCESS (5.516s)
[685.330223] [FACT gem_exec_flush (basic-uc-set-default)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[685.332880] [FACT gem_exec_flush (basic-uc-set-default)] new: kernel.kmod_is_loaded.i915: true
[685.339495] [119/133] (374s left) gem_exec_schedule (u-submit-late-slice)
[685.474674] Starting subtest: u-submit-late-slice
[685.475666] Starting dynamic subtest: rcs0
[685.538185] Dynamic subtest rcs0: SUCCESS (0.062s)
[685.563914] Starting dynamic subtest: bcs0
[685.587491] Dynamic subtest bcs0: SUCCESS (0.049s)
[685.616219] Starting dynamic subtest: vcs0
[685.635797] Dynamic subtest vcs0: SUCCESS (0.045s)
[685.663537] Starting dynamic subtest: vecs0
[685.684683] Dynamic subtest vecs0: SUCCESS (0.045s)
[685.688847] Subtest u-submit-late-slice: SUCCESS (0.214s)
[686.089283] [120/133] (374s left) gem_ctx_bad_destroy (invalid-pad)
[686.184223] Starting subtest: invalid-pad
[686.185308] Subtest invalid-pad: SUCCESS (0.000s)
[686.321843] [121/133] (373s left) kms_psr2_su (page_flip-xrgb8888)
[686.418499] Subtest page_flip-XRGB8888: SKIP (0.000s)
[686.528640] [122/133] (373s left) kms_flip (2x-busy-flip)
[686.699078] Starting subtest: 2x-busy-flip
[686.703425] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[687.944843] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (1.240s)
[687.970344] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[689.134710] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (1.185s)
[689.159332] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[690.294343] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (1.155s)
[690.297922] Subtest 2x-busy-flip: SUCCESS (3.599s)
[690.867293] [123/133] (369s left) syncobj_timeline (multi-wait-for-submit-signaled)
[690.968245] Starting subtest: multi-wait-for-submit-signaled
[690.971692] Subtest multi-wait-for-submit-signaled: SUCCESS (0.003s)
[691.116673] [124/133] (369s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[691.287953] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[691.289119] Starting dynamic subtest: pipe-A-HDMI-A-1
[691.297568] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s)
[691.318886] Starting dynamic subtest: pipe-A-HDMI-A-2
[691.327508] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.002s)
[691.348665] Starting dynamic subtest: pipe-B-HDMI-A-1
[691.357035] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s)
[691.377714] Starting dynamic subtest: pipe-B-HDMI-A-2
[691.389604] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.002s)
[691.410427] Starting dynamic subtest: pipe-C-HDMI-A-1
[691.419486] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[691.440316] Starting dynamic subtest: pipe-C-HDMI-A-2
[691.448430] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.002s)
[691.450062] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.043s)
[692.219721] [125/133] (368s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[692.405187] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[695.394075] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SUCCESS (2.989s)
[695.617313] [126/133] (365s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[695.815359] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[695.817377] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[695.987466] [127/133] (364s left) kms_properties (colorop-properties-atomic)
[696.157485] Starting subtest: colorop-properties-atomic
[696.158538] Starting dynamic subtest: pipe-A-HDMI-A-1
[696.590426] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.431s)
[696.614334] Starting dynamic subtest: pipe-A-HDMI-A-2
[696.947032] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.346s)
[696.969558] Starting dynamic subtest: pipe-B-HDMI-A-1
[697.259097] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.306s)
[697.280376] Starting dynamic subtest: pipe-B-HDMI-A-2
[697.587949] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.323s)
[697.609159] Starting dynamic subtest: pipe-C-HDMI-A-1
[697.910599] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.324s)
[697.939218] Starting dynamic subtest: pipe-C-HDMI-A-2
[698.222087] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.306s)
[698.227145] Subtest colorop-properties-atomic: SUCCESS (2.066s)
[698.517720] [128/133] (362s left) syncobj_wait (multi-wait-submitted)
[698.616889] Starting subtest: multi-wait-submitted
[698.718614] Subtest multi-wait-submitted: SUCCESS (0.102s)
[698.849978] [129/133] (362s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[699.033463] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[699.035288] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[699.185419] [130/133] (361s left) kms_psr (pr-cursor-mmap-gtt)
[699.354404] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[699.459892] [131/133] (361s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[699.555978] Starting subtest: single-wait-all-for-submit-signaled
[699.557136] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.001s)
[699.700720] [132/133] (361s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[699.800571] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[699.904201] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.102s)
[700.053756] [133/133] (361s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[700.223413] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.000s)
[700.322942] Closing watchdogs
results: parsing output: 0/ for test: gem_lmem_swapping
results: parsing output: 1/ for test: prime_mmap
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: gem_exec_schedule
results: parsing output: 4/ for test: syncobj_eventfd
results: parsing output: 5/ for test: gem_mmap_gtt
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_flip_scaled_crc
results: parsing output: 8/ for test: sw_sync
results: parsing output: 9/ for test: kms_prime
results: parsing output: 10/ for test: gem_exec_schedule
results: parsing output: 11/ for test: kms_plane_scaling
results: parsing output: 12/ for test: kms_flip
results: parsing output: 13/ for test: kms_flip
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_vblank
results: parsing output: 16/ for test: gem_exec_schedule
results: parsing output: 17/ for test: gem_mmap
results: parsing output: 18/ for test: syncobj_wait
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: sw_sync
results: parsing output: 21/ for test: kms_feature_discovery
results: parsing output: 22/ for test: kms_flip
results: parsing output: 23/ for test: kms_cursor_crc
results: parsing output: 24/ for test: gem_exec_fence
results: parsing output: 25/ for test: gem_exec_reloc
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: gem_ctx_shared
results: parsing output: 29/ for test: gem_exec_balancer
results: parsing output: 30/ for test: gem_ctx_persistence
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: i915_pm_rpm
results: parsing output: 33/ for test: prime_vgem
results: parsing output: 34/ for test: gem_exec_balancer
results: parsing output: 35/ for test: gem_wait
results: parsing output: 36/ for test: kms_plane
results: parsing output: 37/ for test: gem_userptr_blits
results: parsing output: 38/ for test: kms_universal_plane
results: parsing output: 39/ for test: syncobj_wait
results: parsing output: 40/ for test: gem_render_copy
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: gem_softpin
results: parsing output: 43/ for test: gem_partial_pwrite_pread
results: parsing output: 44/ for test: kms_cursor_legacy
results: parsing output: 45/ for test: gen7_exec_parse
results: parsing output: 46/ for test: kms_chamelium_frames
results: parsing output: 47/ for test: kms_chamelium_frames
results: parsing output: 48/ for test: gem_caching
results: parsing output: 49/ for test: syncobj_wait
results: parsing output: 50/ for test: kms_ccs
results: parsing output: 51/ for test: kms_async_flips
results: parsing output: 52/ for test: gem_render_copy
results: parsing output: 53/ for test: gem_create
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: syncobj_timeline
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_pread
results: parsing output: 58/ for test: gem_exec_reloc
results: parsing output: 59/ for test: prime_vgem
results: parsing output: 60/ for test: kms_plane_alpha_blend
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_joiner
results: parsing output: 63/ for test: kms_ccs
results: parsing output: 64/ for test: kms_cursor_edge_walk
results: parsing output: 65/ for test: kms_content_protection
results: parsing output: 66/ for test: perf_pmu
results: parsing output: 67/ for test: kms_getfb
results: parsing output: 68/ for test: gen9_exec_parse
results: parsing output: 69/ for test: kms_plane_scaling
results: parsing output: 70/ for test: kms_rotation_crc
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: device_reset
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: gem_fence_thrash
results: parsing output: 75/ for test: kms_lease
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: kms_cursor_crc
results: parsing output: 79/ for test: gem_exec_reloc
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_rotation_crc
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: prime_mmap_coherency
results: parsing output: 85/ for test: kms_pm_dc
results: parsing output: 86/ for test: gem_busy
results: parsing output: 87/ for test: kms_cursor_legacy
results: parsing output: 88/ for test: prime_mmap
results: parsing output: 89/ for test: kms_psr2_sf
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: i915_drm_fdinfo
results: parsing output: 93/ for test: i915_drm_fdinfo
results: parsing output: 94/ for test: gem_close
results: parsing output: 95/ for test: api_intel_bb
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: prime_mmap
results: parsing output: 98/ for test: kms_flip_scaled_crc
results: parsing output: 99/ for test: kms_cursor_legacy
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: kms_color_pipeline
results: parsing output: 102/ for test: gem_mmap_gtt
results: parsing output: 103/ for test: kms_plane_lowres
results: parsing output: 104/ for test: gem_ctx_isolation
results: parsing output: 105/ for test: kms_addfb_basic
results: parsing output: 106/ for test: prime_busy
results: parsing output: 107/ for test: kms_cdclk
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: gem_softpin
results: parsing output: 112/ for test: perf
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_rotation_crc
results: parsing output: 115/ for test: sysfs_heartbeat_interval
results: parsing output: 116/ for test: i915_selftest
results: parsing output: 117/ for test: gem_exec_flush
results: parsing output: 118/ for test: gem_exec_schedule
results: parsing output: 119/ for test: gem_ctx_bad_destroy
results: parsing output: 120/ for test: kms_psr2_su
results: parsing output: 121/ for test: kms_flip
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: kms_ccs
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_properties
results: parsing output: 127/ for test: syncobj_wait
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: syncobj_timeline
results: parsing output: 131/ for test: syncobj_wait
results: parsing output: 132/ for test: kms_psr
Done.