[43.835456] Initializing watchdogs
[43.835522]   /dev/watchdog0
[43.850864] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[43.856808] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[43.859457] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[43.861353] [001/133] (960s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[43.903934] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[43.939314] [002/133] (960s left) prime_mmap (test_userptr)
[43.972532] Starting subtest: test_userptr
[43.973227] Starting dynamic subtest: test_userptr-smem
[43.973912] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[43.974572] Subtest test_userptr: SUCCESS (0.001s)
[44.071397] [003/133] (960s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[44.170576] Starting subtest: yf-tiled-64bpp-rotate-270
[44.171996] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.001s)
[44.257407] [004/133] (960s left) gem_exec_schedule (noreorder)
[44.426240] Starting subtest: noreorder
[44.427154] Starting dynamic subtest: rcs0
[44.475599] Dynamic subtest rcs0: SUCCESS (0.050s)
[44.488480] Starting dynamic subtest: bcs0
[44.534538] Dynamic subtest bcs0: SUCCESS (0.058s)
[44.548810] Starting dynamic subtest: vcs0
[44.599664] Dynamic subtest vcs0: SUCCESS (0.064s)
[44.612518] Starting dynamic subtest: vcs1
[44.666643] Dynamic subtest vcs1: SUCCESS (0.066s)
[44.679185] Starting dynamic subtest: vecs0
[44.722542] Dynamic subtest vecs0: SUCCESS (0.055s)
[44.723525] Subtest noreorder: SUCCESS (0.297s)
[44.901866] [005/133] (959s left) syncobj_eventfd (binary-wait-signaled)
[44.935466] Starting subtest: binary-wait-signaled
[44.936203] Subtest binary-wait-signaled: SUCCESS (0.000s)
[44.997130] [006/133] (959s left) gem_mmap_gtt (basic-read-write-distinct)
[45.029484] Starting subtest: basic-read-write-distinct
[45.033128] Subtest basic-read-write-distinct: SUCCESS (0.004s)
[45.120624] [007/133] (959s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[45.209501] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[45.210855] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[45.295029] [008/133] (959s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[45.378665] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[45.379342] Starting dynamic subtest: pipe-A-valid-mode
[46.547230] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.168s)
[46.547954] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SUCCESS (1.169s)
[46.688612] [009/133] (957s left) sw_sync (alloc_timeline)
[46.724144] Starting subtest: alloc_timeline
[46.724891] Subtest alloc_timeline: SUCCESS (0.000s)
[46.768427] [010/133] (957s left) kms_prime (d3hot)
[46.862975] Subtest D3hot: SKIP (0.000s)
[46.972427] [FACT kms_prime (d3hot)] new: kernel.kmod_is_loaded.vgem: true
[46.973956] [011/133] (957s left) gem_exec_schedule (u-submit-early-slice)
[47.018565] Starting subtest: u-submit-early-slice
[47.019269] Starting dynamic subtest: rcs0
[47.052941] Dynamic subtest rcs0: SUCCESS (0.035s)
[47.058688] Starting dynamic subtest: bcs0
[47.080768] Dynamic subtest bcs0: SUCCESS (0.027s)
[47.086768] Starting dynamic subtest: vcs0
[47.107303] Dynamic subtest vcs0: SUCCESS (0.026s)
[47.112934] Starting dynamic subtest: vcs1
[47.134078] Dynamic subtest vcs1: SUCCESS (0.027s)
[47.140088] Starting dynamic subtest: vecs0
[47.159989] Dynamic subtest vecs0: SUCCESS (0.026s)
[47.160717] Subtest u-submit-early-slice: SUCCESS (0.142s)
[47.455569] [012/133] (957s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[47.539271] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[47.540143] Starting dynamic subtest: pipe-A
[48.817306] Dynamic subtest pipe-A: SUCCESS (1.278s)
[48.824154] Starting dynamic subtest: pipe-B
[50.110765] Dynamic subtest pipe-B: SUCCESS (1.293s)
[50.116968] Starting dynamic subtest: pipe-C
[50.312108] Dynamic subtest pipe-C: SUCCESS (0.201s)
[50.321736] Starting dynamic subtest: pipe-D
[50.512053] Dynamic subtest pipe-D: SUCCESS (0.200s)
[50.513515] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (2.973s)
[50.684295] [013/133] (954s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[50.774466] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[50.782983] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.009s)
[50.847391] [014/133] (953s left) kms_flip (2x-flip-vs-dpms-on-nop)
[50.932361] Starting subtest: 2x-flip-vs-dpms-on-nop
[50.941438] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.009s)
[51.008368] [015/133] (953s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[51.100629] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[51.101979] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[51.201690] [016/133] (953s left) kms_vblank (wait-idle-hang)
[51.286365] Starting subtest: wait-idle-hang
[51.287045] Starting dynamic subtest: pipe-A-HDMI-A-1
[65.681925] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (14.394s)
[65.690784] Starting dynamic subtest: pipe-D-HDMI-A-1
[79.494554] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (13.810s)
[79.495260] Subtest wait-idle-hang: SUCCESS (28.209s)
[79.633891] [017/133] (925s left) gem_exec_schedule (fifo)
[79.681066] Starting subtest: fifo
[79.681873] Starting dynamic subtest: rcs0
[79.741485] Dynamic subtest rcs0: SUCCESS (0.060s)
[79.749934] Starting dynamic subtest: bcs0
[79.802973] Dynamic subtest bcs0: SUCCESS (0.061s)
[79.812987] Starting dynamic subtest: vcs0
[79.866736] Dynamic subtest vcs0: SUCCESS (0.063s)
[79.876646] Starting dynamic subtest: vcs1
[79.929167] Dynamic subtest vcs1: SUCCESS (0.062s)
[79.942123] Starting dynamic subtest: vecs0
[79.996408] Dynamic subtest vecs0: SUCCESS (0.066s)
[79.997558] Subtest fifo: SUCCESS (0.316s)
[80.324322] [018/133] (924s left) gem_mmap (bad-offset)
[80.357569] Starting subtest: bad-offset
[80.358294] Subtest bad-offset: SUCCESS (0.000s)
[80.451444] [019/133] (924s left) syncobj_wait (wait-any-snapshot)
[80.483937] Starting subtest: wait-any-snapshot
[80.566633] Subtest wait-any-snapshot: SUCCESS (0.082s)
[80.652484] [020/133] (924s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[80.742450] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[80.743803] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[80.820404] [021/133] (924s left) sw_sync (sync_merge)
[80.853163] Starting subtest: sync_merge
[80.853850] Subtest sync_merge: SUCCESS (0.000s)
[80.906703] [022/133] (924s left) kms_feature_discovery (display)
[80.991814] Starting subtest: display
[80.992524] Subtest display: SUCCESS (0.000s)
[81.045801] [023/133] (924s left) kms_flip (flip-vs-absolute-wf_vblank)
[81.130354] Starting subtest: flip-vs-absolute-wf_vblank
[81.132681] Starting dynamic subtest: A-HDMI-A1
[88.980818] Dynamic subtest A-HDMI-A1: SUCCESS (7.829s)
[88.986808] Starting dynamic subtest: B-HDMI-A1
[96.789453] Dynamic subtest B-HDMI-A1: SUCCESS (7.798s)
[96.795396] Starting dynamic subtest: C-HDMI-A1
[104.593789] Dynamic subtest C-HDMI-A1: SUCCESS (7.803s)
[104.599024] Starting dynamic subtest: D-HDMI-A1
[112.362309] Dynamic subtest D-HDMI-A1: SUCCESS (7.791s)
[112.362986] Subtest flip-vs-absolute-wf_vblank: SUCCESS (31.230s)
[112.542986] [024/133] (892s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[112.640744] Starting subtest: cursor-rapid-movement-max-size
[112.642796] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[112.741199] [025/133] (892s left) gem_exec_fence (syncobj-export)
[113.071556] Starting subtest: syncobj-export
[113.073126] Subtest syncobj-export: SUCCESS (0.002s)
[113.366283] [026/133] (891s left) gem_exec_reloc (basic-cpu-gtt-active)
[113.404311] Starting subtest: basic-cpu-gtt-active
[113.533284] Subtest basic-cpu-gtt-active: SUCCESS (0.120s)
[113.637857] [027/133] (891s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[113.735458] Starting subtest: x-tiled-16bpp-rotate-270
[113.818146] Subtest x-tiled-16bpp-rotate-270: SKIP (0.076s)
[113.924087] [028/133] (891s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[114.019372] Starting subtest: 4-tiled-addfb-size-offset-overflow
[114.020813] Subtest 4-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[114.098308] [029/133] (891s left) gem_ctx_shared (q-out-order)
[114.141624] Starting subtest: Q-out-order
[114.142324] Starting dynamic subtest: rcs0
[114.187720] Dynamic subtest rcs0: SUCCESS (0.046s)
[114.198870] Starting dynamic subtest: bcs0
[114.240886] Dynamic subtest bcs0: SUCCESS (0.052s)
[114.252620] Starting dynamic subtest: vcs0
[114.294334] Dynamic subtest vcs0: SUCCESS (0.052s)
[114.305953] Starting dynamic subtest: vcs1
[114.351992] Dynamic subtest vcs1: SUCCESS (0.057s)
[114.362611] Starting dynamic subtest: vecs0
[114.403695] Dynamic subtest vecs0: SUCCESS (0.050s)
[114.404707] Subtest Q-out-order: SUCCESS (0.263s)
[114.583592] [030/133] (890s left) gem_exec_balancer (sliced)
[114.626691] Starting subtest: sliced
[116.075631] Subtest sliced: SUCCESS (1.440s)
[116.248214] [031/133] (889s left) gem_ctx_persistence (heartbeat-hang)
[116.284963] Starting subtest: heartbeat-hang
[117.772588] Subtest heartbeat-hang: SUCCESS (1.487s)
[117.847394] [032/133] (887s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[117.937579] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[117.939028] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[118.005623] [033/133] (887s left) i915_pm_rpm (gem-mmap-type)
[119.397769] Starting subtest: gem-mmap-type
[119.398793] Starting dynamic subtest: gtt-smem0
[125.617377] Dynamic subtest gtt-smem0: SUCCESS (6.219s)
[125.623828] Starting dynamic subtest: wb-smem0
[128.147076] Dynamic subtest wb-smem0: SUCCESS (2.529s)
[128.159560] Starting dynamic subtest: wc-smem0
[130.588563] Dynamic subtest wc-smem0: SUCCESS (2.436s)
[130.594466] Starting dynamic subtest: uc-smem0
[133.141363] Dynamic subtest uc-smem0: SUCCESS (2.553s)
[133.145030] Subtest gem-mmap-type: SUCCESS (13.745s)
[133.255997] [034/133] (872s left) prime_vgem (basic-read)
[133.303574] Starting subtest: basic-read
[133.325147] Subtest basic-read: SUCCESS (0.022s)
[133.417464] [035/133] (872s left) gem_exec_balancer (bonded-sync)
[133.461046] Starting subtest: bonded-sync
[148.258764] Subtest bonded-sync: SUCCESS (14.789s)
[148.432695] [036/133] (857s left) gem_wait (invalid-buf)
[148.469582] Starting subtest: invalid-buf
[148.470265] Subtest invalid-buf: SUCCESS (0.000s)
[148.685525] [037/133] (857s left) kms_plane (pixel-format-4-tiled-modifier)
[148.772654] Starting subtest: pixel-format-4-tiled-modifier
[148.773986] Subtest pixel-format-4-tiled-modifier: SKIP (0.000s)
[148.834598] [038/133] (856s left) gem_userptr_blits (sync-overlap)
[148.878569] Starting subtest: sync-overlap
[148.879318] Subtest sync-overlap: SUCCESS (0.000s)
[148.994468] [039/133] (856s left) kms_universal_plane (cursor-fb-leak)
[149.078776] Starting subtest: cursor-fb-leak
[149.080340] Starting dynamic subtest: pipe-A-HDMI-A-1
[149.291160] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.211s)
[149.306386] Starting dynamic subtest: pipe-B-HDMI-A-1
[149.575961] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.281s)
[149.592810] Starting dynamic subtest: pipe-C-HDMI-A-1
[149.855206] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.275s)
[149.863087] Starting dynamic subtest: pipe-D-HDMI-A-1
[150.127836] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.271s)
[150.128586] Subtest cursor-fb-leak: SUCCESS (1.050s)
[150.264437] [040/133] (855s left) syncobj_wait (wait-all-delayed-signal)
[150.300869] Starting subtest: wait-all-delayed-signal
[150.403359] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[150.475808] [041/133] (855s left) gem_render_copy (linear-to-vebox-yf-tiled)
[150.514941] Starting subtest: linear-to-vebox-yf-tiled
[150.515743] Starting dynamic subtest: smem
[150.581664] Dynamic subtest smem: SUCCESS (0.066s)
[150.582392] Subtest linear-to-vebox-yf-tiled: SUCCESS (0.067s)
[150.751219] [042/133] (855s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[150.837682] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[150.838366] Starting dynamic subtest: pipe-A-HDMI-A-1
[150.844883] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[150.851123] Starting dynamic subtest: pipe-B-HDMI-A-1
[150.860865] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[150.867127] Starting dynamic subtest: pipe-C-HDMI-A-1
[150.873857] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[150.879914] Starting dynamic subtest: pipe-D-HDMI-A-1
[150.886628] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[150.887944] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.008s)
[151.082186] [043/133] (854s left) gem_softpin (evict-active-interruptible)
[151.123933] Starting subtest: evict-active-interruptible
[151.128617] Subtest evict-active-interruptible: SUCCESS (0.005s)
[151.245968] [044/133] (854s left) gem_partial_pwrite_pread (writes-after-reads)
[151.282484] Starting subtest: writes-after-reads
[163.524575] Subtest writes-after-reads: SUCCESS (12.239s)
[163.632656] [045/133] (842s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[163.720761] Starting subtest: cursorA-vs-flipB-atomic
[163.722170] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[163.784726] [046/133] (842s left) gen7_exec_parse (basic-allowed)
[163.821373] Subtest basic-allowed: SKIP (0.000s)
[163.861025] [047/133] (842s left) kms_chamelium_frames (hdmi-crc-fast)
[164.001134] Subtest hdmi-crc-fast: SKIP (0.000s)
[164.114801] [048/133] (842s left) kms_chamelium_frames (vga-frame-dump)
[164.253722] Subtest vga-frame-dump: SKIP (0.000s)
[164.342537] [049/133] (841s left) gem_caching (reads)
[164.382435] Starting subtest: reads
[166.339852] Subtest reads: SUCCESS (1.957s)
[166.445827] [050/133] (839s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[166.479516] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[166.480196] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[166.535565] [051/133] (839s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[166.622849] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[166.623538] Starting dynamic subtest: pipe-A-HDMI-A-1
[166.630178] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[166.636613] Starting dynamic subtest: pipe-B-HDMI-A-1
[166.643294] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[166.649570] Starting dynamic subtest: pipe-C-HDMI-A-1
[166.656257] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[166.662415] Starting dynamic subtest: pipe-D-HDMI-A-1
[166.669187] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[166.670522] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SKIP (0.006s)
[166.858607] [052/133] (839s left) kms_async_flips (invalid-async-flip-atomic)
[166.948181] Starting subtest: invalid-async-flip-atomic
[167.080347] Starting dynamic subtest: pipe-A-HDMI-A-1
[167.211443] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.131s)
[167.334565] Starting dynamic subtest: pipe-B-HDMI-A-1
[167.428605] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.101s)
[167.543342] Starting dynamic subtest: pipe-C-HDMI-A-1
[167.636786] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.102s)
[167.747157] Starting dynamic subtest: pipe-D-HDMI-A-1
[167.835522] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.095s)
[167.836259] Subtest invalid-async-flip-atomic: SUCCESS (0.887s)
[168.049412] [053/133] (838s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[168.088567] Starting subtest: y-tiled-to-vebox-yf-tiled
[168.089266] Starting dynamic subtest: smem
[168.162306] Dynamic subtest smem: SUCCESS (0.073s)
[168.164182] Subtest y-tiled-to-vebox-yf-tiled: SUCCESS (0.075s)
[168.344909] [054/133] (838s left) gem_create (create-ext-set-pat)
[168.502115] Starting subtest: create-ext-set-pat
[168.503903] Subtest create-ext-set-pat: SKIP (0.000s)
[168.562241] [055/133] (837s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[168.658866] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[169.250946] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.591s)
[169.352667] [056/133] (837s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[169.386189] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[169.487622] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.101s)
[169.564187] [057/133] (836s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[169.653694] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[169.655055] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[169.746860] [058/133] (836s left) gem_pread (self)
[169.779551] Starting subtest: self
[169.785226] Subtest self: SUCCESS (0.006s)
[169.879866] [059/133] (836s left) gem_exec_reloc (basic-softpin)
[169.918786] Starting subtest: basic-softpin
[169.919784] Subtest basic-softpin: SUCCESS (0.002s)
[170.035063] [060/133] (836s left) prime_vgem (fence-read-hang)
[170.081337] Subtest fence-read-hang: SKIP (0.000s)
[170.179294] [061/133] (836s left) kms_plane_alpha_blend (alpha-transparent-fb)
[170.263904] Starting subtest: alpha-transparent-fb
[170.329701] Starting dynamic subtest: pipe-A-HDMI-A-1
[170.606570] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.277s)
[170.615587] Starting dynamic subtest: pipe-D-HDMI-A-1
[170.940569] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.331s)
[170.941305] Subtest alpha-transparent-fb: SUCCESS (0.677s)
[171.087170] [062/133] (835s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[171.178786] Starting subtest: fbc-rgb565-draw-pwrite
[172.518218] Subtest fbc-rgb565-draw-pwrite: SUCCESS (1.340s)
[172.632144] [063/133] (834s left) kms_joiner (basic-max-non-joiner)
[172.719980] Starting subtest: basic-max-non-joiner
[172.721393] Subtest basic-max-non-joiner: SKIP (0.000s)
[172.778209] [064/133] (834s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[172.862894] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[172.864699] Starting dynamic subtest: pipe-A-HDMI-A-1
[172.871284] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[172.877786] Starting dynamic subtest: pipe-B-HDMI-A-1
[172.884363] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[172.890846] Starting dynamic subtest: pipe-C-HDMI-A-1
[172.897407] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[172.903655] Starting dynamic subtest: pipe-D-HDMI-A-1
[172.910367] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[172.911674] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SKIP (0.007s)
[173.110906] [065/133] (833s left) kms_cursor_edge_walk (256x256-top-edge)
[173.196308] Starting subtest: 256x256-top-edge
[173.198448] Starting dynamic subtest: pipe-A-HDMI-A-1
[174.953336] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.755s)
[174.963311] Starting dynamic subtest: pipe-D-HDMI-A-1
[176.642607] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.687s)
[176.643325] Subtest 256x256-top-edge: SUCCESS (3.446s)
[176.747160] [066/133] (830s left) kms_content_protection (atomic-dpms-hdcp14)
[176.842207] Starting subtest: atomic-dpms-hdcp14
[176.847465] Subtest atomic-dpms-hdcp14: SKIP (0.003s)
[176.937221] [067/133] (829s left) perf_pmu (gt-awake)
[176.973381] Starting subtest: gt-awake
[180.008301] Subtest gt-awake: SUCCESS (3.026s)
[180.083891] [068/133] (826s left) kms_getfb (getfb2-handle-not-fb)
[180.173120] Starting subtest: getfb2-handle-not-fb
[180.173845] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[180.261092] [069/133] (826s left) gen9_exec_parse (batch-invalid-length)
[180.297662] Subtest batch-invalid-length: SKIP (0.000s)
[180.342242] [070/133] (826s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[180.428053] Starting subtest: plane-upscale-20x20-with-pixel-format
[180.428757] Starting dynamic subtest: pipe-A
[181.543872] Dynamic subtest pipe-A: SUCCESS (1.116s)
[181.552095] Starting dynamic subtest: pipe-B
[182.712064] Dynamic subtest pipe-B: SUCCESS (1.167s)
[182.721899] Starting dynamic subtest: pipe-C
[182.913691] Dynamic subtest pipe-C: SUCCESS (0.201s)
[182.923041] Starting dynamic subtest: pipe-D
[183.116922] Dynamic subtest pipe-D: SUCCESS (0.202s)
[183.117673] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (2.690s)
[183.295401] [071/133] (823s left) kms_rotation_crc (primary-rotation-180)
[183.387017] Starting subtest: primary-rotation-180
[186.946717] Subtest primary-rotation-180: SUCCESS (3.560s)
[187.131135] [072/133] (819s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[187.228974] Starting subtest: yf-tiled-32bpp-rotate-0
[187.230325] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[187.310822] [073/133] (819s left) device_reset (unbind-cold-reset-rebind)
[187.357773] Starting subtest: unbind-cold-reset-rebind
[187.359115] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[187.412492] [074/133] (819s left) kms_psr (psr2-no-drrs)
[187.498861] Subtest psr2-no-drrs: SKIP (0.000s)
[187.542521] [075/133] (819s left) gem_fence_thrash (bo-write-verify-threaded-y)
[187.576168] Starting subtest: bo-write-verify-threaded-y
[191.961587] Subtest bo-write-verify-threaded-y: SUCCESS (4.352s)
[192.053097] [076/133] (815s left) kms_lease (master-vs-lease)
[192.144057] Starting subtest: master-vs-lease
[192.144836] Subtest master-vs-lease: SUCCESS (0.001s)
[192.204632] [077/133] (815s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[192.296827] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[192.298210] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[192.391143] [078/133] (814s left) kms_big_fb (linear-8bpp-rotate-270)
[192.486969] Starting subtest: linear-8bpp-rotate-270
[192.559942] Subtest linear-8bpp-rotate-270: SKIP (0.073s)
[192.683903] [079/133] (814s left) kms_cursor_crc (cursor-offscreen-512x170)
[192.778968] Starting subtest: cursor-offscreen-512x170
[192.780428] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[192.866781] [080/133] (814s left) gem_exec_reloc (basic-write-wc-active)
[192.905131] Starting subtest: basic-write-wc-active
[193.035714] Subtest basic-write-wc-active: SUCCESS (0.122s)
[193.147030] [081/133] (814s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[193.236733] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[193.238110] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[193.331291] [082/133] (814s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[193.419785] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[193.421101] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[193.515604] [083/133] (814s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[193.599885] Starting subtest: primary-4-tiled-reflect-x-0
[193.654211] Subtest primary-4-tiled-reflect-x-0: SKIP (0.053s)
[193.742830] [084/133] (813s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[193.831823] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[195.053639] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (1.222s)
[195.174184] [085/133] (812s left) prime_mmap_coherency (ioctl-errors)
[195.211214] Starting subtest: ioctl-errors
[200.077559] Subtest ioctl-errors: SUCCESS (4.866s)
[200.231682] [086/133] (807s left) kms_pm_dc (dc5-dpms)
[201.394823] Starting subtest: dc5-dpms
[202.715227] Subtest dc5-dpms: SUCCESS (1.311s)
[202.779883] [087/133] (804s left) gem_busy (extended)
[202.960863] Starting subtest: extended
[202.961861] Starting dynamic subtest: rcs0
[202.979375] Dynamic subtest rcs0: SUCCESS (0.028s)
[202.995113] Starting dynamic subtest: bcs0
[202.997761] Dynamic subtest bcs0: SUCCESS (0.016s)
[203.007831] Starting dynamic subtest: vcs0
[203.011762] Dynamic subtest vcs0: SUCCESS (0.013s)
[203.021373] Starting dynamic subtest: vcs1
[203.027801] Dynamic subtest vcs1: SUCCESS (0.015s)
[203.036714] Starting dynamic subtest: vecs0
[203.046152] Dynamic subtest vecs0: SUCCESS (0.017s)
[203.046927] Subtest extended: SUCCESS (0.097s)
[203.277434] [088/133] (804s left) kms_cursor_legacy (torture-move)
[203.365883] Starting subtest: torture-move
[203.366585] Starting dynamic subtest: pipe-A
[208.935597] Dynamic subtest pipe-A: SUCCESS (5.557s)
[208.946113] Starting dynamic subtest: pipe-B
[214.549551] Dynamic subtest pipe-B: SUCCESS (5.589s)
[214.558623] Starting dynamic subtest: pipe-C
[220.303284] Dynamic subtest pipe-C: SUCCESS (5.778s)
[220.311314] Starting dynamic subtest: pipe-D
[226.272188] Dynamic subtest pipe-D: SUCCESS (5.943s)
[226.284632] Starting dynamic subtest: all-pipes
[231.764983] Dynamic subtest all-pipes: SUCCESS (5.492s)
[231.766073] Subtest torture-move: SUCCESS (28.366s)
[231.825150] [089/133] (776s left) prime_mmap (test_refcounting)
[231.863360] Starting subtest: test_refcounting
[231.864071] Starting dynamic subtest: test_refcounting-smem
[231.865822] Dynamic subtest test_refcounting-smem: SUCCESS (0.002s)
[231.866535] Subtest test_refcounting: SUCCESS (0.003s)
[231.956399] [090/133] (775s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[232.046352] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[232.089913] [091/133] (775s left) syncobj_timeline (invalid-signal-zero-handles)
[232.124665] Starting subtest: invalid-signal-zero-handles
[232.125344] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[232.192350] [092/133] (775s left) kms_big_fb (y-tiled-addfb)
[232.291241] Starting subtest: y-tiled-addfb
[232.291936] Subtest y-tiled-addfb: SUCCESS (0.000s)
[232.407377] [093/133] (775s left) i915_drm_fdinfo (busy)
[232.443415] Starting subtest: busy
[232.444122] Starting dynamic subtest: rcs0
[232.963521] Dynamic subtest rcs0: SUCCESS (0.518s)
[232.973775] Starting dynamic subtest: bcs0
[233.491475] Dynamic subtest bcs0: SUCCESS (0.527s)
[233.502903] Starting dynamic subtest: vcs0
[234.014453] Dynamic subtest vcs0: SUCCESS (0.520s)
[234.027122] Starting dynamic subtest: vcs1
[234.539262] Dynamic subtest vcs1: SUCCESS (0.524s)
[234.550355] Starting dynamic subtest: vecs0
[235.061434] Dynamic subtest vecs0: SUCCESS (0.520s)
[235.062410] Subtest busy: SUCCESS (2.619s)
[235.139874] [094/133] (772s left) i915_drm_fdinfo (virtual-busy-idle-all)
[235.175226] Starting subtest: virtual-busy-idle-all
[235.794164] Subtest virtual-busy-idle-all: SUCCESS (0.616s)
[235.858447] [095/133] (772s left) gem_close (many-handles-one-vma)
[235.896047] Starting subtest: many-handles-one-vma
[235.919852] Subtest many-handles-one-vma: SUCCESS (0.024s)
[236.033241] [096/133] (772s left) api_intel_bb (reset-bb)
[236.067036] Starting subtest: reset-bb
[236.069272] Subtest reset-bb: SUCCESS (0.002s)
[236.183236] [097/133] (772s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[236.276623] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[236.279177] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[236.369790] [098/133] (771s left) prime_mmap (test_invalid_sync_flags)
[236.402955] Starting subtest: test_invalid_sync_flags
[236.403706] Starting dynamic subtest: test_invalid_sync_flags-smem
[236.404386] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[236.405092] Subtest test_invalid_sync_flags: SUCCESS (0.001s)
[236.526488] [099/133] (771s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[236.615375] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[236.617646] Starting dynamic subtest: pipe-A-valid-mode
[237.431579] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.813s)
[237.432367] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SUCCESS (0.816s)
[237.606146] [100/133] (770s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[237.702847] Starting subtest: flip-vs-cursor-atomic-transitions
[244.472894] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (6.770s)
[244.612738] [101/133] (763s left) kms_psr (fbc-psr2-cursor-render)
[244.708526] Subtest fbc-psr2-cursor-render: SKIP (0.000s)
[244.757865] [102/133] (763s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[244.849004] Starting subtest: plane-lut1d-ctm3x4
[244.933783] Starting dynamic subtest: pipe-A-plane-0
[245.033073] Dynamic subtest pipe-A-plane-0: SUCCESS (0.099s)
[245.050392] Starting dynamic subtest: pipe-A-plane-1
[245.141115] Dynamic subtest pipe-A-plane-1: SUCCESS (0.105s)
[245.155472] Starting dynamic subtest: pipe-A-plane-2
[245.232903] Dynamic subtest pipe-A-plane-2: SUCCESS (0.089s)
[245.431368] Starting dynamic subtest: pipe-B-plane-0
[245.516055] Dynamic subtest pipe-B-plane-0: SUCCESS (0.091s)
[245.531228] Starting dynamic subtest: pipe-B-plane-1
[245.607701] Dynamic subtest pipe-B-plane-1: SUCCESS (0.089s)
[245.622576] Starting dynamic subtest: pipe-B-plane-2
[245.699477] Dynamic subtest pipe-B-plane-2: SUCCESS (0.089s)
[245.900592] Starting dynamic subtest: pipe-C-plane-0
[245.990723] Dynamic subtest pipe-C-plane-0: SUCCESS (0.100s)
[246.004915] Starting dynamic subtest: pipe-C-plane-1
[246.083056] Dynamic subtest pipe-C-plane-1: SUCCESS (0.089s)
[246.096258] Starting dynamic subtest: pipe-C-plane-2
[246.182115] Dynamic subtest pipe-C-plane-2: SUCCESS (0.098s)
[246.390991] Starting dynamic subtest: pipe-D-plane-0
[246.479188] Dynamic subtest pipe-D-plane-0: SUCCESS (0.099s)
[246.494517] Starting dynamic subtest: pipe-D-plane-1
[246.578832] Dynamic subtest pipe-D-plane-1: SUCCESS (0.096s)
[246.591767] Starting dynamic subtest: pipe-D-plane-2
[246.679454] Dynamic subtest pipe-D-plane-2: SUCCESS (0.098s)
[246.735480] Subtest plane-lut1d-ctm3x4: SUCCESS (1.887s)
[246.841599] [103/133] (761s left) gem_mmap_gtt (hang-busy)
[246.876414] Starting subtest: hang-busy
[283.260194] Subtest hang-busy: SUCCESS (36.377s)
[283.347627] [104/133] (725s left) kms_plane_lowres (tiling-none)
[283.436956] Starting subtest: tiling-none
[283.437754] Starting dynamic subtest: pipe-A-HDMI-A-1
[288.602034] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (5.165s)
[288.683559] Starting dynamic subtest: pipe-B-HDMI-A-1
[293.688606] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (5.011s)
[293.771219] Starting dynamic subtest: pipe-C-HDMI-A-1
[298.790919] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (5.029s)
[298.866981] Starting dynamic subtest: pipe-D-HDMI-A-1
[303.848776] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (4.990s)
[303.923667] Subtest tiling-none: SUCCESS (20.487s)
[304.067859] [105/133] (704s left) gem_ctx_isolation (nonpriv)
[304.133386] Starting subtest: nonpriv
[304.134142] Starting dynamic subtest: rcs0
[304.372240] Dynamic subtest rcs0: SUCCESS (0.230s)
[304.379632] Starting dynamic subtest: bcs0
[304.649323] Dynamic subtest bcs0: SUCCESS (0.280s)
[304.656809] Starting dynamic subtest: vcs0
[304.925627] Dynamic subtest vcs0: SUCCESS (0.271s)
[304.941592] Starting dynamic subtest: vcs1
[305.191933] Dynamic subtest vcs1: SUCCESS (0.274s)
[305.200972] Starting dynamic subtest: vecs0
[305.464487] Dynamic subtest vecs0: SUCCESS (0.271s)
[305.465210] Subtest nonpriv: SUCCESS (1.333s)
[305.649450] [106/133] (702s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[305.741064] Starting subtest: addfb25-x-tiled-mismatch-legacy
[305.741789] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[305.834689] [107/133] (702s left) prime_busy (before)
[305.872186] Starting subtest: before
[305.877203] Starting dynamic subtest: rcs0
[305.907261] Dynamic subtest rcs0: SUCCESS (0.030s)
[305.923839] Starting dynamic subtest: bcs0
[305.928181] Dynamic subtest bcs0: SUCCESS (0.019s)
[305.939393] Starting dynamic subtest: vcs0
[305.950668] Dynamic subtest vcs0: SUCCESS (0.021s)
[305.962448] Starting dynamic subtest: vcs1
[305.967095] Dynamic subtest vcs1: SUCCESS (0.015s)
[305.975923] Starting dynamic subtest: vecs0
[305.986031] Dynamic subtest vecs0: SUCCESS (0.018s)
[306.095974] Subtest before: SUCCESS (0.222s)
[306.168750] [108/133] (702s left) kms_cdclk (plane-scaling)
[306.203688] Subtest plane-scaling: SKIP (0.000s)
[306.244643] [109/133] (702s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[306.338395] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[306.339853] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[306.417427] [110/133] (702s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[306.507805] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[306.509173] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[306.614145] [111/133] (702s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[306.704692] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[306.706036] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[306.791127] [112/133] (702s left) gem_softpin (allocator-nopin-reserve)
[306.828284] Starting subtest: allocator-nopin-reserve
[306.919334] Subtest allocator-nopin-reserve: SUCCESS (0.091s)
[307.047079] [113/133] (701s left) perf (gen12-unprivileged-single-ctx-counters)
[307.145569] Starting subtest: gen12-unprivileged-single-ctx-counters
[307.146262] Starting dynamic subtest: rcs0
[307.282818] Dynamic subtest rcs0: SUCCESS (0.136s)
[307.283567] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.138s)
[307.326426] [114/133] (701s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[307.417690] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[307.419048] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[307.508401] [115/133] (701s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[307.597034] Starting subtest: primary-x-tiled-reflect-x-180
[311.143114] Subtest primary-x-tiled-reflect-x-180: SUCCESS (3.546s)
[311.353263] [116/133] (697s left) sysfs_heartbeat_interval (mixed)
[311.392082] Starting subtest: mixed
[311.394412] Starting dynamic subtest: vecs0
[316.523969] Dynamic subtest vecs0: SUCCESS (5.130s)
[316.538128] Starting dynamic subtest: vcs0
[321.672287] Dynamic subtest vcs0: SUCCESS (5.145s)
[321.683378] Starting dynamic subtest: bcs0
[326.844360] Dynamic subtest bcs0: SUCCESS (5.169s)
[326.855660] Starting dynamic subtest: rcs0
[332.029218] Dynamic subtest rcs0: SUCCESS (5.182s)
[332.042981] Starting dynamic subtest: vcs1
[337.162160] Dynamic subtest vcs1: SUCCESS (5.130s)
[337.163469] Subtest mixed: SUCCESS (25.771s)
[337.240873] [117/133] (671s left) i915_selftest (live)
[338.177750] Starting subtest: live
[338.178648] Starting dynamic subtest: sanitycheck
[339.452597] Dynamic subtest sanitycheck: SUCCESS (1.267s)
[339.460183] Starting dynamic subtest: uncore
[340.648863] Dynamic subtest uncore: SUCCESS (1.194s)
[340.655812] Starting dynamic subtest: workarounds
[342.178539] Dynamic subtest workarounds: SUCCESS (1.528s)
[342.185446] Starting dynamic subtest: gt_engines
[343.930594] Dynamic subtest gt_engines: SUCCESS (1.750s)
[343.937602] Starting dynamic subtest: gt_timelines
[352.490711] Dynamic subtest gt_timelines: SUCCESS (8.558s)
[352.499781] Starting dynamic subtest: gt_contexts
[353.833829] Dynamic subtest gt_contexts: SUCCESS (1.341s)
[353.849236] Starting dynamic subtest: gt_lrc
[357.994695] Dynamic subtest gt_lrc: SUCCESS (4.158s)
[358.005607] Starting dynamic subtest: gt_mocs
[359.332417] Dynamic subtest gt_mocs: SUCCESS (1.336s)
[359.339666] Starting dynamic subtest: gt_pm
[380.443720] Dynamic subtest gt_pm: SUCCESS (21.109s)
[380.454392] Starting dynamic subtest: gt_heartbeat
[381.658728] Dynamic subtest gt_heartbeat: SUCCESS (1.213s)
[381.669696] Starting dynamic subtest: gt_tlb
[385.108659] Dynamic subtest gt_tlb: SUCCESS (3.448s)
[385.121186] Starting dynamic subtest: requests
[393.701621] Dynamic subtest requests: SUCCESS (8.591s)
[393.708691] Starting dynamic subtest: migrate
[397.988601] Dynamic subtest migrate: SUCCESS (4.285s)
[397.995333] Starting dynamic subtest: active
[399.196679] Dynamic subtest active: SUCCESS (1.206s)
[399.207303] Starting dynamic subtest: objects
[400.851697] Dynamic subtest objects: SUCCESS (1.653s)
[400.862410] Starting dynamic subtest: mman
[405.543547] Dynamic subtest mman: SUCCESS (4.690s)
[405.554138] Starting dynamic subtest: dmabuf
[406.781635] Dynamic subtest dmabuf: SUCCESS (1.236s)
[406.788622] Starting dynamic subtest: vma
[407.965649] Dynamic subtest vma: SUCCESS (1.182s)
[407.972760] Starting dynamic subtest: coherency
[412.044730] Dynamic subtest coherency: SUCCESS (4.077s)
[412.052176] Starting dynamic subtest: gtt
[420.397800] Dynamic subtest gtt: SUCCESS (8.351s)
[420.408394] Starting dynamic subtest: gem
[422.541706] Dynamic subtest gem: SUCCESS (2.142s)
[422.548726] Starting dynamic subtest: evict
[424.741544] Dynamic subtest evict: SUCCESS (2.198s)
[424.748837] Starting dynamic subtest: hugepages
[432.453749] Dynamic subtest hugepages: SUCCESS (7.710s)
[432.461303] Starting dynamic subtest: gem_contexts
[447.870651] Dynamic subtest gem_contexts: SUCCESS (15.415s)
[447.878015] Starting dynamic subtest: client
[449.130841] Dynamic subtest client: SUCCESS (1.258s)
[449.138632] Starting dynamic subtest: gem_migrate
[450.329633] Dynamic subtest gem_migrate: SUCCESS (1.197s)
[450.337261] Starting dynamic subtest: reset
[455.212663] Dynamic subtest reset: SUCCESS (4.881s)
[455.222208] Starting dynamic subtest: memory_region
[456.404644] Dynamic subtest memory_region: SUCCESS (1.190s)
[456.411690] Starting dynamic subtest: hangcheck
[486.346557] Dynamic subtest hangcheck: SUCCESS (29.940s)
[486.354093] Starting dynamic subtest: execlists
[500.118741] Dynamic subtest execlists: SUCCESS (13.770s)
[500.126358] Starting dynamic subtest: ring_submission
[501.301615] Dynamic subtest ring_submission: SUCCESS (1.181s)
[501.313653] Starting dynamic subtest: perf
[502.570599] Dynamic subtest perf: SUCCESS (1.267s)
[502.577770] Starting dynamic subtest: slpc
[503.753845] Dynamic subtest slpc: SUCCESS (1.181s)
[503.764710] Starting dynamic subtest: guc
[504.928506] Dynamic subtest guc: SUCCESS (1.173s)
[504.940524] Starting dynamic subtest: guc_multi_lrc
[506.140904] Dynamic subtest guc_multi_lrc: SUCCESS (1.210s)
[506.148387] Starting dynamic subtest: guc_hang
[507.306658] Dynamic subtest guc_hang: SUCCESS (1.163s)
[507.317745] Starting dynamic subtest: late_gt_pm
[508.563742] Dynamic subtest late_gt_pm: SUCCESS (1.255s)
[508.564533] Subtest live: SUCCESS (170.381s)
[508.591775] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[508.592577] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[508.595655] [118/133] (500s left) gem_exec_flush (basic-uc-set-default)
[509.645115] Starting subtest: basic-uc-set-default
[515.071996] Subtest basic-uc-set-default: SUCCESS (5.427s)
[515.258425] [FACT gem_exec_flush (basic-uc-set-default)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[515.259749] [FACT gem_exec_flush (basic-uc-set-default)] new: kernel.kmod_is_loaded.i915: true
[515.263493] [119/133] (493s left) gem_exec_schedule (u-submit-late-slice)
[515.322981] Starting subtest: u-submit-late-slice
[515.323808] Starting dynamic subtest: rcs0
[515.344394] Dynamic subtest rcs0: SUCCESS (0.031s)
[515.355075] Starting dynamic subtest: bcs0
[515.374104] Dynamic subtest bcs0: SUCCESS (0.029s)
[515.386418] Starting dynamic subtest: vcs0
[515.403128] Dynamic subtest vcs0: SUCCESS (0.028s)
[515.412613] Starting dynamic subtest: vcs1
[515.427069] Dynamic subtest vcs1: SUCCESS (0.023s)
[515.435723] Starting dynamic subtest: vecs0
[515.456232] Dynamic subtest vecs0: SUCCESS (0.028s)
[515.457038] Subtest u-submit-late-slice: SUCCESS (0.144s)
[515.750267] [120/133] (493s left) gem_ctx_bad_destroy (invalid-pad)
[515.783697] Starting subtest: invalid-pad
[515.784365] Subtest invalid-pad: SUCCESS (0.000s)
[515.860288] [121/133] (493s left) kms_psr2_su (page_flip-xrgb8888)
[515.894697] Subtest page_flip-XRGB8888: SKIP (0.000s)
[515.941522] [122/133] (493s left) kms_flip (2x-busy-flip)
[516.033947] Starting subtest: 2x-busy-flip
[516.043559] Subtest 2x-busy-flip: SKIP (0.009s)
[516.109826] [123/133] (493s left) syncobj_timeline (multi-wait-for-submit-signaled)
[516.144572] Starting subtest: multi-wait-for-submit-signaled
[516.145267] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[516.202205] [124/133] (493s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[516.291074] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[516.292899] Starting dynamic subtest: pipe-A-HDMI-A-1
[517.036812] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.741s)
[517.050062] Starting dynamic subtest: pipe-B-HDMI-A-1
[517.431967] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.389s)
[517.450312] Starting dynamic subtest: pipe-C-HDMI-A-1
[517.824907] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.387s)
[517.841411] Starting dynamic subtest: pipe-D-HDMI-A-1
[518.210876] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.381s)
[518.211852] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SUCCESS (1.918s)
[518.407240] [125/133] (490s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[518.501476] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[518.502927] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[518.600826] [126/133] (490s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[518.690989] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[518.692395] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[518.797282] [127/133] (490s left) kms_properties (colorop-properties-atomic)
[518.884438] Starting subtest: colorop-properties-atomic
[518.886809] Starting dynamic subtest: pipe-A-HDMI-A-1
[518.957306] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.071s)
[518.965165] Starting dynamic subtest: pipe-B-HDMI-A-1
[519.054762] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.096s)
[519.065749] Starting dynamic subtest: pipe-C-HDMI-A-1
[519.191165] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.134s)
[519.202112] Starting dynamic subtest: pipe-D-HDMI-A-1
[519.329361] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.136s)
[519.330122] Subtest colorop-properties-atomic: SUCCESS (0.445s)
[519.463726] [128/133] (490s left) syncobj_wait (multi-wait-submitted)
[519.499681] Starting subtest: multi-wait-submitted
[519.609177] Subtest multi-wait-submitted: SUCCESS (0.107s)
[519.682294] [129/133] (489s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[519.772180] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[519.773549] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[519.862810] [130/133] (489s left) kms_psr (pr-cursor-mmap-gtt)
[519.949536] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[519.990494] [131/133] (489s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[520.024234] Starting subtest: single-wait-all-for-submit-signaled
[520.024934] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[520.090078] [132/133] (489s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[520.123794] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[520.232387] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.108s)
[520.327142] [133/133] (489s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[520.414054] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.000s)
[520.462285] 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.