[120.375504] Initializing watchdogs
[120.375549]   /dev/watchdog0
[120.390901] [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]
[120.395457] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[120.397634] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[120.400812] [001/131] (960s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[120.525075] Starting subtest: fbc-tiling-linear
[124.286578] Subtest fbc-tiling-linear: SUCCESS (3.765s)
[125.411113] [002/131] (955s left) perf_pmu (busy-idle-check-all)
[125.455657] Starting subtest: busy-idle-check-all
[125.457953] Starting dynamic subtest: rcs0
[126.129101] Dynamic subtest rcs0: SUCCESS (0.673s)
[126.138512] Starting dynamic subtest: bcs0
[126.781471] Dynamic subtest bcs0: SUCCESS (0.652s)
[126.791116] Starting dynamic subtest: vcs0
[127.892469] Dynamic subtest vcs0: SUCCESS (1.110s)
[127.902111] Starting dynamic subtest: vcs1
[129.880441] Dynamic subtest vcs1: SUCCESS (1.985s)
[129.890591] Starting dynamic subtest: vecs0
[131.927449] Dynamic subtest vecs0: SUCCESS (2.046s)
[131.938071] Starting dynamic subtest: ccs0
[132.584545] Dynamic subtest ccs0: SUCCESS (0.657s)
[132.589568] Subtest busy-idle-check-all: SUCCESS (7.129s)
[132.709824] [003/131] (948s left) gem_mmap_offset (bad-flags)
[132.763207] Starting subtest: bad-flags
[132.765325] Subtest bad-flags: SUCCESS (0.000s)
[132.861671] [004/131] (948s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[132.953618] Starting subtest: flip-vs-dpms-off-vs-modeset
[132.956046] Starting dynamic subtest: A-eDP1
[136.635874] Dynamic subtest A-eDP1: SUCCESS (3.680s)
[136.645500] Starting dynamic subtest: B-eDP1
[139.827333] Dynamic subtest B-eDP1: SUCCESS (3.191s)
[139.837096] Starting dynamic subtest: C-eDP1
[142.955871] Dynamic subtest C-eDP1: SUCCESS (3.129s)
[142.964238] Starting dynamic subtest: D-eDP1
[146.053255] Dynamic subtest D-eDP1: SUCCESS (3.095s)
[146.055508] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.100s)
[146.869208] [005/131] (934s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[146.978574] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[146.983120] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[147.116616] [006/131] (933s left) sw_sync (sync_merge_same)
[147.149285] Starting subtest: sync_merge_same
[147.151598] Subtest sync_merge_same: SUCCESS (0.000s)
[147.222615] [007/131] (933s left) gem_exec_balancer (persistence)
[147.481700] Starting subtest: persistence
[148.382530] Subtest persistence: SUCCESS (0.900s)
[148.518199] [008/131] (932s left) kms_lease (lease-get)
[148.611716] Starting subtest: lease-get
[148.614368] Starting dynamic subtest: pipe-A-eDP-1
[148.616820] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[148.625438] Starting dynamic subtest: pipe-B-eDP-1
[148.627357] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[148.634471] Starting dynamic subtest: pipe-C-eDP-1
[148.636388] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[148.643317] Starting dynamic subtest: pipe-D-eDP-1
[148.645240] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[148.647115] Subtest lease-get: SUCCESS (0.007s)
[148.736930] [009/131] (932s left) kms_vblank (wait-forked-hang)
[148.822387] Starting subtest: wait-forked-hang
[148.824611] Starting dynamic subtest: pipe-A-eDP-1
[175.701568] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.873s)
[175.717620] Starting dynamic subtest: pipe-D-eDP-1
[190.680276] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.975s)
[190.682472] Subtest wait-forked-hang: SUCCESS (41.852s)
[191.533402] [010/131] (889s left) api_intel_bb (destroy-bb)
[191.584919] Starting subtest: destroy-bb
[191.592623] Subtest destroy-bb: SUCCESS (0.008s)
[191.698590] [011/131] (889s left) gem_exec_schedule (submit-early-slice)
[191.771584] Starting subtest: submit-early-slice
[191.773857] Starting dynamic subtest: rcs0
[191.808719] Dynamic subtest rcs0: SUCCESS (0.041s)
[191.818565] Starting dynamic subtest: bcs0
[191.846544] Dynamic subtest bcs0: SUCCESS (0.038s)
[191.855651] Starting dynamic subtest: vcs0
[191.887733] Dynamic subtest vcs0: SUCCESS (0.041s)
[191.898268] Starting dynamic subtest: vcs1
[191.926937] Dynamic subtest vcs1: SUCCESS (0.039s)
[191.935401] Starting dynamic subtest: vecs0
[191.961436] Dynamic subtest vecs0: SUCCESS (0.034s)
[191.970468] Starting dynamic subtest: ccs0
[192.000628] Dynamic subtest ccs0: SUCCESS (0.039s)
[192.003403] Subtest submit-early-slice: SUCCESS (0.234s)
[193.027453] [012/131] (888s left) syncobj_wait (invalid-reset-zero-handles)
[193.086785] Starting subtest: invalid-reset-zero-handles
[193.089031] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[193.219669] [013/131] (888s left) gem_userptr_blits (readonly-unsync)
[193.280260] Subtest readonly-unsync: SKIP (0.000s)
[193.441171] [014/131] (887s left) kms_feature_discovery (display)
[193.537762] Starting subtest: display
[193.540100] Subtest display: SUCCESS (0.000s)
[193.623775] [015/131] (887s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[193.734285] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[193.738528] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[193.848398] [016/131] (887s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[198.900724] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[198.905260] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.002s)
[199.763148] [017/131] (881s left) sw_sync (sync_busy_fork_unixsocket)
[199.795684] Starting subtest: sync_busy_fork_unixsocket
[199.802594] Subtest sync_busy_fork_unixsocket: SUCCESS (0.009s)
[199.883880] [018/131] (881s left) kms_invalid_mode (bad-htotal)
[199.987790] Starting subtest: bad-htotal
[199.990255] Starting dynamic subtest: pipe-A-eDP-1
[200.270819] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[200.279274] Starting dynamic subtest: pipe-B-eDP-1
[200.281391] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[200.288650] Starting dynamic subtest: pipe-C-eDP-1
[200.290794] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[200.298470] Starting dynamic subtest: pipe-D-eDP-1
[200.300340] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[200.302269] Subtest bad-htotal: SUCCESS (0.291s)
[201.080163] [019/131] (880s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[201.184621] Starting subtest: y-tiled-32bpp-rotate-180
[201.188845] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[201.287732] [020/131] (880s left) kms_psr (psr2-cursor-blt)
[201.375011] Starting subtest: psr2-cursor-blt
[201.377270] Starting dynamic subtest: eDP-1
[203.060546] Dynamic subtest eDP-1: SUCCESS (1.684s)
[203.062820] Subtest psr2-cursor-blt: SUCCESS (1.685s)
[203.866109] [021/131] (877s left) prime_vgem (basic-read)
[203.979688] Starting subtest: basic-read
[203.987119] Subtest basic-read: SKIP (0.005s)
[204.128894] [FACT prime_vgem (basic-read)] new: kernel.kmod_is_loaded.vgem: true
[204.132091] [022/131] (877s left) kms_chamelium_color (ctm-red-to-blue)
[204.226807] Subtest ctm-red-to-blue: SKIP (0.000s)
[204.272566] [023/131] (877s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[204.329827] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[204.332071] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[204.458523] [024/131] (877s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[204.555436] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[204.559485] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[204.673557] [025/131] (877s left) gem_exec_alignment (pi)
[204.732618] Starting subtest: pi
[255.704174] Subtest pi: SUCCESS (50.967s)
[256.725779] [026/131] (825s left) api_intel_allocator (reloc-allocator)
[256.815073] Starting subtest: reloc-allocator
[256.817394] Starting dynamic subtest: basic
[256.819786] Dynamic subtest basic: SUCCESS (0.005s)
[256.830318] Starting dynamic subtest: parallel-one
[256.832489] Dynamic subtest parallel-one: SUCCESS (0.009s)
[256.840443] Starting dynamic subtest: print
[256.842738] Dynamic subtest print: SUCCESS (0.000s)
[256.850678] Starting dynamic subtest: reuse
[256.852747] Dynamic subtest reuse: SUCCESS (0.000s)
[256.860228] Starting dynamic subtest: fork-reopen-allocator
[256.862086] Dynamic subtest fork-reopen-allocator: SUCCESS (0.013s)
[256.863980] Subtest reloc-allocator: SUCCESS (0.028s)
[257.007572] [027/131] (824s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[257.106918] Starting subtest: fbc-psr-cursor-mmap-gtt
[257.108857] Starting dynamic subtest: eDP-1
[257.112893] Dynamic subtest eDP-1: SKIP (0.000s)
[257.117342] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[257.202682] [028/131] (824s left) syncobj_eventfd (invalid-illegal-eventfd)
[257.274491] Starting subtest: invalid-illegal-eventfd
[257.276782] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[257.371697] [029/131] (824s left) gem_partial_pwrite_pread (write)
[257.432394] Subtest write: SKIP (0.000s)
[257.494773] [030/131] (824s left) kms_cursor_crc (cursor-sliding-32x32)
[257.637545] Starting subtest: cursor-sliding-32x32
[257.683071] Subtest cursor-sliding-32x32: SKIP (0.042s)
[257.976421] [031/131] (824s left) gem_wait (invalid-buf)
[258.034753] Starting subtest: invalid-buf
[258.036772] Subtest invalid-buf: SUCCESS (0.000s)
[258.289938] [032/131] (823s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[258.392855] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[258.397354] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[258.523104] [033/131] (823s left) gem_lmem_swapping (verify-ccs)
[258.563965] Subtest verify-ccs: SKIP (0.000s)
[258.605911] [034/131] (823s left) kms_plane_scaling (planes-upscale-factor-0-25)
[258.701985] Starting subtest: planes-upscale-factor-0-25
[258.704290] Starting dynamic subtest: pipe-A
[258.768345] Dynamic subtest pipe-A: SUCCESS (0.067s)
[258.778366] Starting dynamic subtest: pipe-B
[259.879706] Dynamic subtest pipe-B: SUCCESS (1.111s)
[259.890144] Starting dynamic subtest: pipe-C
[260.977614] Dynamic subtest pipe-C: SUCCESS (1.097s)
[260.988037] Starting dynamic subtest: pipe-D
[262.110597] Dynamic subtest pipe-D: SUCCESS (1.132s)
[262.113018] Subtest planes-upscale-factor-0-25: SUCCESS (3.411s)
[263.277742] [035/131] (818s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[268.236385] Starting subtest: pr-primary-plane-update-sf-dmg-area-big-fb
[268.241134] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.002s)
[269.106064] [036/131] (813s left) kms_flip (dpms-vs-vblank-race)
[269.199434] Starting subtest: dpms-vs-vblank-race
[269.201707] Starting dynamic subtest: A-eDP1
[274.188659] Dynamic subtest A-eDP1: SUCCESS (4.988s)
[274.197220] Starting dynamic subtest: B-eDP1
[278.811625] Dynamic subtest B-eDP1: SUCCESS (4.622s)
[278.822416] Starting dynamic subtest: C-eDP1
[283.422252] Dynamic subtest C-eDP1: SUCCESS (4.609s)
[283.431516] Starting dynamic subtest: D-eDP1
[288.030624] Dynamic subtest D-eDP1: SUCCESS (4.607s)
[288.032749] Subtest dpms-vs-vblank-race: SUCCESS (18.833s)
[288.914697] [037/131] (793s left) i915_suspend (debugfs-reader)
[288.979065] Starting subtest: debugfs-reader
[306.927646] Subtest debugfs-reader: SUCCESS (3.238s)
[307.109819] [038/131] (775s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[307.227084] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[307.231651] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[307.357178] [039/131] (775s left) kms_properties (crtc-properties-legacy)
[307.451046] Starting subtest: crtc-properties-legacy
[307.453401] Starting dynamic subtest: pipe-A-eDP-1
[307.897495] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.439s)
[307.907763] Starting dynamic subtest: pipe-B-eDP-1
[309.105552] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.182s)
[309.117537] Starting dynamic subtest: pipe-C-eDP-1
[310.237458] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.112s)
[310.248427] Starting dynamic subtest: pipe-D-eDP-1
[311.385645] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.131s)
[311.389291] Subtest crtc-properties-legacy: SUCCESS (3.868s)
[312.247081] [040/131] (770s left) gem_pxp (display-protected-crc)
[312.362312] Starting subtest: display-protected-crc
[314.025839] Subtest display-protected-crc: SUCCESS (1.648s)
[314.172573] [041/131] (768s left) kms_vblank (ts-continuation-idle-hang)
[314.264742] Starting subtest: ts-continuation-idle-hang
[314.266648] Starting dynamic subtest: pipe-A-eDP-1
[340.357780] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.017s)
[340.371548] Starting dynamic subtest: pipe-D-eDP-1
[355.406348] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.044s)
[355.408720] Subtest ts-continuation-idle-hang: SUCCESS (41.066s)
[356.203387] [042/131] (726s left) kms_plane (plane-position-covered)
[356.306734] Starting subtest: plane-position-covered
[356.824470] Starting dynamic subtest: pipe-A-plane-1
[358.069475] Dynamic subtest pipe-A-plane-1: SUCCESS (1.245s)
[358.081925] Starting dynamic subtest: pipe-A-plane-2
[359.319858] Dynamic subtest pipe-A-plane-2: SUCCESS (1.250s)
[359.330238] Starting dynamic subtest: pipe-A-plane-3
[360.572996] Dynamic subtest pipe-A-plane-3: SUCCESS (1.253s)
[360.583463] Starting dynamic subtest: pipe-A-plane-4
[361.800876] Dynamic subtest pipe-A-plane-4: SUCCESS (1.227s)
[361.811597] Starting dynamic subtest: pipe-A-plane-5
[361.830415] Dynamic subtest pipe-A-plane-5: SUCCESS (0.027s)
[362.952839] Starting dynamic subtest: pipe-B-plane-1
[364.203329] Dynamic subtest pipe-B-plane-1: SUCCESS (1.258s)
[364.212290] Starting dynamic subtest: pipe-B-plane-2
[365.506157] Dynamic subtest pipe-B-plane-2: SUCCESS (1.303s)
[365.515701] Starting dynamic subtest: pipe-B-plane-3
[366.756266] Dynamic subtest pipe-B-plane-3: SUCCESS (1.249s)
[366.766337] Starting dynamic subtest: pipe-B-plane-4
[368.074503] Dynamic subtest pipe-B-plane-4: SUCCESS (1.317s)
[368.084489] Starting dynamic subtest: pipe-B-plane-5
[368.102733] Dynamic subtest pipe-B-plane-5: SUCCESS (0.026s)
[368.105003] Subtest plane-position-covered: SUCCESS (11.794s)
[368.886318] [043/131] (713s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[368.944936] Starting subtest: etime-single-wait-for-submit-unsubmitted
[369.055115] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.108s)
[369.141272] [044/131] (713s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[369.230445] Starting subtest: psr-dirtyfb-ioctl
[369.232610] Starting dynamic subtest: A-eDP-1
[373.176805] Dynamic subtest A-eDP-1: SUCCESS (3.944s)
[373.179139] Subtest psr-dirtyfb-ioctl: SUCCESS (3.946s)
[373.993939] [045/131] (708s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[374.055021] Starting subtest: y-tiled-to-vebox-x-tiled
[374.059258] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[374.248492] [046/131] (708s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[374.313411] Starting subtest: single-wait-for-submit-available-submitted
[374.315603] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s)
[374.427693] [047/131] (708s left) kms_psr (psr-dpms)
[374.509222] Starting subtest: psr-dpms
[374.511455] Starting dynamic subtest: eDP-1
[377.502499] Dynamic subtest eDP-1: SUCCESS (2.992s)
[377.504738] Subtest psr-dpms: SUCCESS (2.993s)
[378.394913] [048/131] (704s left) gem_ctx_exec (basic-norecovery)
[378.447254] Starting subtest: basic-norecovery
[378.771882] Subtest basic-norecovery: SUCCESS (0.324s)
[378.925177] [049/131] (703s left) i915_fb_tiling (basic-x-tiling)
[378.987266] Subtest basic-x-tiling: SKIP (0.000s)
[379.059513] [050/131] (703s left) kms_psr (fbc-pr-cursor-plane-move)
[379.157425] Starting subtest: fbc-pr-cursor-plane-move
[379.161734] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[379.250852] [051/131] (703s left) kms_pm_rpm (modeset-non-lpsp)
[380.776625] Starting subtest: modeset-non-lpsp
[381.931536] Subtest modeset-non-lpsp: SKIP (1.155s)
[382.300200] [052/131] (700s left) gem_pxp (reject-modify-context-protection-off-1)
[382.397269] Starting subtest: reject-modify-context-protection-off-1
[382.399522] Subtest reject-modify-context-protection-off-1: SUCCESS (0.001s)
[382.511963] [053/131] (700s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[382.595145] Starting subtest: fbcpsr-stridechange
[388.820292] Subtest fbcpsr-stridechange: SUCCESS (6.224s)
[388.989935] [054/131] (694s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[389.081704] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[389.084137] Starting dynamic subtest: pipe-A-eDP-1
[389.109489] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[389.119523] Starting dynamic subtest: pipe-B-eDP-1
[389.142445] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[389.151602] Starting dynamic subtest: pipe-C-eDP-1
[389.174957] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[389.183962] Starting dynamic subtest: pipe-D-eDP-1
[389.208195] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[389.212300] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[391.325086] [055/131] (691s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[391.430501] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[391.432490] Starting dynamic subtest: A-eDP1
[400.341808] Dynamic subtest A-eDP1: SUCCESS (8.906s)
[400.352207] Starting dynamic subtest: B-eDP1
[409.260825] Dynamic subtest B-eDP1: SUCCESS (8.922s)
[409.277550] Starting dynamic subtest: C-eDP1
[418.177376] Dynamic subtest C-eDP1: SUCCESS (8.918s)
[418.187580] Starting dynamic subtest: D-eDP1
[427.031007] Dynamic subtest D-eDP1: SUCCESS (8.850s)
[427.033342] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.606s)
[428.268436] [056/131] (654s left) gem_exec_schedule (preempt-contexts)
[428.336189] Starting subtest: preempt-contexts
[428.338469] Starting dynamic subtest: rcs0
[428.388404] Dynamic subtest rcs0: SUCCESS (0.061s)
[428.397840] Starting dynamic subtest: bcs0
[428.445081] Dynamic subtest bcs0: SUCCESS (0.056s)
[428.454963] Starting dynamic subtest: vcs0
[428.492817] Dynamic subtest vcs0: SUCCESS (0.046s)
[428.502838] Starting dynamic subtest: vcs1
[428.536051] Dynamic subtest vcs1: SUCCESS (0.041s)
[428.548508] Starting dynamic subtest: vecs0
[428.579413] Dynamic subtest vecs0: SUCCESS (0.045s)
[428.589191] Starting dynamic subtest: ccs0
[428.637505] Dynamic subtest ccs0: SUCCESS (0.057s)
[428.639800] Subtest preempt-contexts: SUCCESS (0.311s)
[429.759613] [057/131] (653s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[429.857490] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[436.638445] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.784s)
[436.807627] [058/131] (646s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[436.891417] Starting subtest: bad-rotation-90-yf-tiled-ccs
[436.893727] Starting dynamic subtest: pipe-A-eDP-1
[436.916842] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[436.929708] Starting dynamic subtest: pipe-B-eDP-1
[436.951682] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[436.960769] Starting dynamic subtest: pipe-C-eDP-1
[436.982293] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[436.991438] Starting dynamic subtest: pipe-D-eDP-1
[437.013275] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[437.017350] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.005s)
[439.189372] [059/131] (644s left) gem_exec_reloc (basic-wc-gtt-active)
[439.250175] Subtest basic-wc-gtt-active: SKIP (0.000s)
[439.318637] [060/131] (644s left) gem_caching (read-writes)
[439.381876] Subtest read-writes: SKIP (0.000s)
[439.453181] [061/131] (643s left) gem_wait (busy)
[439.516303] Starting subtest: busy
[439.518713] Starting dynamic subtest: all-engines
[441.602080] Dynamic subtest all-engines: SUCCESS (2.084s)
[441.613782] Starting dynamic subtest: rcs0
[442.146380] Dynamic subtest rcs0: SUCCESS (0.542s)
[442.156442] Starting dynamic subtest: bcs0
[442.687771] Dynamic subtest bcs0: SUCCESS (0.541s)
[442.698138] Starting dynamic subtest: vcs0
[444.609959] Dynamic subtest vcs0: SUCCESS (1.919s)
[444.621331] Starting dynamic subtest: vcs1
[446.593942] Dynamic subtest vcs1: SUCCESS (1.981s)
[446.607439] Starting dynamic subtest: vecs0
[448.644004] Dynamic subtest vecs0: SUCCESS (2.047s)
[448.656484] Starting dynamic subtest: ccs0
[449.186414] Dynamic subtest ccs0: SUCCESS (0.541s)
[449.189226] Subtest busy: SUCCESS (9.670s)
[449.396238] [062/131] (634s left) prime_vgem (shrink)
[449.506908] Starting subtest: shrink
[449.522957] Subtest shrink: SUCCESS (0.019s)
[449.649614] [063/131] (633s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[450.026782] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[450.877118] [064/131] (632s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[450.987804] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[450.990110] Starting dynamic subtest: pipe-A-default-mode
[452.162735] Dynamic subtest pipe-A-default-mode: SKIP (1.172s)
[452.167211] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.174s)
[452.351855] [065/131] (631s left) i915_drm_fdinfo (virtual-busy-all)
[452.389959] Starting subtest: virtual-busy-all
[452.394029] Subtest virtual-busy-all: SKIP (0.000s)
[452.476239] [066/131] (631s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[452.537745] Subtest tiled-to-untiled: SKIP (0.000s)
[452.617687] [067/131] (631s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[452.684783] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[452.758804] [068/131] (630s left) fbdev (eof)
[452.794270] Starting subtest: eof
[452.796540] Subtest eof: SUCCESS (0.000s)
[452.890925] [069/131] (630s left) gem_render_linear_blits (basic)
[452.948460] Starting subtest: basic
[452.968314] Subtest basic: SUCCESS (0.020s)
[453.073100] [070/131] (630s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[453.167119] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[453.169093] Starting dynamic subtest: pipe-A-default-mode
[454.291105] Dynamic subtest pipe-A-default-mode: SKIP (1.119s)
[454.295537] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.121s)
[454.446745] [071/131] (629s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[454.551127] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[454.555472] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[454.658251] [072/131] (629s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[454.743828] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[454.746107] Starting dynamic subtest: pipe-A-eDP-1
[454.754929] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[454.764874] Starting dynamic subtest: pipe-B-eDP-1
[454.773735] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[454.783351] Starting dynamic subtest: pipe-C-eDP-1
[454.791915] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[454.800807] Starting dynamic subtest: pipe-D-eDP-1
[454.809638] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[454.814148] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[456.955143] [073/131] (626s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[457.053892] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[457.057924] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[457.187425] [074/131] (626s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[457.286914] Starting subtest: x-tiled-64bpp-rotate-180
[458.818956] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.533s)
[459.024022] [075/131] (624s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[459.123421] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[459.125761] Starting dynamic subtest: pipe-A-eDP-1
[459.146607] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[459.158144] Starting dynamic subtest: pipe-B-eDP-1
[459.174746] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[459.183806] Starting dynamic subtest: pipe-C-eDP-1
[459.199758] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[459.208555] Starting dynamic subtest: pipe-D-eDP-1
[459.224505] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[459.226160] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[461.415454] [076/131] (622s left) kms_cursor_crc (cursor-random-32x32)
[461.549852] Starting subtest: cursor-random-32x32
[461.600321] Subtest cursor-random-32x32: SKIP (0.044s)
[461.923008] [077/131] (622s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[462.044166] Starting subtest: 2x-long-flip-vs-cursor-atomic
[462.048729] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[462.213713] [078/131] (621s left) gem_exec_reloc (basic-wc-active)
[462.268365] Subtest basic-wc-active: SKIP (0.000s)
[462.337583] [079/131] (621s left) syncobj_timeline (invalid-wait-illegal-handle)
[462.398908] Starting subtest: invalid-wait-illegal-handle
[462.400918] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[462.509750] [080/131] (621s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[462.561182] Starting subtest: multi-wait-all-for-submit-signaled
[462.563144] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[462.669036] [081/131] (621s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[462.770852] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[462.774363] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[462.904104] [082/131] (621s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[464.828574] Starting subtest: modeset-lpsp-stress-no-wait
[474.528860] Subtest modeset-lpsp-stress-no-wait: SUCCESS (9.703s)
[474.634756] [083/131] (609s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[474.762149] Starting subtest: short-flip-before-cursor-toggle
[475.675034] Subtest short-flip-before-cursor-toggle: SUCCESS (0.912s)
[476.542070] [084/131] (607s left) core_sysfs (read-all-entries)
[476.594419] Starting subtest: read-all-entries
[476.599645] Subtest read-all-entries: SUCCESS (0.005s)
[476.716453] [085/131] (607s left) vgem_basic (second-client)
[476.765866] Starting subtest: second-client
[476.788051] Subtest second-client: SUCCESS (0.022s)
[476.858915] [086/131] (607s left) i915_query (query-topology-unsupported)
[476.919292] Starting subtest: query-topology-unsupported
[476.923704] Subtest query-topology-unsupported: SKIP (0.000s)
[477.047993] [087/131] (607s left) kms_chamelium_hpd (common-hpd-after-suspend)
[477.421070] Subtest common-hpd-after-suspend: SKIP (0.000s)
[478.222735] [088/131] (606s left) kms_tv_load_detect (load-detect)
[478.284102] Subtest load-detect: SKIP (0.000s)
[478.351148] [089/131] (606s left) gem_exec_fence (syncobj-timeline-export)
[478.896063] Starting subtest: syncobj-timeline-export
[478.901823] Subtest syncobj-timeline-export: SUCCESS (0.007s)
[480.763346] [090/131] (603s left) gem_exec_whisper (basic-fds)
[480.828641] Starting subtest: basic-fds
[489.699407] Subtest basic-fds: SUCCESS (8.865s)
[489.905389] [091/131] (594s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[489.961861] Starting subtest: saturated-hostile-nopreempt
[489.963930] Starting dynamic subtest: rcs0
[490.021470] Dynamic subtest rcs0: SKIP (0.057s)
[490.031802] Starting dynamic subtest: bcs0
[490.065469] Dynamic subtest bcs0: SKIP (0.043s)
[490.077488] Starting dynamic subtest: vcs0
[490.095527] Dynamic subtest vcs0: SKIP (0.029s)
[490.105105] Starting dynamic subtest: vcs1
[490.116273] Dynamic subtest vcs1: SKIP (0.019s)
[490.126014] Starting dynamic subtest: vecs0
[490.136200] Dynamic subtest vecs0: SKIP (0.019s)
[490.145766] Starting dynamic subtest: ccs0
[490.150216] Dynamic subtest ccs0: SKIP (0.012s)
[490.154567] Subtest saturated-hostile-nopreempt: SKIP (0.186s)
[490.251365] [092/131] (594s left) gem_exec_reloc (basic-cpu)
[490.312320] Subtest basic-cpu: SKIP (0.000s)
[490.408621] [093/131] (594s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[490.534134] Starting subtest: cursorB-vs-flipB-toggle
[490.538724] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[490.679320] [094/131] (594s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[490.778101] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[498.013653] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.235s)
[498.195801] [095/131] (586s left) kms_getfb (getfb-handle-valid)
[498.281232] Starting subtest: getfb-handle-valid
[498.283463] Subtest getfb-handle-valid: SUCCESS (0.000s)
[498.403262] [096/131] (586s left) i915_pm_rps (reset)
[498.465060] Starting subtest: reset
[498.548498] Subtest reset: FAIL (0.027s)
[498.625248] [097/131] (586s left) gem_softpin (safe-alignment)
[498.678318] Starting subtest: safe-alignment
[498.701625] Subtest safe-alignment: SUCCESS (0.023s)
[500.649477] [098/131] (584s left) gem_exec_fence (syncobj-timeline-wait)
[501.198151] Starting subtest: syncobj-timeline-wait
[502.617270] Subtest syncobj-timeline-wait: SUCCESS (1.419s)
[504.689129] [099/131] (580s left) kms_psr (fbc-psr-cursor-plane-onoff)
[504.783455] Starting subtest: fbc-psr-cursor-plane-onoff
[504.785589] Starting dynamic subtest: eDP-1
[504.789479] Dynamic subtest eDP-1: SKIP (0.000s)
[504.793319] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.001s)
[504.884240] [100/131] (580s left) gem_eio (wait-wedge-1us)
[505.122704] Starting subtest: wait-wedge-1us
[506.716740] Subtest wait-wedge-1us: SUCCESS (1.594s)
[506.872171] [101/131] (578s left) gem_userptr_blits (input-checking)
[506.947218] Starting subtest: input-checking
[506.949490] Subtest input-checking: SUCCESS (0.000s)
[507.097626] [102/131] (578s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[507.193480] Starting subtest: fbc-rgb101010-draw-blt
[511.801297] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.610s)
[513.007093] [103/131] (572s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[513.107903] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[513.943627] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.837s)
[514.130149] [104/131] (571s left) kms_pipe_stress (stress-xrgb8888-yftiled)
[514.227724] Starting subtest: stress-xrgb8888-yftiled
[514.231993] Subtest stress-xrgb8888-yftiled: SKIP (0.000s)
[514.293788] [105/131] (570s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[514.413357] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[531.517106] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.096s)
[532.414531] [106/131] (552s left) kms_atomic_interruptible (legacy-cursor)
[532.515014] Starting subtest: legacy-cursor
[532.517311] Starting dynamic subtest: pipe-A-eDP-1
[539.903011] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.389s)
[539.905365] Subtest legacy-cursor: SUCCESS (7.390s)
[540.766979] [107/131] (544s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[540.867304] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[540.871369] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[541.004228] [108/131] (544s left) kms_color (legacy-gamma-reset)
[541.099787] Starting subtest: legacy-gamma-reset
[541.101725] Starting dynamic subtest: pipe-A-eDP-1
[541.475781] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.377s)
[541.485859] Starting dynamic subtest: pipe-B-eDP-1
[541.488371] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.011s)
[541.500363] Starting dynamic subtest: pipe-C-eDP-1
[541.502591] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[541.512240] Starting dynamic subtest: pipe-D-eDP-1
[541.514390] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[541.516848] Subtest legacy-gamma-reset: SUCCESS (0.414s)
[542.297801] [109/131] (543s left) gem_exec_whisper (basic-queues-forked)
[542.364212] Starting subtest: basic-queues-forked
[566.542714] Subtest basic-queues-forked: SUCCESS (24.178s)
[566.737994] [110/131] (518s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[566.835063] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[566.839446] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[566.968092] [111/131] (518s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[567.076791] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[567.081624] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[567.206517] [112/131] (518s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[567.297089] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[567.299427] Starting dynamic subtest: pipe-A-eDP-1
[567.322539] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[567.334814] Starting dynamic subtest: pipe-B-eDP-1
[567.355850] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[567.365839] Starting dynamic subtest: pipe-C-eDP-1
[567.387307] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[567.398083] Starting dynamic subtest: pipe-D-eDP-1
[567.419554] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[567.423882] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s)
[569.546246] [113/131] (516s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[569.648228] Starting subtest: basic-modeset-with-all-modifiers-formats
[570.019795] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[570.817060] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.799s)
[570.827041] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[570.839133] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[570.848842] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[570.861641] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.022s)
[570.871252] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[571.017422] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.155s)
[571.027399] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[571.039316] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.021s)
[571.049736] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[571.061503] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.021s)
[571.071361] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[571.083746] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.021s)
[571.093524] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[571.105966] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.021s)
[571.116028] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[571.128105] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.021s)
[571.138579] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[571.150390] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.022s)
[571.160088] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[571.172340] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.021s)
[571.183055] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[571.194851] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.021s)
[571.204627] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[571.350391] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.155s)
[571.361242] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[571.372731] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.021s)
[571.383227] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[571.394798] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.021s)
[571.404729] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[571.416878] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.021s)
[571.426362] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[571.438835] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.022s)
[571.449139] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[571.461408] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.021s)
[571.471447] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[571.483640] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.021s)
[571.493296] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[571.505797] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.022s)
[571.515438] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[571.528011] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.022s)
[571.537727] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[571.695258] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.166s)
[571.710236] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[571.717446] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.021s)
[571.727896] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[571.739696] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.021s)
[571.752142] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[571.761848] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.021s)
[571.771578] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[571.783979] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.021s)
[571.793771] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[571.806304] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.022s)
[571.815764] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[571.828185] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.021s)
[571.837622] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[571.850316] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.022s)
[571.861498] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[571.872531] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.021s)
[572.276192] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.630s)
[573.116240] [114/131] (512s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[573.220901] Starting subtest: 4-tiled-64bpp-rotate-270
[573.240309] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.019s)
[573.376356] [115/131] (512s left) gem_exec_balancer (invalid-bonds)
[573.441968] Starting subtest: invalid-bonds
[573.446519] Subtest invalid-bonds: SKIP (0.000s)
[573.770066] [116/131] (511s left) gem_exec_gttfill (basic)
[573.830426] Starting subtest: basic
[576.401718] Subtest basic: SUCCESS (2.570s)
[576.602749] [117/131] (509s left) kms_getfb (getfb2-handle-not-fb)
[576.749892] Starting subtest: getfb2-handle-not-fb
[576.752179] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[576.869056] [118/131] (508s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[576.959496] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[576.963387] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[577.094003] [119/131] (508s left) kms_big_fb (linear-16bpp-rotate-270)
[577.188087] Starting subtest: linear-16bpp-rotate-270
[577.207831] Subtest linear-16bpp-rotate-270: SKIP (0.019s)
[577.379887] [120/131] (508s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[577.488430] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[577.492463] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[577.623188] [121/131] (508s left) gem_ctx_engines (execute-one)
[577.673630] Starting subtest: execute-one
[580.113437] Subtest execute-one: SUCCESS (2.440s)
[580.324580] [122/131] (505s left) sysfs_timeslice_duration (timeout)
[580.394846] Starting subtest: timeout
[580.397106] Starting dynamic subtest: vecs0
[589.637199] Dynamic subtest vecs0: SUCCESS (9.241s)
[589.650651] Starting dynamic subtest: ccs0
[591.037324] Dynamic subtest ccs0: SUCCESS (1.400s)
[591.047725] Starting dynamic subtest: vcs0
[600.612207] Dynamic subtest vcs0: SUCCESS (9.571s)
[600.625103] Starting dynamic subtest: bcs0
[601.331276] Dynamic subtest bcs0: SUCCESS (0.716s)
[601.344454] Starting dynamic subtest: rcs0
[602.708493] Dynamic subtest rcs0: SUCCESS (1.377s)
[602.720811] Starting dynamic subtest: vcs1
[612.632462] Dynamic subtest vcs1: SUCCESS (9.917s)
[612.635401] Subtest timeout: SUCCESS (32.236s)
[612.719341] [123/131] (473s left) perf_pmu (multi-client)
[612.763955] Starting subtest: multi-client
[612.766233] Starting dynamic subtest: rcs0
[613.849064] Dynamic subtest rcs0: SUCCESS (1.083s)
[613.860595] Starting dynamic subtest: bcs0
[614.904220] Dynamic subtest bcs0: SUCCESS (1.052s)
[614.916745] Starting dynamic subtest: vcs0
[615.955035] Dynamic subtest vcs0: SUCCESS (1.049s)
[615.968293] Starting dynamic subtest: vcs1
[617.657157] Dynamic subtest vcs1: SUCCESS (1.698s)
[617.668264] Starting dynamic subtest: vecs0
[619.642386] Dynamic subtest vecs0: SUCCESS (1.983s)
[619.653682] Starting dynamic subtest: ccs0
[621.626444] Dynamic subtest ccs0: SUCCESS (1.982s)
[621.629544] Subtest multi-client: SUCCESS (8.861s)
[621.767490] [124/131] (464s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[621.878225] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[621.882632] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[621.997500] [125/131] (464s left) gen9_exec_parse (allowed-single)
[622.053925] Subtest allowed-single: SKIP (0.000s)
[622.138025] [126/131] (463s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[622.242012] Starting subtest: 4-tiled-16bpp-rotate-0
[623.496735] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.256s)
[623.654856] [127/131] (462s left) kms_fbcon_fbt (fbc)
[623.714735] Starting subtest: fbc
[630.039637] Subtest fbc: SUCCESS (6.322s)
[631.129561] [128/131] (455s left) kms_flip (2x-flip-vs-panning)
[631.236950] Starting subtest: 2x-flip-vs-panning
[631.246055] Subtest 2x-flip-vs-panning: SKIP (0.011s)
[631.330394] [129/131] (454s left) kms_plane_multiple (2x-tiling-x)
[631.430315] Starting subtest: 2x-tiling-x
[631.434455] Subtest 2x-tiling-x: SKIP (0.000s)
[631.527600] [130/131] (454s left) kms_cursor_crc (cursor-offscreen-128x128)
[631.738619] Starting subtest: cursor-offscreen-128x128
[631.743484] Starting dynamic subtest: pipe-A-eDP-1
[633.689934] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.945s)
[633.718143] Starting dynamic subtest: pipe-D-eDP-1
[636.251063] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.541s)
[636.253342] Subtest cursor-offscreen-128x128: SUCCESS (4.511s)
[637.165216] [131/131] (449s left) kms_psr (psr-sprite-plane-move)
[637.268556] Starting subtest: psr-sprite-plane-move
[637.270855] Starting dynamic subtest: eDP-1
[639.074297] Dynamic subtest eDP-1: SUCCESS (1.804s)
[639.076291] Subtest psr-sprite-plane-move: SUCCESS (1.805s)
[639.903055] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: perf_pmu
results: parsing output: 2/ for test: gem_mmap_offset
results: parsing output: 3/ for test: kms_flip
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: sw_sync
results: parsing output: 6/ for test: gem_exec_balancer
results: parsing output: 7/ for test: kms_lease
results: parsing output: 8/ for test: kms_vblank
results: parsing output: 9/ for test: api_intel_bb
results: parsing output: 10/ for test: gem_exec_schedule
results: parsing output: 11/ for test: syncobj_wait
results: parsing output: 12/ for test: gem_userptr_blits
results: parsing output: 13/ for test: kms_feature_discovery
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_psr2_sf
results: parsing output: 16/ for test: sw_sync
results: parsing output: 17/ for test: kms_invalid_mode
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: prime_vgem
results: parsing output: 21/ for test: kms_chamelium_color
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: gem_exec_alignment
results: parsing output: 25/ for test: api_intel_allocator
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: syncobj_eventfd
results: parsing output: 28/ for test: gem_partial_pwrite_pread
results: parsing output: 29/ for test: kms_cursor_crc
results: parsing output: 30/ for test: gem_wait
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_lmem_swapping
results: parsing output: 33/ for test: kms_plane_scaling
results: parsing output: 34/ for test: kms_psr2_sf
results: parsing output: 35/ for test: kms_flip
results: parsing output: 36/ for test: i915_suspend
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_properties
results: parsing output: 39/ for test: gem_pxp
results: parsing output: 40/ for test: kms_vblank
results: parsing output: 41/ for test: kms_plane
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: kms_dirtyfb
results: parsing output: 44/ for test: gem_render_copy
results: parsing output: 45/ for test: syncobj_timeline
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: gem_ctx_exec
results: parsing output: 48/ for test: i915_fb_tiling
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: kms_pm_rpm
results: parsing output: 51/ for test: gem_pxp
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: kms_flip
results: parsing output: 55/ for test: gem_exec_schedule
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_ccs
results: parsing output: 58/ for test: gem_exec_reloc
results: parsing output: 59/ for test: gem_caching
results: parsing output: 60/ for test: gem_wait
results: parsing output: 61/ for test: prime_vgem
results: parsing output: 62/ for test: kms_chamelium_hpd
results: parsing output: 63/ for test: kms_flip_scaled_crc
results: parsing output: 64/ for test: i915_drm_fdinfo
results: parsing output: 65/ for test: gem_set_tiling_vs_blt
results: parsing output: 66/ for test: gem_exec_reloc
results: parsing output: 67/ for test: fbdev
results: parsing output: 68/ for test: gem_render_linear_blits
results: parsing output: 69/ for test: kms_flip_scaled_crc
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_ccs
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: kms_ccs
results: parsing output: 75/ for test: kms_cursor_crc
results: parsing output: 76/ for test: kms_cursor_legacy
results: parsing output: 77/ for test: gem_exec_reloc
results: parsing output: 78/ for test: syncobj_timeline
results: parsing output: 79/ for test: syncobj_wait
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_pm_rpm
results: parsing output: 82/ for test: kms_cursor_legacy
results: parsing output: 83/ for test: core_sysfs
results: parsing output: 84/ for test: vgem_basic
results: parsing output: 85/ for test: i915_query
results: parsing output: 86/ for test: kms_chamelium_hpd
results: parsing output: 87/ for test: kms_tv_load_detect
results: parsing output: 88/ for test: gem_exec_fence
results: parsing output: 89/ for test: gem_exec_whisper
results: parsing output: 90/ for test: gem_ctx_persistence
results: parsing output: 91/ for test: gem_exec_reloc
results: parsing output: 92/ for test: kms_cursor_legacy
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_getfb
results: parsing output: 95/ for test: i915_pm_rps
results: parsing output: 96/ for test: gem_softpin
results: parsing output: 97/ for test: gem_exec_fence
results: parsing output: 98/ for test: kms_psr
results: parsing output: 99/ for test: gem_eio
results: parsing output: 100/ for test: gem_userptr_blits
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: kms_pipe_stress
results: parsing output: 104/ for test: kms_cursor_legacy
results: parsing output: 105/ for test: kms_atomic_interruptible
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_color
results: parsing output: 108/ for test: gem_exec_whisper
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: kms_ccs
results: parsing output: 112/ for test: kms_async_flips
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: gem_exec_balancer
results: parsing output: 115/ for test: gem_exec_gttfill
results: parsing output: 116/ for test: kms_getfb
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: gem_ctx_engines
results: parsing output: 121/ for test: sysfs_timeslice_duration
results: parsing output: 122/ for test: perf_pmu
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gen9_exec_parse
results: parsing output: 125/ for test: kms_big_fb
results: parsing output: 126/ for test: kms_fbcon_fbt
results: parsing output: 127/ for test: kms_flip
results: parsing output: 128/ for test: kms_plane_multiple
results: parsing output: 129/ for test: kms_cursor_crc
results: parsing output: 130/ for test: kms_psr
Done.