[57.996378] Initializing watchdogs
[57.996427]   /dev/watchdog0
[58.011266] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.017875] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.020173] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.023569] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[58.150307] Starting subtest: fbcpsr-rgb101010-draw-render
[64.889835] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.741s)
[65.014079] [002/133] (953s left) kms_plane (pixel-format-y-tiled-modifier)
[65.100910] Starting subtest: pixel-format-y-tiled-modifier
[65.104982] Subtest pixel-format-y-tiled-modifier: SKIP (0.000s)
[65.168163] [003/133] (953s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[65.271098] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[65.275309] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[65.373738] [004/133] (953s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[65.478596] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[65.482722] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[65.590578] [005/133] (953s left) gem_exec_whisper (basic-contexts-all)
[65.651661] Starting subtest: basic-contexts-all
[76.751026] Subtest basic-contexts-all: SUCCESS (11.096s)
[76.933941] [006/133] (941s left) i915_drm_fdinfo (busy-check-all)
[76.979100] Starting subtest: busy-check-all
[76.981651] Starting dynamic subtest: rcs0
[76.986443] Dynamic subtest rcs0: SKIP (0.004s)
[76.996267] Starting dynamic subtest: bcs0
[77.000771] Dynamic subtest bcs0: SKIP (0.000s)
[77.007860] Starting dynamic subtest: vcs0
[77.012276] Dynamic subtest vcs0: SKIP (0.000s)
[77.019696] Starting dynamic subtest: vcs1
[77.024084] Dynamic subtest vcs1: SKIP (0.000s)
[77.031381] Starting dynamic subtest: vecs0
[77.035777] Dynamic subtest vecs0: SKIP (0.000s)
[77.043180] Starting dynamic subtest: ccs0
[77.047178] Dynamic subtest ccs0: SKIP (0.000s)
[77.051252] Subtest busy-check-all: SKIP (0.008s)
[77.088241] [007/133] (941s left) kms_getfb (getfb-reject-nv12)
[77.190585] Starting subtest: getfb-reject-nv12
[77.192720] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[77.286798] [008/133] (941s left) kms_psr (fbc-pr-sprite-plane-onoff)
[77.381706] Starting subtest: fbc-pr-sprite-plane-onoff
[77.385714] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[77.455392] [009/133] (941s left) gem_caching (read-writes)
[77.506574] Subtest read-writes: SKIP (0.000s)
[77.568793] [010/133] (941s left) prime_mmap (test_forked_cpu_write)
[77.626553] Starting subtest: test_forked_cpu_write
[77.629038] Starting dynamic subtest: test_forked_cpu_write-smem
[77.633719] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.009s)
[77.636060] Subtest test_forked_cpu_write: SUCCESS (0.010s)
[77.747241] [011/133] (941s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[77.837305] Starting subtest: primary-yf-tiled-reflect-x-0
[77.896893] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.059s)
[78.012493] [012/133] (940s left) sysfs_preempt_timeout (invalid)
[78.070735] Starting subtest: invalid
[78.072532] Starting dynamic subtest: vecs0
[78.074464] Dynamic subtest vecs0: SUCCESS (0.000s)
[78.081943] Starting dynamic subtest: ccs0
[78.083963] Dynamic subtest ccs0: SUCCESS (0.000s)
[78.090865] Starting dynamic subtest: vcs0
[78.092683] Dynamic subtest vcs0: SUCCESS (0.000s)
[78.099560] Starting dynamic subtest: bcs0
[78.101396] Dynamic subtest bcs0: SUCCESS (0.000s)
[78.108305] Starting dynamic subtest: rcs0
[78.110256] Dynamic subtest rcs0: SUCCESS (0.000s)
[78.117105] Starting dynamic subtest: vcs1
[78.118903] Dynamic subtest vcs1: SUCCESS (0.000s)
[78.120855] Subtest invalid: SUCCESS (0.003s)
[78.162815] [013/133] (940s left) perf_pmu (busy-idle-no-semaphores)
[78.206471] Starting subtest: busy-idle-no-semaphores
[78.208641] Starting dynamic subtest: rcs0
[78.867396] Dynamic subtest rcs0: SUCCESS (0.662s)
[78.876261] Starting dynamic subtest: bcs0
[79.517305] Dynamic subtest bcs0: SUCCESS (0.647s)
[79.527699] Starting dynamic subtest: vcs0
[80.170511] Dynamic subtest vcs0: SUCCESS (0.652s)
[80.181187] Starting dynamic subtest: vcs1
[81.534053] Dynamic subtest vcs1: SUCCESS (1.362s)
[81.544742] Starting dynamic subtest: vecs0
[83.517647] Dynamic subtest vecs0: SUCCESS (1.982s)
[83.528507] Starting dynamic subtest: ccs0
[85.503602] Dynamic subtest ccs0: SUCCESS (1.985s)
[85.506582] Subtest busy-idle-no-semaphores: SUCCESS (7.297s)
[85.630864] [014/133] (933s left) gem_create (create-massive)
[85.694845] Starting subtest: create-massive
[85.697180] Subtest create-massive: SUCCESS (0.000s)
[85.877949] [015/133] (933s left) sw_sync (sync_multi_consumer)
[85.917433] Starting subtest: sync_multi_consumer
[86.346661] Subtest sync_multi_consumer: SUCCESS (0.429s)
[86.423582] [016/133] (932s left) gem_vm_create (execbuf)
[86.475361] Starting subtest: execbuf
[86.485708] Subtest execbuf: SUCCESS (0.012s)
[86.596402] [017/133] (932s left) kms_addfb_basic (bad-pitch-256)
[86.645922] Starting subtest: bad-pitch-256
[86.648259] Subtest bad-pitch-256: SUCCESS (0.000s)
[86.779055] [018/133] (932s left) gem_exec_fence (basic-busy-all)
[86.843782] Starting subtest: basic-busy-all
[86.902462] Subtest basic-busy-all: SUCCESS (0.060s)
[88.993708] [FACT gem_exec_fence (basic-busy-all)] new: kernel.kmod_is_loaded.vgem: true
[88.996804] [019/133] (930s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[89.119943] Starting subtest: basic-flip-after-cursor-atomic
[90.075068] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.956s)
[90.878470] [020/133] (928s left) kms_psr (psr-sprite-mmap-gtt)
[90.968053] Starting subtest: psr-sprite-mmap-gtt
[90.970300] Starting dynamic subtest: eDP-1
[92.407576] Dynamic subtest eDP-1: SKIP (1.436s)
[92.412452] Subtest psr-sprite-mmap-gtt: SKIP (1.438s)
[92.581462] [021/133] (926s left) kms_pipe_stress (stress-xrgb8888-yftiled)
[92.668763] Starting subtest: stress-xrgb8888-yftiled
[92.673240] Subtest stress-xrgb8888-yftiled: SKIP (0.000s)
[92.742625] [022/133] (926s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[92.855262] Starting subtest: basic-busy-flip-before-cursor-varying-size
[92.859878] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[93.011634] [023/133] (926s left) gem_tiled_partial_pwrite_pread (reads)
[93.068352] Subtest reads: SKIP (0.000s)
[93.138038] [024/133] (926s left) gem_exec_balancer (individual)
[93.191500] Starting subtest: individual
[94.908586] Subtest individual: SUCCESS (1.715s)
[95.212762] [025/133] (924s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[95.302863] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[95.306963] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.000s)
[95.373643] [026/133] (924s left) i915_selftest (live)
[97.009748] Starting subtest: live
[97.012251] Starting dynamic subtest: sanitycheck
[99.720204] Dynamic subtest sanitycheck: SUCCESS (2.710s)
[99.729659] Starting dynamic subtest: uncore
[104.080558] Dynamic subtest uncore: SUCCESS (4.360s)
[104.089203] Starting dynamic subtest: workarounds
[121.792309] Dynamic subtest workarounds: FAIL (17.568s)
[121.798644] Starting dynamic subtest: gt_engines
[124.664901] Dynamic subtest gt_engines: SUCCESS (3.014s)
[124.673277] Starting dynamic subtest: gt_timelines
[140.696518] Dynamic subtest gt_timelines: SUCCESS (16.031s)
[140.705740] Starting dynamic subtest: gt_contexts
[145.023951] Dynamic subtest gt_contexts: SUCCESS (4.325s)
[145.031515] Starting dynamic subtest: gt_lrc
[151.105491] Dynamic subtest gt_lrc: SUCCESS (6.080s)
[151.119534] Starting dynamic subtest: gt_mocs
[155.485430] Dynamic subtest gt_mocs: SUCCESS (4.376s)
[155.497602] Starting dynamic subtest: gt_pm
[162.184930] Dynamic subtest gt_pm: SUCCESS (6.701s)
[162.199166] Starting dynamic subtest: gt_heartbeat
[166.540205] Dynamic subtest gt_heartbeat: SUCCESS (4.353s)
[166.548921] Starting dynamic subtest: gt_tlb
[175.874103] Dynamic subtest gt_tlb: SUCCESS (9.333s)
[175.882452] Starting dynamic subtest: requests
[189.356671] Dynamic subtest requests: SUCCESS (13.481s)
[189.370557] Starting dynamic subtest: migrate
[197.008919] Dynamic subtest migrate: SUCCESS (7.650s)
[197.017904] Starting dynamic subtest: active
[201.301780] Dynamic subtest active: SUCCESS (4.292s)
[201.309196] Starting dynamic subtest: objects
[205.998495] Dynamic subtest objects: SUCCESS (4.695s)
[206.008231] Starting dynamic subtest: mman
[210.825660] Dynamic subtest mman: SUCCESS (4.826s)
[210.834343] Starting dynamic subtest: dmabuf
[215.179045] Dynamic subtest dmabuf: SUCCESS (4.352s)
[215.188143] Starting dynamic subtest: vma
[219.480071] Dynamic subtest vma: SUCCESS (4.300s)
[219.495313] Starting dynamic subtest: coherency
[224.442820] Dynamic subtest coherency: SUCCESS (4.961s)
[224.450782] Starting dynamic subtest: gtt
[236.234248] Dynamic subtest gtt: SUCCESS (11.790s)
[236.242696] Starting dynamic subtest: gem
[244.521841] Dynamic subtest gem: SUCCESS (8.287s)
[244.530804] Starting dynamic subtest: evict
[248.561067] Dynamic subtest evict: SUCCESS (4.037s)
[248.570177] Starting dynamic subtest: hugepages
[259.271067] Dynamic subtest hugepages: SUCCESS (10.708s)
[259.279954] Starting dynamic subtest: gem_contexts
[288.493459] Dynamic subtest gem_contexts: SUCCESS (29.219s)
[288.502516] Starting dynamic subtest: client
[292.762068] Dynamic subtest client: SUCCESS (4.268s)
[292.771407] Starting dynamic subtest: gem_migrate
[297.061024] Dynamic subtest gem_migrate: SUCCESS (4.297s)
[297.070142] Starting dynamic subtest: reset
[299.800900] Dynamic subtest reset: SUCCESS (2.738s)
[299.808259] Starting dynamic subtest: memory_region
[304.107219] Dynamic subtest memory_region: SUCCESS (4.304s)
[304.116287] Starting dynamic subtest: hangcheck
[317.160519] Dynamic subtest hangcheck: SUCCESS (13.051s)
[317.169356] Starting dynamic subtest: execlists
[319.889515] Dynamic subtest execlists: SUCCESS (2.728s)
[319.898246] Starting dynamic subtest: ring_submission
[324.173420] Dynamic subtest ring_submission: SUCCESS (4.282s)
[324.182688] Starting dynamic subtest: perf
[328.472964] Dynamic subtest perf: SUCCESS (4.298s)
[328.481856] Starting dynamic subtest: slpc
[342.568254] Dynamic subtest slpc: SUCCESS (14.093s)
[342.577311] Starting dynamic subtest: guc
[346.511033] Dynamic subtest guc: SUCCESS (3.941s)
[346.520233] Starting dynamic subtest: guc_multi_lrc
[350.810197] Dynamic subtest guc_multi_lrc: SUCCESS (4.298s)
[350.819572] Starting dynamic subtest: guc_hang
[355.623960] Dynamic subtest guc_hang: SUCCESS (4.812s)
[355.633080] Starting dynamic subtest: late_gt_pm
[358.422073] Dynamic subtest late_gt_pm: SUCCESS (2.797s)
[358.425046] Subtest live: FAIL (261.403s)
[358.453592] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[358.454338] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[358.457458] [027/133] (661s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[360.327959] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[361.165333] [FACT kms_chamelium_frames (hdmi-cmp-planar-formats)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[361.166607] [FACT kms_chamelium_frames (hdmi-cmp-planar-formats)] new: kernel.kmod_is_loaded.i915: true
[361.170373] [028/133] (658s left) gem_exec_schedule (pi-shared-iova)
[361.359668] Starting subtest: pi-shared-iova
[361.362065] Starting dynamic subtest: rcs0
[361.442844] Dynamic subtest rcs0: SUCCESS (0.086s)
[361.451070] Starting dynamic subtest: vcs0
[361.499630] Dynamic subtest vcs0: SUCCESS (0.056s)
[361.511090] Starting dynamic subtest: vcs1
[361.550474] Dynamic subtest vcs1: SUCCESS (0.050s)
[361.561668] Starting dynamic subtest: vecs0
[361.606497] Dynamic subtest vecs0: SUCCESS (0.055s)
[361.617079] Starting dynamic subtest: ccs0
[361.661800] Dynamic subtest ccs0: SUCCESS (0.055s)
[361.664512] Subtest pi-shared-iova: SUCCESS (0.307s)
[363.010327] [029/133] (656s left) kms_busy (extended-modeset-hang-oldfb)
[363.098061] Starting subtest: extended-modeset-hang-oldfb
[363.100330] Starting dynamic subtest: pipe-A
[374.770743] Dynamic subtest pipe-A: SUCCESS (11.671s)
[374.778839] Starting dynamic subtest: pipe-D
[387.045850] Dynamic subtest pipe-D: SUCCESS (12.272s)
[387.048362] Subtest extended-modeset-hang-oldfb: SUCCESS (23.948s)
[387.846816] [030/133] (631s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[387.904365] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[387.981452] [031/133] (631s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[388.064818] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[388.067068] Starting dynamic subtest: pipe-A-eDP-1
[388.088364] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[388.097724] Starting dynamic subtest: pipe-B-eDP-1
[388.118315] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[388.126252] Starting dynamic subtest: pipe-C-eDP-1
[388.146943] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[388.154441] Starting dynamic subtest: pipe-D-eDP-1
[388.176806] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[388.181036] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[390.319839] [032/133] (629s left) gem_exec_async (forked-writes)
[390.370829] Starting subtest: forked-writes
[390.373171] Starting dynamic subtest: rcs0
[390.401044] Dynamic subtest rcs0: SUCCESS (0.030s)
[390.412456] Starting dynamic subtest: bcs0
[390.426007] Dynamic subtest bcs0: SUCCESS (0.024s)
[390.434243] Starting dynamic subtest: vcs0
[390.449798] Dynamic subtest vcs0: SUCCESS (0.023s)
[390.458071] Starting dynamic subtest: vcs1
[390.472343] Dynamic subtest vcs1: SUCCESS (0.021s)
[390.484294] Starting dynamic subtest: vecs0
[390.498234] Dynamic subtest vecs0: SUCCESS (0.024s)
[390.506961] Starting dynamic subtest: ccs0
[390.521633] Dynamic subtest ccs0: SUCCESS (0.022s)
[390.523902] Subtest forked-writes: SUCCESS (0.151s)
[390.748260] [033/133] (629s left) gem_exec_reloc (basic-gtt-read-noreloc)
[390.804321] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[390.869532] [034/133] (628s left) gem_bad_reloc (negative-reloc)
[390.922780] Subtest negative-reloc: SKIP (0.000s)
[390.996034] [035/133] (628s left) sw_sync (alloc_fence)
[391.042543] Starting subtest: alloc_fence
[391.044938] Subtest alloc_fence: SUCCESS (0.000s)
[391.091672] [036/133] (628s left) gem_partial_pwrite_pread (write)
[391.156049] Subtest write: SKIP (0.000s)
[391.214995] [037/133] (628s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[391.312333] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[391.316308] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[391.378567] [038/133] (628s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[391.475419] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[396.607058] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (5.134s)
[397.767818] [039/133] (622s left) gem_render_linear_blits (basic)
[397.838094] Starting subtest: basic
[397.859409] Subtest basic: SUCCESS (0.024s)
[397.943408] [040/133] (622s left) kms_big_fb (4-tiled-addfb-size-overflow)
[398.054639] Starting subtest: 4-tiled-addfb-size-overflow
[398.057036] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[398.152368] [041/133] (621s left) gem_render_copy (x-tiled)
[398.206209] Starting subtest: x-tiled
[398.208598] Starting dynamic subtest: smem
[398.252742] Dynamic subtest smem: SUCCESS (0.046s)
[398.255111] Subtest x-tiled: SUCCESS (0.047s)
[398.440183] [042/133] (621s left) api_intel_allocator (reopen-fork)
[398.487895] Starting subtest: reopen-fork
[401.826607] Subtest reopen-fork: SUCCESS (3.339s)
[401.903794] [043/133] (618s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[401.968246] Starting subtest: multi-wait-available-unsubmitted-submitted
[401.970573] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.001s)
[402.069717] [044/133] (618s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[402.159673] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[402.161933] Starting dynamic subtest: pipe-A-eDP-1
[402.181129] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[402.189567] Starting dynamic subtest: pipe-B-eDP-1
[402.207461] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[402.215261] Starting dynamic subtest: pipe-C-eDP-1
[402.233711] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[402.241378] Starting dynamic subtest: pipe-D-eDP-1
[402.260189] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[402.262044] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s)
[404.423656] [045/133] (615s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[404.523901] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[404.528356] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[404.618968] [046/133] (615s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[404.706523] Starting subtest: modeset-transition-nonblocking-fencing
[404.708609] Starting dynamic subtest: 1x-outputs
[415.598955] Dynamic subtest 1x-outputs: SUCCESS (10.893s)
[415.601691] Subtest modeset-transition-nonblocking-fencing: SUCCESS (10.895s)
[416.449364] [047/133] (603s left) syncobj_timeline (multi-wait-all-available-signaled)
[416.500527] Starting subtest: multi-wait-all-available-signaled
[416.502849] Subtest multi-wait-all-available-signaled: SUCCESS (0.000s)
[416.622428] [048/133] (603s left) kms_prop_blob (blob-prop-lifetime)
[416.672404] Starting subtest: blob-prop-lifetime
[416.674705] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[416.761780] [049/133] (603s left) gem_tiled_swapping (non-threaded)
[416.831059] Subtest non-threaded: SKIP (0.000s)
[416.896809] [050/133] (603s left) gem_exec_flush (basic-wb-rw-before-default)
[416.960236] Starting subtest: basic-wb-rw-before-default
[422.414466] Subtest basic-wb-rw-before-default: SUCCESS (5.455s)
[422.613332] [051/133] (597s left) kms_cursor_legacy (single-bo)
[422.732633] Starting subtest: single-bo
[422.735035] Starting dynamic subtest: pipe-A
[428.114719] Dynamic subtest pipe-A: SUCCESS (5.380s)
[428.126077] Starting dynamic subtest: pipe-B
[433.498199] Dynamic subtest pipe-B: SUCCESS (5.380s)
[433.508592] Starting dynamic subtest: pipe-C
[438.881066] Dynamic subtest pipe-C: SUCCESS (5.380s)
[438.891522] Starting dynamic subtest: pipe-D
[444.263109] Dynamic subtest pipe-D: SUCCESS (5.380s)
[444.273916] Starting dynamic subtest: all-pipes
[449.652931] Dynamic subtest all-pipes: SUCCESS (5.387s)
[449.655337] Subtest single-bo: SUCCESS (26.920s)
[449.811253] [052/133] (570s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[449.909880] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[457.077270] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.172s)
[457.202140] [053/133] (563s left) core_auth (getclient-simple)
[457.235830] Starting subtest: getclient-simple
[457.251857] Subtest getclient-simple: SUCCESS (0.015s)
[457.366099] [054/133] (563s left) kms_vblank (wait-idle-hang)
[457.447768] Starting subtest: wait-idle-hang
[457.449894] Starting dynamic subtest: pipe-A-eDP-1
[483.742034] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.293s)
[483.757099] Starting dynamic subtest: pipe-D-eDP-1
[498.710922] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.966s)
[498.713262] Subtest wait-idle-hang: SUCCESS (41.264s)
[499.521640] [055/133] (521s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[499.641493] Starting subtest: cursorA-vs-flipB-atomic
[499.646024] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[499.785996] [056/133] (520s left) dmabuf_sync_file (import-multiple-read-write)
[499.827274] Starting subtest: import-multiple-read-write
[499.829533] Subtest import-multiple-read-write: SUCCESS (0.003s)
[499.887509] [057/133] (520s left) gem_exec_schedule (fairslice)
[499.954523] Starting subtest: fairslice
[499.956405] Starting dynamic subtest: rcs0
[501.970768] Dynamic subtest rcs0: SUCCESS (2.020s)
[501.979784] Starting dynamic subtest: bcs0
[503.990830] Dynamic subtest bcs0: SUCCESS (2.020s)
[503.999682] Starting dynamic subtest: vcs0
[506.010654] Dynamic subtest vcs0: SUCCESS (2.017s)
[506.019484] Starting dynamic subtest: vcs1
[508.029249] Dynamic subtest vcs1: SUCCESS (2.017s)
[508.037265] Starting dynamic subtest: vecs0
[510.046501] Dynamic subtest vecs0: SUCCESS (2.017s)
[510.054585] Starting dynamic subtest: ccs0
[512.068837] Dynamic subtest ccs0: SUCCESS (2.020s)
[512.070891] Subtest fairslice: SUCCESS (12.117s)
[512.380215] [058/133] (508s left) gem_userptr_blits (map-fixed-invalidate)
[512.457790] Starting subtest: map-fixed-invalidate
[512.462161] Subtest map-fixed-invalidate: SKIP (0.000s)
[512.573435] [059/133] (508s left) kms_atomic_interruptible (legacy-cursor)
[512.662679] Starting subtest: legacy-cursor
[512.665067] Starting dynamic subtest: pipe-A-eDP-1
[520.028042] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.366s)
[520.030249] Subtest legacy-cursor: SUCCESS (7.368s)
[520.884165] [060/133] (500s left) gem_mmap_offset (mmap-boundaries)
[520.952731] Starting subtest: mmap-boundaries
[520.955233] Starting dynamic subtest: smem0
[521.296260] Dynamic subtest smem0: SUCCESS (0.342s)
[521.298997] Subtest mmap-boundaries: SUCCESS (0.344s)
[521.408965] [061/133] (499s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[521.800121] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[522.586036] [062/133] (498s left) kms_frontbuffer_tracking (psr-2p-rte)
[522.683921] Starting subtest: psr-2p-rte
[522.688134] Subtest psr-2p-rte: SKIP (0.000s)
[522.767975] [063/133] (498s left) gem_ppgtt (blt-vs-render-ctxn)
[522.826945] Starting subtest: blt-vs-render-ctxN
[555.816548] Subtest blt-vs-render-ctxN: SUCCESS (32.985s)
[555.939063] [064/133] (465s left) kms_pm_rpm (pm-tiling)
[558.052693] Starting subtest: pm-tiling
[558.057868] Subtest pm-tiling: SKIP (0.000s)
[558.419809] [065/133] (462s left) i915_pm_rpm (gem-pread)
[559.954366] Starting subtest: gem-pread
[562.327646] Subtest gem-pread: SUCCESS (2.377s)
[562.421631] [066/133] (458s left) gem_exec_reloc (basic-cpu-read-noreloc)
[562.499334] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[562.578354] [067/133] (458s left) gem_exec_capture (capture-invisible)
[562.637303] Starting subtest: capture-invisible
[562.639699] Starting dynamic subtest: smem0
[562.644588] Dynamic subtest smem0: SKIP (0.000s)
[562.649071] Subtest capture-invisible: SKIP (0.001s)
[562.745989] [068/133] (458s left) kms_joiner (basic-max-non-joiner)
[562.840282] Starting subtest: basic-max-non-joiner
[562.844347] Subtest basic-max-non-joiner: SKIP (0.000s)
[562.923439] [069/133] (458s left) gem_exec_schedule (submit-golden-slice)
[563.016853] Starting subtest: submit-golden-slice
[563.019109] Starting dynamic subtest: rcs0
[563.042972] Dynamic subtest rcs0: SUCCESS (0.032s)
[563.054113] Starting dynamic subtest: bcs0
[563.077552] Dynamic subtest bcs0: SUCCESS (0.033s)
[563.086976] Starting dynamic subtest: vcs0
[563.110119] Dynamic subtest vcs0: SUCCESS (0.032s)
[563.119139] Starting dynamic subtest: vcs1
[563.143374] Dynamic subtest vcs1: SUCCESS (0.032s)
[563.152511] Starting dynamic subtest: vecs0
[563.174440] Dynamic subtest vecs0: SUCCESS (0.028s)
[563.183807] Starting dynamic subtest: ccs0
[563.204586] Dynamic subtest ccs0: SUCCESS (0.030s)
[563.206890] Subtest submit-golden-slice: SUCCESS (0.194s)
[564.979776] [070/133] (456s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[565.083061] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[565.140253] [071/133] (456s left) gem_lmem_swapping (massive)
[565.183214] Subtest massive: SKIP (0.000s)
[565.229549] [072/133] (456s left) i915_module_load (reload)
[565.266186] Starting subtest: reload
[570.090238] Subtest reload: SUCCESS (4.826s)
[570.131449] [073/133] (451s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[571.873824] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[571.876111] Starting dynamic subtest: pipe-A-eDP-1
[571.899560] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[571.907913] Starting dynamic subtest: pipe-B-eDP-1
[571.931251] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[571.939068] Starting dynamic subtest: pipe-C-eDP-1
[571.962615] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[571.970756] Starting dynamic subtest: pipe-D-eDP-1
[571.994641] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[571.998677] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[574.391009] [074/133] (447s left) kms_psr (pr-sprite-plane-onoff)
[574.510972] Starting subtest: pr-sprite-plane-onoff
[574.515559] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[574.597518] [075/133] (446s left) kms_lease (lease-unleased-crtc)
[574.706063] Starting subtest: lease-unleased-crtc
[574.708415] Starting dynamic subtest: pipe-A-eDP-1
[574.997070] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.291s)
[575.008895] Starting dynamic subtest: pipe-B-eDP-1
[575.742362] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.742s)
[575.751505] Starting dynamic subtest: pipe-C-eDP-1
[575.753889] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.006s)
[575.761730] Starting dynamic subtest: pipe-D-eDP-1
[575.763683] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.005s)
[575.765587] Subtest lease-unleased-crtc: SUCCESS (1.051s)
[576.128284] [076/133] (445s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[578.055545] Starting subtest: dpms-mode-unset-non-lpsp
[579.226320] Subtest dpms-mode-unset-non-lpsp: SKIP (1.167s)
[579.613141] [077/133] (442s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[579.709099] Starting subtest: yf-tiled-16bpp-rotate-0
[579.715840] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[579.805126] [078/133] (441s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[579.903082] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[579.905314] Starting dynamic subtest: pipe-A-eDP-1
[591.215507] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.314s)
[591.226782] Starting dynamic subtest: pipe-B-eDP-1
[603.213744] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.998s)
[603.216411] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.315s)
[604.063176] [079/133] (417s left) kms_feature_discovery (display-3x)
[604.152695] Starting subtest: display-3x
[604.157127] Subtest display-3x: SKIP (0.000s)
[604.225938] [080/133] (417s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[604.333706] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[611.689904] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.359s)
[611.831654] [081/133] (409s left) gem_linear_blits (basic)
[612.008707] Starting subtest: basic
[612.014718] Subtest basic: SUCCESS (0.009s)
[612.149668] [082/133] (409s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[612.293150] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[612.297521] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[612.388311] [083/133] (409s left) kms_color (ctm-negative)
[612.507070] Starting subtest: ctm-negative
[612.508930] Starting dynamic subtest: pipe-A-eDP-1
[613.216582] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.708s)
[613.225714] Starting dynamic subtest: pipe-B-eDP-1
[614.615656] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.400s)
[614.625628] Starting dynamic subtest: pipe-C-eDP-1
[615.990582] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.373s)
[616.008027] Starting dynamic subtest: pipe-D-eDP-1
[617.324426] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.332s)
[617.326664] Subtest ctm-negative: SUCCESS (4.819s)
[618.136624] [084/133] (403s left) kms_content_protection (lic-type-0-hdcp14)
[618.275772] Starting subtest: lic-type-0-hdcp14
[618.280288] Subtest lic-type-0-hdcp14: SKIP (0.000s)
[618.396191] [085/133] (403s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[618.452769] Starting subtest: etime-multi-wait-all-submitted-signaled
[618.561812] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.107s)
[618.640141] [086/133] (403s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[618.684424] Starting subtest: single-wait-for-submit-available-submitted
[618.686381] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s)
[618.802132] [087/133] (403s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[618.905126] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[618.909499] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[618.984441] [088/133] (403s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[619.081985] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[625.746927] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.667s)
[625.870430] [089/133] (396s left) kms_psr (fbc-psr-primary-mmap-gtt)
[625.967055] Starting subtest: fbc-psr-primary-mmap-gtt
[625.969338] Starting dynamic subtest: eDP-1
[625.973420] Dynamic subtest eDP-1: SKIP (0.000s)
[625.977540] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[626.059707] [090/133] (396s left) gem_flink_basic (double-flink)
[626.107093] Starting subtest: double-flink
[626.109403] Subtest double-flink: SUCCESS (0.000s)
[626.219821] [091/133] (395s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[626.316525] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[634.002782] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.689s)
[634.118927] [092/133] (388s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[634.229949] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[634.234176] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[634.327051] [093/133] (387s left) syncobj_timeline (device-submit-unordered)
[634.379794] Starting subtest: device-submit-unordered
[634.382067] Subtest device-submit-unordered: SUCCESS (0.001s)
[634.496680] [094/133] (387s left) gem_mmap_gtt (basic-read)
[634.562667] Subtest basic-read: SKIP (0.000s)
[634.622476] [095/133] (387s left) kms_plane_multiple (2x-tiling-4)
[634.719651] Starting subtest: 2x-tiling-4
[634.723785] Subtest 2x-tiling-4: SKIP (0.000s)
[634.795111] [096/133] (387s left) kms_big_fb (linear-16bpp-rotate-270)
[634.898764] Starting subtest: linear-16bpp-rotate-270
[634.918262] Subtest linear-16bpp-rotate-270: SKIP (0.019s)
[635.030629] [097/133] (387s left) gem_exec_fence (submit3)
[635.215418] Starting subtest: submit3
[635.219769] Subtest submit3: SKIP (0.000s)
[636.945214] [098/133] (385s left) perf_pmu (all-busy-idle-check-all)
[636.988839] Starting subtest: all-busy-idle-check-all
[638.933896] Subtest all-busy-idle-check-all: SUCCESS (1.944s)
[639.032116] [099/133] (383s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[639.138892] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[639.141213] Starting dynamic subtest: pipe-A-default-mode
[640.298877] Dynamic subtest pipe-A-default-mode: SKIP (1.157s)
[640.303391] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.159s)
[640.469946] [100/133] (382s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[640.541559] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[640.546226] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[640.739229] [101/133] (381s left) kms_async_flips (crc)
[640.839543] Starting subtest: crc
[641.211741] Starting dynamic subtest: pipe-A-eDP-1
[644.077129] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.864s)
[644.458411] Starting dynamic subtest: pipe-B-eDP-1
[647.324303] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.874s)
[647.707736] Starting dynamic subtest: pipe-C-eDP-1
[650.644418] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.948s)
[651.018219] Starting dynamic subtest: pipe-D-eDP-1
[653.884276] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.875s)
[653.886481] Subtest crc: SUCCESS (13.046s)
[655.031439] [102/133] (367s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[655.121565] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[655.125713] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[655.203918] [103/133] (367s left) sw_sync (timeline_closed)
[655.247477] Starting subtest: timeline_closed
[655.249394] Subtest timeline_closed: SUCCESS (0.000s)
[655.309983] [104/133] (367s left) gem_ctx_isolation (dirty-switch)
[655.375163] Starting subtest: dirty-switch
[655.377490] Starting dynamic subtest: rcs0
[655.558135] Dynamic subtest rcs0: SUCCESS (0.182s)
[655.567089] Starting dynamic subtest: bcs0
[655.764950] Dynamic subtest bcs0: SUCCESS (0.206s)
[655.775846] Starting dynamic subtest: vcs0
[655.963520] Dynamic subtest vcs0: SUCCESS (0.198s)
[655.974151] Starting dynamic subtest: vcs1
[657.085543] Dynamic subtest vcs1: SUCCESS (1.121s)
[657.098730] Starting dynamic subtest: vecs0
[659.097245] Dynamic subtest vecs0: SUCCESS (2.011s)
[659.105970] Starting dynamic subtest: ccs0
[661.092297] Dynamic subtest ccs0: SUCCESS (1.994s)
[661.094685] Subtest dirty-switch: SUCCESS (5.717s)
[661.328589] [105/133] (361s left) gem_partial_pwrite_pread (reads-uncached)
[661.395356] Subtest reads-uncached: SKIP (0.000s)
[661.479695] [106/133] (361s left) gem_exec_reloc (basic-write-wc)
[661.547444] Subtest basic-write-wc: SKIP (0.000s)
[661.619417] [107/133] (361s left) gem_softpin (allocator-evict)
[661.688008] Starting subtest: allocator-evict
[661.689905] Starting dynamic subtest: rcs0
[685.429790] Dynamic subtest rcs0: SUCCESS (23.743s)
[685.439293] Starting dynamic subtest: bcs0
[709.135638] Dynamic subtest bcs0: SUCCESS (23.704s)
[709.145094] Starting dynamic subtest: vcs0
[732.997727] Dynamic subtest vcs0: SUCCESS (23.860s)
[733.006703] Starting dynamic subtest: vcs1
[756.663457] Dynamic subtest vcs1: SUCCESS (23.664s)
[756.674815] Starting dynamic subtest: vecs0
[780.221074] Dynamic subtest vecs0: SUCCESS (23.556s)
[780.230788] Starting dynamic subtest: ccs0
[804.188799] Dynamic subtest ccs0: SUCCESS (23.965s)
[804.191207] Subtest allocator-evict: SUCCESS (142.498s)
[804.271931] [108/133] (218s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[804.404188] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[804.406465] Starting dynamic subtest: pipe-A
[804.467279] Dynamic subtest pipe-A: SUCCESS (0.065s)
[804.478027] Starting dynamic subtest: pipe-B
[805.648995] Dynamic subtest pipe-B: SUCCESS (1.180s)
[805.660557] Starting dynamic subtest: pipe-C
[806.758312] Dynamic subtest pipe-C: SUCCESS (1.108s)
[806.767135] Starting dynamic subtest: pipe-D
[807.883180] Dynamic subtest pipe-D: SUCCESS (1.124s)
[807.885463] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.482s)
[809.049938] [109/133] (213s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[809.147955] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[809.150258] Starting dynamic subtest: pipe-A-eDP-1
[809.207841] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[809.217076] Starting dynamic subtest: pipe-B-eDP-1
[809.272435] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[809.281177] Starting dynamic subtest: pipe-C-eDP-1
[809.340336] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[809.349801] Starting dynamic subtest: pipe-D-eDP-1
[809.407284] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[809.411301] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.009s)
[811.408928] [110/133] (211s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[811.498785] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[811.501069] Starting dynamic subtest: pipe-A-eDP-1
[845.416818] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.837s)
[845.426276] Starting dynamic subtest: pipe-B-eDP-1
[880.388607] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.548s)
[880.398474] Starting dynamic subtest: pipe-C-eDP-1
[915.350505] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.493s)
[915.360218] Starting dynamic subtest: pipe-D-eDP-1
[950.357768] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.413s)
[950.360284] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (17.296s)
[960.613704] [111/133] ( 71s left) gen9_exec_parse (cmd-crossing-page)
[960.687787] Subtest cmd-crossing-page: SKIP (0.000s)
[960.757811] [112/133] ( 71s left) kms_cursor_crc (cursor-offscreen-32x32)
[960.908183] Starting subtest: cursor-offscreen-32x32
[960.954374] Subtest cursor-offscreen-32x32: SKIP (0.041s)
[961.246426] [113/133] ( 70s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[961.346626] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[961.351842] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[961.445458] [114/133] ( 70s left) gem_render_copy_redux (flink)
[961.498687] Starting subtest: flink
[962.262434] Subtest flink: SUCCESS (0.762s)
[962.385109] [115/133] ( 69s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[962.480562] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[970.023384] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.534s)
[970.159145] [116/133] ( 62s left) gem_exec_suspend (basic)
[970.337087] Starting subtest: basic
[970.339907] Starting dynamic subtest: smem
[972.463815] Dynamic subtest smem: SUCCESS (2.124s)
[972.466704] Subtest basic: SUCCESS (2.126s)
[972.655170] [117/133] ( 59s left) gem_gtt_cpu_tlb
[972.807693] [118/133] ( 59s left) perf (invalid-open-flags)
[972.959035] Starting subtest: invalid-open-flags
[972.961457] Subtest invalid-open-flags: SUCCESS (0.000s)
[973.008996] [119/133] ( 59s left) prime_vgem (fence-wait)
[973.082859] Starting subtest: fence-wait
[973.085357] Starting dynamic subtest: rcs0
[974.150807] Dynamic subtest rcs0: SUCCESS (1.066s)
[974.160116] Starting dynamic subtest: bcs0
[975.209989] Dynamic subtest bcs0: SUCCESS (1.056s)
[975.222722] Starting dynamic subtest: vcs0
[976.255429] Dynamic subtest vcs0: SUCCESS (1.043s)
[976.269221] Starting dynamic subtest: vcs1
[977.297512] Dynamic subtest vcs1: SUCCESS (1.041s)
[977.310566] Starting dynamic subtest: vecs0
[978.340895] Dynamic subtest vecs0: SUCCESS (1.041s)
[978.354714] Starting dynamic subtest: ccs0
[979.381705] Dynamic subtest ccs0: SUCCESS (1.038s)
[979.384713] Subtest fence-wait: SUCCESS (6.295s)
[979.495486] [120/133] ( 52s left) kms_psr (psr2-sprite-mmap-gtt)
[979.587987] Starting subtest: psr2-sprite-mmap-gtt
[979.590380] Starting dynamic subtest: eDP-1
[981.044287] Dynamic subtest eDP-1: SKIP (1.451s)
[981.049584] Subtest psr2-sprite-mmap-gtt: SKIP (1.454s)
[981.181511] [121/133] ( 51s left) gem_mmap_wc (bad-offset)
[981.244853] Subtest bad-offset: SKIP (0.000s)
[981.300722] [122/133] ( 51s left) kms_vrr (lobf)
[981.411687] Starting subtest: lobf
[981.416774] Subtest lobf: SKIP (0.000s)
[981.485896] [123/133] ( 51s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[981.580912] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[981.586248] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[981.700671] [124/133] ( 50s left) gem_pxp (hw-rejects-pxp-context)
[981.819403] Starting subtest: hw-rejects-pxp-context
[981.825148] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[981.941516] [125/133] ( 50s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[982.036863] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[985.802691] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.770s)
[986.975840] [126/133] ( 45s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[987.087774] Starting subtest: y-tiled-16bpp-rotate-0
[987.093070] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[987.180087] [127/133] ( 45s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0-hflip)
[987.274306] Starting subtest: linear-max-hw-stride-32bpp-rotate-0-hflip
[987.278880] Subtest linear-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[987.361459] [128/133] ( 45s left) gem_ctx_persistence (legacy-engines-cleanup)
[987.421469] Starting subtest: legacy-engines-cleanup
[987.423766] Starting dynamic subtest: render
[987.487618] Dynamic subtest render: SUCCESS (0.066s)
[987.501523] Starting dynamic subtest: bsd1
[987.507872] Dynamic subtest bsd1: SUCCESS (0.017s)
[987.517405] Starting dynamic subtest: bsd2
[987.570994] Dynamic subtest bsd2: SUCCESS (0.062s)
[987.582874] Starting dynamic subtest: blt
[987.607741] Dynamic subtest blt: SUCCESS (0.035s)
[987.617822] Starting dynamic subtest: vebox
[987.648858] Dynamic subtest vebox: SUCCESS (0.039s)
[987.651562] Subtest legacy-engines-cleanup: SUCCESS (0.228s)
[987.726890] [129/133] ( 45s left) kms_flip (bo-too-big)
[987.828721] Starting subtest: bo-too-big
[987.831308] Starting dynamic subtest: A-eDP1
[989.136088] Dynamic subtest A-eDP1: SUCCESS (1.307s)
[989.146433] Starting dynamic subtest: B-eDP1
[990.460267] Dynamic subtest B-eDP1: SUCCESS (1.324s)
[990.471384] Starting dynamic subtest: C-eDP1
[991.784385] Dynamic subtest C-eDP1: SUCCESS (1.323s)
[991.795787] Starting dynamic subtest: D-eDP1
[993.120577] Dynamic subtest D-eDP1: SUCCESS (1.335s)
[993.126288] Subtest bo-too-big: SUCCESS (5.300s)
[994.336234] [130/133] ( 38s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[994.394702] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[994.501315] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.105s)
[994.591347] [131/133] ( 38s left) kms_cursor_crc (cursor-random-max-size)
[994.940487] Starting subtest: cursor-random-max-size
[994.947391] Subtest cursor-random-max-size: SKIP (0.000s)
[995.070213] [132/133] ( 37s left) gem_basic (create-close)
[995.119926] Starting subtest: create-close
[995.125456] Subtest create-close: SUCCESS (0.000s)
[995.202276] [133/133] ( 37s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[995.295505] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[995.307519] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.011s)
[995.382526] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_plane
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: gem_exec_whisper
results: parsing output: 5/ for test: i915_drm_fdinfo
results: parsing output: 6/ for test: kms_getfb
results: parsing output: 7/ for test: kms_psr
results: parsing output: 8/ for test: gem_caching
results: parsing output: 9/ for test: prime_mmap
results: parsing output: 10/ for test: kms_rotation_crc
results: parsing output: 11/ for test: sysfs_preempt_timeout
results: parsing output: 12/ for test: perf_pmu
results: parsing output: 13/ for test: gem_create
results: parsing output: 14/ for test: sw_sync
results: parsing output: 15/ for test: gem_vm_create
results: parsing output: 16/ for test: kms_addfb_basic
results: parsing output: 17/ for test: gem_exec_fence
results: parsing output: 18/ for test: kms_cursor_legacy
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: kms_pipe_stress
results: parsing output: 21/ for test: kms_cursor_legacy
results: parsing output: 22/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 23/ for test: gem_exec_balancer
results: parsing output: 24/ for test: kms_flip_scaled_crc
results: parsing output: 25/ for test: i915_selftest
results: parsing output: 26/ for test: kms_chamelium_frames
results: parsing output: 27/ for test: gem_exec_schedule
results: parsing output: 28/ for test: kms_busy
results: parsing output: 29/ for test: gem_mmap_gtt
results: parsing output: 30/ for test: kms_ccs
results: parsing output: 31/ for test: gem_exec_async
results: parsing output: 32/ for test: gem_exec_reloc
results: parsing output: 33/ for test: gem_bad_reloc
results: parsing output: 34/ for test: sw_sync
results: parsing output: 35/ for test: gem_partial_pwrite_pread
results: parsing output: 36/ for test: kms_psr2_sf
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_render_linear_blits
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: gem_render_copy
results: parsing output: 41/ for test: api_intel_allocator
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: kms_ccs
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: kms_atomic_transition
results: parsing output: 46/ for test: syncobj_timeline
results: parsing output: 47/ for test: kms_prop_blob
results: parsing output: 48/ for test: gem_tiled_swapping
results: parsing output: 49/ for test: gem_exec_flush
results: parsing output: 50/ for test: kms_cursor_legacy
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: core_auth
results: parsing output: 53/ for test: kms_vblank
results: parsing output: 54/ for test: kms_cursor_legacy
results: parsing output: 55/ for test: dmabuf_sync_file
results: parsing output: 56/ for test: gem_exec_schedule
results: parsing output: 57/ for test: gem_userptr_blits
results: parsing output: 58/ for test: kms_atomic_interruptible
results: parsing output: 59/ for test: gem_mmap_offset
results: parsing output: 60/ for test: kms_chamelium_hpd
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: gem_ppgtt
results: parsing output: 63/ for test: kms_pm_rpm
results: parsing output: 64/ for test: i915_pm_rpm
results: parsing output: 65/ for test: gem_exec_reloc
results: parsing output: 66/ for test: gem_exec_capture
results: parsing output: 67/ for test: kms_joiner
results: parsing output: 68/ for test: gem_exec_schedule
results: parsing output: 69/ for test: kms_tiled_display
results: parsing output: 70/ for test: gem_lmem_swapping
results: parsing output: 71/ for test: i915_module_load
results: parsing output: 72/ for test: kms_ccs
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: kms_lease
results: parsing output: 75/ for test: kms_pm_rpm
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: kms_psr2_sf
results: parsing output: 78/ for test: kms_feature_discovery
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: gem_linear_blits
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_color
results: parsing output: 83/ for test: kms_content_protection
results: parsing output: 84/ for test: syncobj_timeline
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: kms_plane
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: gem_flink_basic
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: syncobj_timeline
results: parsing output: 93/ for test: gem_mmap_gtt
results: parsing output: 94/ for test: kms_plane_multiple
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: gem_exec_fence
results: parsing output: 97/ for test: perf_pmu
results: parsing output: 98/ for test: kms_flip_scaled_crc
results: parsing output: 99/ for test: gem_render_copy
results: parsing output: 100/ for test: kms_async_flips
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: sw_sync
results: parsing output: 103/ for test: gem_ctx_isolation
results: parsing output: 104/ for test: gem_partial_pwrite_pread
results: parsing output: 105/ for test: gem_exec_reloc
results: parsing output: 106/ for test: gem_softpin
results: parsing output: 107/ for test: kms_plane_scaling
results: parsing output: 108/ for test: kms_ccs
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: gen9_exec_parse
results: parsing output: 111/ for test: kms_cursor_crc
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_render_copy_redux
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: gem_exec_suspend
results: parsing output: 116/ for test: gem_gtt_cpu_tlb
results: parsing output: 117/ for test: perf
results: parsing output: 118/ for test: prime_vgem
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: gem_mmap_wc
results: parsing output: 121/ for test: kms_vrr
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gem_pxp
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_big_fb
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: gem_ctx_persistence
results: parsing output: 128/ for test: kms_flip
results: parsing output: 129/ for test: syncobj_wait
results: parsing output: 130/ for test: kms_cursor_crc
results: parsing output: 131/ for test: gem_basic
results: parsing output: 132/ for test: kms_flip
Done.