[57.191040] Initializing watchdogs
[57.191126]   /dev/watchdog0
[57.212748] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[57.223229] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[57.226947] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.229361] [001/131] (960s left) kms_psr (psr2-cursor-mmap-gtt)
[57.415490] Subtest psr2-cursor-mmap-gtt: SKIP (0.000s)
[57.508691] [002/131] (960s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[57.704189] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[57.705999] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[57.882486] [003/131] (960s left) gem_pxp (verify-pxp-stale-buf-optout-execution)
[60.475302] Starting subtest: verify-pxp-stale-buf-optout-execution
[60.478204] Subtest verify-pxp-stale-buf-optout-execution: SKIP (0.000s)
[60.591986] [004/131] (957s left) gem_userptr_blits (stress-purge)
[60.675453] Starting subtest: stress-purge
[66.043387] Subtest stress-purge: SUCCESS (5.378s)
[66.222529] [005/131] (951s left) gem_busy (parallel)
[66.504343] Starting subtest: parallel
[66.505337] Starting dynamic subtest: rcs0
[66.607055] Dynamic subtest rcs0: SUCCESS (0.103s)
[66.617276] Starting dynamic subtest: bcs0
[66.672634] Dynamic subtest bcs0: SUCCESS (0.066s)
[66.681172] Starting dynamic subtest: vcs0
[66.730354] Dynamic subtest vcs0: SUCCESS (0.058s)
[66.738725] Starting dynamic subtest: vcs1
[66.793518] Dynamic subtest vcs1: SUCCESS (0.063s)
[66.801981] Starting dynamic subtest: vecs0
[67.106529] Dynamic subtest vecs0: SUCCESS (0.313s)
[67.115117] Starting dynamic subtest: vecs1
[67.322520] Dynamic subtest vecs1: SUCCESS (0.216s)
[67.331279] Starting dynamic subtest: ccs0
[67.557839] Dynamic subtest ccs0: SUCCESS (0.228s)
[67.558806] Subtest parallel: SUCCESS (1.047s)
[67.812213] [006/131] (950s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[68.006632] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[68.008266] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[68.209584] [007/131] (949s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[68.397530] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[68.398440] Starting dynamic subtest: pipe-A-valid-mode
[68.480265] Dynamic subtest pipe-A-valid-mode: SKIP (0.081s)
[68.482087] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.082s)
[68.729700] [008/131] (949s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[68.914954] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[72.169320] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (3.257s)
[72.445145] [009/131] (945s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[72.629980] Starting subtest: 2x-flip-vs-cursor-atomic
[72.632796] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.002s)
[72.790814] [010/131] (945s left) gem_softpin (allocator-basic-reserve)
[72.866426] Starting subtest: allocator-basic-reserve
[73.107965] Subtest allocator-basic-reserve: SUCCESS (0.235s)
[73.313300] [011/131] (945s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[73.494962] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[73.495836] Starting dynamic subtest: pipe-A-DP-3
[73.499143] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[73.507511] Starting dynamic subtest: pipe-B-DP-3
[73.510995] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[73.519266] Starting dynamic subtest: pipe-C-DP-3
[73.522742] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[73.530921] Starting dynamic subtest: pipe-D-DP-3
[73.534223] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[73.535924] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SKIP (0.004s)
[73.959601] [012/131] (944s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[74.142929] Starting subtest: nonblocking-crc-frame-sequence
[74.143797] Starting dynamic subtest: pipe-A-DP-3
[74.900756] Dynamic subtest pipe-A-DP-3: SUCCESS (0.756s)
[74.923289] Starting dynamic subtest: pipe-B-DP-3
[75.556222] Dynamic subtest pipe-B-DP-3: SUCCESS (0.653s)
[75.568611] Starting dynamic subtest: pipe-C-DP-3
[76.164494] Dynamic subtest pipe-C-DP-3: SUCCESS (0.606s)
[76.175185] Starting dynamic subtest: pipe-D-DP-3
[76.759871] Dynamic subtest pipe-D-DP-3: SUCCESS (0.595s)
[76.760948] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.619s)
[77.070576] [013/131] (941s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[77.255994] Starting subtest: cursor-vs-flip-varying-size
[110.078607] Subtest cursor-vs-flip-varying-size: SUCCESS (32.822s)
[110.390145] [014/131] (908s left) gem_create (hog-create)
[110.464298] Starting subtest: hog-create
[110.465249] Starting dynamic subtest: lmem0
[142.746280] Dynamic subtest lmem0: SUCCESS (32.282s)
[142.755218] Starting dynamic subtest: smem0
[174.998234] Dynamic subtest smem0: SUCCESS (32.251s)
[174.999167] Subtest hog-create: SUCCESS (64.533s)
[175.277074] [015/131] (843s left) gem_mmap_gtt (cpuset-big-copy-odd)
[175.339921] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[175.417565] [016/131] (843s left) syncobj_timeline (multi-wait-submitted-signaled)
[175.496227] Starting subtest: multi-wait-submitted-signaled
[175.497173] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[175.647288] [017/131] (843s left) i915_fb_tiling (basic-x-tiling)
[175.716915] Subtest basic-x-tiling: SKIP (0.000s)
[175.790480] [018/131] (843s left) kms_plane_multiple (2x-tiling-none)
[175.970476] Starting subtest: 2x-tiling-none
[175.972278] Subtest 2x-tiling-none: SKIP (0.000s)
[176.105232] [019/131] (842s left) prime_self_import (basic-with_two_bos)
[176.149683] Starting subtest: basic-with_two_bos
[176.186857] Subtest basic-with_two_bos: SUCCESS (0.038s)
[176.324579] [020/131] (842s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[176.396287] Starting subtest: etime-single-wait-for-submit-unsubmitted
[176.500484] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.102s)
[176.626118] [021/131] (842s left) kms_big_fb (linear-addfb)
[176.819193] Starting subtest: linear-addfb
[176.820109] Subtest linear-addfb: SUCCESS (0.000s)
[177.011477] [022/131] (842s left) kms_flip (2x-nonexisting-fb-interruptible)
[177.199874] Starting subtest: 2x-nonexisting-fb-interruptible
[177.215274] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.014s)
[177.396257] [023/131] (841s left) kms_lease (empty-lease)
[177.579369] Starting subtest: empty-lease
[177.580294] Starting dynamic subtest: pipe-A-DP-3
[177.582307] Dynamic subtest pipe-A-DP-3: SUCCESS (0.002s)
[177.592141] Starting dynamic subtest: pipe-B-DP-3
[177.593563] Dynamic subtest pipe-B-DP-3: SUCCESS (0.002s)
[177.602243] Starting dynamic subtest: pipe-C-DP-3
[177.603178] Dynamic subtest pipe-C-DP-3: SUCCESS (0.002s)
[177.611790] Starting dynamic subtest: pipe-D-DP-3
[177.612612] Dynamic subtest pipe-D-DP-3: SUCCESS (0.002s)
[177.613445] Subtest empty-lease: SUCCESS (0.011s)
[177.794585] [024/131] (841s left) kms_feature_discovery (chamelium)
[177.994119] Starting subtest: chamelium
[177.996229] Subtest chamelium: SKIP (0.000s)
[178.137791] [025/131] (841s left) i915_pm_rps (min-max-config-idle)
[178.216855] Starting subtest: min-max-config-idle
[178.218645] Subtest min-max-config-idle: SKIP (0.001s)
[178.396398] [026/131] (841s left) gem_exec_balancer (bonded-dual)
[178.478039] Starting subtest: bonded-dual
[178.480379] Subtest bonded-dual: SKIP (0.000s)
[178.882857] [027/131] (840s left) gem_exec_parallel (engines)
[178.962859] Starting subtest: engines
[178.963807] Starting dynamic subtest: basic
[180.486635] Dynamic subtest basic: SUCCESS (1.523s)
[180.496915] Starting dynamic subtest: contexts
[185.090429] Dynamic subtest contexts: SUCCESS (4.603s)
[185.100185] Starting dynamic subtest: fds
[189.944581] Dynamic subtest fds: SUCCESS (4.854s)
[189.954069] Starting dynamic subtest: userptr
[191.422959] Dynamic subtest userptr: SUCCESS (1.478s)
[191.424117] Subtest engines: SUCCESS (12.460s)
[191.736672] [028/131] (827s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[191.927902] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[191.929480] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[192.125618] [029/131] (827s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[192.321119] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[192.396663] [030/131] (827s left) kms_flip (dpms-off-confusion-interruptible)
[192.583649] Starting subtest: dpms-off-confusion-interruptible
[192.588251] Starting dynamic subtest: A-DP3
[200.416305] Dynamic subtest A-DP3: SUCCESS (7.827s)
[200.453594] Starting dynamic subtest: B-DP3
[208.175647] Dynamic subtest B-DP3: SUCCESS (7.757s)
[208.186197] Starting dynamic subtest: C-DP3
[215.935188] Dynamic subtest C-DP3: SUCCESS (7.759s)
[215.945394] Starting dynamic subtest: D-DP3
[223.681513] Dynamic subtest D-DP3: SUCCESS (7.745s)
[223.686312] Subtest dpms-off-confusion-interruptible: SUCCESS (31.102s)
[224.039374] [031/131] (795s left) kms_chamelium_frames (dp-crc-fast)
[224.306291] Subtest dp-crc-fast: SKIP (0.000s)
[224.487814] [032/131] (795s left) gen9_exec_parse (bb-start-out)
[224.564054] Subtest bb-start-out: SKIP (0.000s)
[224.642758] [033/131] (795s left) gem_flink_basic (flink-lifetime)
[224.711060] Starting subtest: flink-lifetime
[224.734219] Subtest flink-lifetime: SUCCESS (0.023s)
[224.870742] [034/131] (795s left) gem_userptr_blits (sync-overlap)
[224.958938] Starting subtest: sync-overlap
[224.959822] Subtest sync-overlap: SUCCESS (0.000s)
[225.130557] [035/131] (794s left) kms_tv_load_detect (load-detect)
[225.202143] Subtest load-detect: SKIP (0.000s)
[225.292036] [036/131] (794s left) gem_exec_params (mmapped)
[225.367398] Starting subtest: mmapped
[225.369439] Subtest mmapped: SUCCESS (0.002s)
[225.535559] [037/131] (794s left) kms_flip (plain-flip-ts-check)
[225.717568] Starting subtest: plain-flip-ts-check
[225.721601] Starting dynamic subtest: A-DP3
[233.849696] Dynamic subtest A-DP3: SUCCESS (8.127s)
[233.888045] Starting dynamic subtest: B-DP3
[241.936811] Dynamic subtest B-DP3: SUCCESS (8.085s)
[241.947163] Starting dynamic subtest: C-DP3
[249.992117] Dynamic subtest C-DP3: SUCCESS (8.054s)
[250.008860] Starting dynamic subtest: D-DP3
[258.045202] Dynamic subtest D-DP3: SUCCESS (8.050s)
[258.049608] Subtest plain-flip-ts-check: SUCCESS (32.332s)
[258.407727] [038/131] (761s left) gem_exec_schedule (submit-golden-slice)
[258.497448] Starting subtest: submit-golden-slice
[258.498425] Starting dynamic subtest: rcs0
[258.577630] Dynamic subtest rcs0: SUCCESS (0.080s)
[258.587197] Starting dynamic subtest: bcs0
[258.634303] Dynamic subtest bcs0: SUCCESS (0.056s)
[258.643845] Starting dynamic subtest: vcs0
[258.686758] Dynamic subtest vcs0: SUCCESS (0.052s)
[258.695962] Starting dynamic subtest: vcs1
[258.754347] Dynamic subtest vcs1: SUCCESS (0.067s)
[258.764150] Starting dynamic subtest: vecs0
[258.804041] Dynamic subtest vecs0: SUCCESS (0.049s)
[258.813501] Starting dynamic subtest: vecs1
[258.860081] Dynamic subtest vecs1: SUCCESS (0.056s)
[258.869522] Starting dynamic subtest: ccs0
[258.908040] Dynamic subtest ccs0: SUCCESS (0.047s)
[258.908936] Subtest submit-golden-slice: SUCCESS (0.411s)
[259.344813] [039/131] (760s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[259.533262] Starting subtest: y-tiled-16bpp-rotate-180
[259.535020] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[259.740416] [040/131] (760s left) gem_exec_reloc (basic-wc-read-noreloc)
[259.819164] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[259.899834] [041/131] (760s left) kms_flip (flip-vs-expired-vblank)
[260.082153] Starting subtest: flip-vs-expired-vblank
[260.086266] Starting dynamic subtest: A-DP3
[267.921296] Dynamic subtest A-DP3: SUCCESS (7.835s)
[267.932299] Starting dynamic subtest: B-DP3
[275.700760] Dynamic subtest B-DP3: SUCCESS (7.777s)
[275.714110] Starting dynamic subtest: C-DP3
[283.472122] Dynamic subtest C-DP3: SUCCESS (7.767s)
[283.489210] Starting dynamic subtest: D-DP3
[291.235834] Dynamic subtest D-DP3: SUCCESS (7.760s)
[291.237993] Subtest flip-vs-expired-vblank: SUCCESS (31.155s)
[291.567206] [042/131] (728s left) gem_sync (basic-store-each)
[291.649500] Starting subtest: basic-store-each
[294.686449] Subtest basic-store-each: SUCCESS (3.036s)
[294.962303] [043/131] (725s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[295.156427] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[296.185268] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (1.029s)
[296.413063] [044/131] (724s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[296.599893] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[296.601536] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[296.816490] [045/131] (723s left) gem_pread (uncached)
[296.885148] Subtest uncached: SKIP (0.000s)
[297.000670] [046/131] (723s left) i915_selftest (live)
[298.091993] Starting subtest: live
[298.093044] Starting dynamic subtest: sanitycheck
[299.707384] Dynamic subtest sanitycheck: SUCCESS (1.615s)
[299.715310] Starting dynamic subtest: uncore
[301.209425] Dynamic subtest uncore: SUCCESS (1.501s)
[301.217173] Starting dynamic subtest: workarounds
[317.831814] Dynamic subtest workarounds: FAIL (16.411s)
[317.838904] Starting dynamic subtest: gt_engines
[319.959223] Dynamic subtest gt_engines: SUCCESS (2.337s)
[319.967801] Starting dynamic subtest: gt_timelines
[339.510030] Dynamic subtest gt_timelines: SUCCESS (19.550s)
[339.518523] Starting dynamic subtest: gt_contexts
[341.067182] Dynamic subtest gt_contexts: SUCCESS (1.556s)
[341.076052] Starting dynamic subtest: gt_lrc
[347.364118] Dynamic subtest gt_lrc: SUCCESS (6.296s)
[347.372733] Starting dynamic subtest: gt_mocs
[350.243855] Dynamic subtest gt_mocs: SUCCESS (2.879s)
[350.252391] Starting dynamic subtest: gt_pm
[354.370045] Dynamic subtest gt_pm: SUCCESS (4.125s)
[354.378470] Starting dynamic subtest: gt_heartbeat
[355.905050] Dynamic subtest gt_heartbeat: SUCCESS (1.534s)
[355.913589] Starting dynamic subtest: gt_tlb
[368.523945] Dynamic subtest gt_tlb: SUCCESS (12.618s)
[368.532377] Starting dynamic subtest: requests
[381.978881] Dynamic subtest requests: SUCCESS (13.454s)
[381.987391] Starting dynamic subtest: migrate
[387.067068] Dynamic subtest migrate: SUCCESS (5.087s)
[387.075454] Starting dynamic subtest: active
[388.577031] Dynamic subtest active: SUCCESS (1.509s)
[388.585303] Starting dynamic subtest: objects
[390.879863] Dynamic subtest objects: SUCCESS (2.302s)
[390.888594] Starting dynamic subtest: mman
[397.505034] Dynamic subtest mman: SUCCESS (6.624s)
[397.514162] Starting dynamic subtest: dmabuf
[399.111959] Dynamic subtest dmabuf: SUCCESS (1.606s)
[399.120783] Starting dynamic subtest: vma
[400.621903] Dynamic subtest vma: SUCCESS (1.509s)
[400.630590] Starting dynamic subtest: coherency
[404.415880] Dynamic subtest coherency: SUCCESS (3.793s)
[404.424208] Starting dynamic subtest: gtt
[414.368973] Dynamic subtest gtt: SUCCESS (9.952s)
[414.377859] Starting dynamic subtest: gem
[416.004029] Dynamic subtest gem: SUCCESS (1.634s)
[416.012434] Starting dynamic subtest: evict
[418.880021] Dynamic subtest evict: SUCCESS (2.875s)
[418.888410] Starting dynamic subtest: hugepages
[436.929111] Dynamic subtest hugepages: SUCCESS (18.048s)
[436.938163] Starting dynamic subtest: gem_contexts
[470.045932] Dynamic subtest gem_contexts: SUCCESS (33.115s)
[470.055157] Starting dynamic subtest: client
[471.631232] Dynamic subtest client: SUCCESS (1.584s)
[471.640390] Starting dynamic subtest: gem_migrate
[475.226218] Dynamic subtest gem_migrate: SUCCESS (3.593s)
[475.234826] Starting dynamic subtest: reset
[476.840970] Dynamic subtest reset: SUCCESS (1.614s)
[476.850538] Starting dynamic subtest: memory_region
[479.991884] Dynamic subtest memory_region: SUCCESS (3.150s)
[480.000320] Starting dynamic subtest: hangcheck
[509.589850] Dynamic subtest hangcheck: SUCCESS (29.597s)
[509.598414] Starting dynamic subtest: execlists
[511.111877] Dynamic subtest execlists: SUCCESS (1.521s)
[511.120396] Starting dynamic subtest: ring_submission
[512.675107] Dynamic subtest ring_submission: SUCCESS (1.562s)
[512.684220] Starting dynamic subtest: perf
[514.303895] Dynamic subtest perf: SUCCESS (1.628s)
[514.312081] Starting dynamic subtest: slpc
[521.392985] Dynamic subtest slpc: SUCCESS (7.088s)
[521.401192] Starting dynamic subtest: guc
[524.257124] Dynamic subtest guc: SUCCESS (2.863s)
[524.267871] Starting dynamic subtest: guc_multi_lrc
[525.814016] Dynamic subtest guc_multi_lrc: SUCCESS (1.556s)
[525.823279] Starting dynamic subtest: guc_hang
[528.119976] Dynamic subtest guc_hang: SUCCESS (2.305s)
[528.128454] Starting dynamic subtest: late_gt_pm
[529.749935] Dynamic subtest late_gt_pm: SUCCESS (1.629s)
[529.750887] Subtest live: FAIL (231.655s)
[529.781662] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[529.783557] [047/131] (491s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[531.524019] Starting subtest: 4-tiled-32bpp-rotate-0
[533.397216] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.873s)
[533.637426] [FACT kms_big_fb (4-tiled-32bpp-rotate-0)] new: kernel.kmod_is_loaded.i915: true
[533.640390] [048/131] (487s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[533.835444] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[536.282295] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (2.447s)
[536.516888] [049/131] (484s left) kms_psr (psr-sprite-blt)
[536.705476] Subtest psr-sprite-blt: SKIP (0.000s)
[536.754020] [050/131] (484s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[536.942332] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[536.943998] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[537.143814] [051/131] (483s left) kms_cursor_edge_walk (128x128-top-edge)
[537.325976] Starting subtest: 128x128-top-edge
[537.328325] Starting dynamic subtest: pipe-A-DP-3
[540.792196] Dynamic subtest pipe-A-DP-3: SUCCESS (3.464s)
[540.803473] Starting dynamic subtest: pipe-D-DP-3
[544.167555] Dynamic subtest pipe-D-DP-3: SUCCESS (3.371s)
[544.168942] Subtest 128x128-top-edge: SUCCESS (6.840s)
[544.459337] [052/131] (476s left) kms_chamelium_frames (hdmi-crc-multiple)
[544.715828] Subtest hdmi-crc-multiple: SKIP (0.000s)
[544.864975] [053/131] (476s left) kms_properties (connector-properties-legacy)
[545.048538] Starting subtest: connector-properties-legacy
[545.051143] Starting dynamic subtest: pipe-A-DP-3
[546.582448] Dynamic subtest pipe-A-DP-3: SUCCESS (1.530s)
[546.598132] Starting dynamic subtest: pipe-None-DP-1
[546.600258] Dynamic subtest pipe-None-DP-1: SUCCESS (0.002s)
[546.612853] Starting dynamic subtest: pipe-None-DP-2
[546.614646] Dynamic subtest pipe-None-DP-2: SUCCESS (0.002s)
[546.624113] Starting dynamic subtest: pipe-None-HDMI-A-1
[546.626357] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.002s)
[546.635633] Starting dynamic subtest: pipe-None-HDMI-A-2
[546.637924] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.002s)
[546.647231] Starting dynamic subtest: pipe-None-DP-4
[546.649565] Dynamic subtest pipe-None-DP-4: SUCCESS (0.002s)
[546.658959] Starting dynamic subtest: pipe-None-HDMI-A-3
[546.660734] Dynamic subtest pipe-None-HDMI-A-3: SUCCESS (0.002s)
[546.661570] Subtest connector-properties-legacy: SUCCESS (1.557s)
[546.911075] [054/131] (474s left) kms_joiner (basic-ultra-joiner)
[547.102879] Starting subtest: basic-ultra-joiner
[547.104540] Subtest basic-ultra-joiner: SKIP (0.000s)
[547.258783] [055/131] (474s left) gem_ctx_param (non-root-set)
[547.327808] Starting subtest: non-root-set
[547.344612] Subtest non-root-set: SUCCESS (0.017s)
[547.509489] [056/131] (474s left) gem_workarounds (reset-fd)
[547.598776] Starting subtest: reset-fd
[547.865274] Subtest reset-fd: SUCCESS (0.266s)
[548.041578] [057/131] (473s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[548.232223] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[548.233956] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[548.425717] [058/131] (473s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[548.604915] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[548.831751] Starting dynamic subtest: pipe-A-DP-3-4-rc-ccs
[551.124384] Dynamic subtest pipe-A-DP-3-4-rc-ccs: SUCCESS (2.292s)
[551.135248] Starting dynamic subtest: pipe-A-DP-3-4
[553.323031] Dynamic subtest pipe-A-DP-3-4: SUCCESS (2.198s)
[553.333818] Starting dynamic subtest: pipe-A-DP-3-4
[555.339934] Dynamic subtest pipe-A-DP-3-4: SUCCESS (2.016s)
[555.350926] Starting dynamic subtest: pipe-A-DP-3-x
[557.523262] Dynamic subtest pipe-A-DP-3-x: SUCCESS (2.182s)
[557.750272] Starting dynamic subtest: pipe-B-DP-3-4-rc-ccs
[560.002940] Dynamic subtest pipe-B-DP-3-4-rc-ccs: SUCCESS (2.263s)
[560.013280] Starting dynamic subtest: pipe-B-DP-3-4
[562.168568] Dynamic subtest pipe-B-DP-3-4: SUCCESS (2.165s)
[562.179170] Starting dynamic subtest: pipe-B-DP-3-4
[564.185481] Dynamic subtest pipe-B-DP-3-4: SUCCESS (2.016s)
[564.195720] Starting dynamic subtest: pipe-B-DP-3-x
[566.352334] Dynamic subtest pipe-B-DP-3-x: SUCCESS (2.166s)
[566.564316] Starting dynamic subtest: pipe-C-DP-3-4-rc-ccs
[568.812628] Dynamic subtest pipe-C-DP-3-4-rc-ccs: SUCCESS (2.258s)
[568.823143] Starting dynamic subtest: pipe-C-DP-3-4
[570.978016] Dynamic subtest pipe-C-DP-3-4: SUCCESS (2.164s)
[570.989175] Starting dynamic subtest: pipe-C-DP-3-4
[572.996226] Dynamic subtest pipe-C-DP-3-4: SUCCESS (2.016s)
[573.022159] Starting dynamic subtest: pipe-C-DP-3-x
[575.161503] Dynamic subtest pipe-C-DP-3-x: SUCCESS (2.162s)
[575.372232] Starting dynamic subtest: pipe-D-DP-3-4-rc-ccs
[577.627399] Dynamic subtest pipe-D-DP-3-4-rc-ccs: SUCCESS (2.265s)
[577.646146] Starting dynamic subtest: pipe-D-DP-3-4
[579.791502] Dynamic subtest pipe-D-DP-3-4: SUCCESS (2.162s)
[579.806364] Starting dynamic subtest: pipe-D-DP-3-4
[581.808576] Dynamic subtest pipe-D-DP-3-4: SUCCESS (2.014s)
[581.825676] Starting dynamic subtest: pipe-D-DP-3-x
[583.974371] Dynamic subtest pipe-D-DP-3-x: SUCCESS (2.163s)
[583.975368] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (35.369s)
[584.436581] [059/131] (437s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[584.619427] Starting subtest: cursorB-vs-flipA-atomic-transitions
[584.621174] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.002s)
[584.783354] [060/131] (437s left) perf_pmu (interrupts-sync)
[584.846794] Starting subtest: interrupts-sync
[586.025505] Subtest interrupts-sync: SUCCESS (1.177s)
[586.214787] [FACT perf_pmu (interrupts-sync)] new: kernel.kmod_is_loaded.vgem: true
[586.217511] [061/131] (435s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[586.410404] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[586.412155] Subtest psr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[586.555615] [062/131] (435s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[586.752194] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[586.813237] [063/131] (435s left) kms_content_protection (uevent)
[587.072571] Starting subtest: uevent
[587.103809] Starting dynamic subtest: pipe-A-DP-3
[621.371988] Dynamic subtest pipe-A-DP-3: FAIL (34.217s)
[621.427938] Subtest uevent: FAIL (34.354s)
[621.723198] [064/131] (400s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[621.913438] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[621.914337] Starting dynamic subtest: pipe-A-valid-mode
[621.998533] Dynamic subtest pipe-A-valid-mode: SKIP (0.084s)
[622.000374] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.086s)
[622.258254] [065/131] (399s left) kms_psr (fbc-psr2-sprite-render)
[622.447861] Subtest fbc-psr2-sprite-render: SKIP (0.000s)
[622.502202] [066/131] (399s left) perf_pmu (busy-double-start)
[622.573739] Starting subtest: busy-double-start
[622.574612] Starting dynamic subtest: rcs0
[626.195316] Dynamic subtest rcs0: SUCCESS (3.620s)
[626.211251] Starting dynamic subtest: bcs0
[629.798351] Dynamic subtest bcs0: SUCCESS (3.598s)
[629.813800] Starting dynamic subtest: vcs0
[633.398424] Dynamic subtest vcs0: SUCCESS (3.595s)
[633.413657] Starting dynamic subtest: vcs1
[636.991420] Dynamic subtest vcs1: SUCCESS (3.588s)
[637.006825] Starting dynamic subtest: vecs0
[640.585400] Dynamic subtest vecs0: SUCCESS (3.589s)
[640.600632] Starting dynamic subtest: vecs1
[644.179654] Dynamic subtest vecs1: SUCCESS (3.589s)
[644.195582] Starting dynamic subtest: ccs0
[647.773194] Dynamic subtest ccs0: SUCCESS (3.588s)
[647.775920] Subtest busy-double-start: SUCCESS (25.201s)
[647.926295] [067/131] (374s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[648.120424] Starting subtest: 2x-long-flip-vs-cursor-atomic
[648.123392] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.002s)
[648.274289] [068/131] (374s left) gem_ctx_persistence (legacy-engines-mixed-process)
[648.359383] Starting subtest: legacy-engines-mixed-process
[648.360389] Starting dynamic subtest: render
[649.847744] Dynamic subtest render: SUCCESS (1.486s)
[649.860764] Starting dynamic subtest: bsd1
[651.903062] Dynamic subtest bsd1: SUCCESS (2.055s)
[651.917362] Starting dynamic subtest: bsd2
[653.891559] Dynamic subtest bsd2: SUCCESS (1.987s)
[653.905814] Starting dynamic subtest: blt
[655.869995] Dynamic subtest blt: SUCCESS (1.976s)
[655.883827] Starting dynamic subtest: vebox
[657.849783] Dynamic subtest vebox: SUCCESS (1.978s)
[657.850837] Subtest legacy-engines-mixed-process: SUCCESS (9.491s)
[657.992782] [069/131] (364s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[658.080449] Starting subtest: y-tiled-ccs-to-y-tiled
[658.082615] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[658.305694] [070/131] (364s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[658.493521] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[658.495989] Starting dynamic subtest: pipe-A-DP-3
[665.793656] Dynamic subtest pipe-A-DP-3: SUCCESS (7.298s)
[665.811120] Starting dynamic subtest: pipe-B-DP-3
[667.394787] Dynamic subtest pipe-B-DP-3: SUCCESS (1.597s)
[667.441048] Starting dynamic subtest: pipe-C-DP-3
[668.993509] Dynamic subtest pipe-C-DP-3: SUCCESS (1.590s)
[669.039723] Starting dynamic subtest: pipe-D-DP-3
[670.625876] Dynamic subtest pipe-D-DP-3: SUCCESS (1.623s)
[670.632384] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SUCCESS (12.134s)
[670.982881] [071/131] (351s left) gem_exec_reloc (basic-wc-cpu-active)
[671.067582] Subtest basic-wc-cpu-active: SKIP (0.000s)
[671.152064] [072/131] (351s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[671.346059] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[671.347824] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[671.540586] [073/131] (351s left) kms_vrr (seamless-rr-switch-virtual)
[671.731415] Starting subtest: seamless-rr-switch-virtual
[671.733992] Subtest seamless-rr-switch-virtual: SKIP (0.000s)
[671.885466] [074/131] (350s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[672.086394] Starting subtest: psr-2p-primscrn-cur-indfb-move
[672.088122] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[672.278644] [075/131] (350s left) syncobj_wait (multi-wait-all-submitted-signaled)
[672.357423] Starting subtest: multi-wait-all-submitted-signaled
[672.459203] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.101s)
[672.589924] [076/131] (350s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[672.782442] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs
[672.783332] Starting dynamic subtest: pipe-A-DP-3
[672.791898] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[672.803511] Starting dynamic subtest: pipe-B-DP-3
[672.812120] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[672.823511] Starting dynamic subtest: pipe-C-DP-3
[672.831799] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[672.843571] Starting dynamic subtest: pipe-D-DP-3
[672.854690] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[672.856628] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.007s)
[673.271683] [077/131] (349s left) kms_psr (fbc-pr-no-drrs)
[673.463810] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[673.532100] [078/131] (349s left) gen7_exec_parse (oacontrol-tracking)
[673.615065] Subtest oacontrol-tracking: SKIP (0.000s)
[673.701630] [079/131] (349s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[673.894589] Starting subtest: flip-vs-cursor-busy-crc-atomic
[674.663824] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.769s)
[674.991439] [080/131] (348s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[675.187037] Starting subtest: psr-rgb565-draw-mmap-cpu
[675.188793] Subtest psr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[675.371753] [081/131] (347s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[675.569573] Starting subtest: fbc-rgb565-draw-render
[679.137656] Subtest fbc-rgb565-draw-render: SUCCESS (3.569s)
[679.335898] [082/131] (343s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[679.617639] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[679.778695] [083/131] (343s left) gem_exec_flush (basic-uc-rw-default)
[679.867948] Subtest basic-uc-rw-default: SKIP (0.000s)
[679.960526] [084/131] (343s left) gem_pread (exhaustion)
[680.038266] Subtest exhaustion: SKIP (0.000s)
[680.114914] [085/131] (343s left) kms_cursor_crc (cursor-onscreen-128x42)
[680.514540] Starting subtest: cursor-onscreen-128x42
[680.519561] Starting dynamic subtest: pipe-A-DP-3
[683.384638] Dynamic subtest pipe-A-DP-3: SUCCESS (2.864s)
[683.438068] Starting dynamic subtest: pipe-D-DP-3
[686.133775] Dynamic subtest pipe-D-DP-3: SUCCESS (2.707s)
[686.134715] Subtest cursor-onscreen-128x42: SUCCESS (5.619s)
[686.560925] [086/131] (336s left) gem_ctx_create (basic)
[686.651587] Starting subtest: basic
[686.652562] Subtest basic: SUCCESS (0.000s)
[686.950330] [087/131] (336s left) kms_vblank (query-forked-busy)
[687.140787] Starting subtest: query-forked-busy
[687.143328] Starting dynamic subtest: pipe-A-DP-3
[689.683717] Dynamic subtest pipe-A-DP-3: SUCCESS (2.540s)
[689.746551] Starting dynamic subtest: pipe-D-DP-3
[692.246100] Dynamic subtest pipe-D-DP-3: SUCCESS (2.546s)
[692.247866] Subtest query-forked-busy: SUCCESS (5.106s)
[692.611117] [088/131] (331s left) gem_basic (create-close)
[692.691293] Starting subtest: create-close
[692.693059] Subtest create-close: SUCCESS (0.000s)
[692.850960] [089/131] (330s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[693.045037] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[693.046851] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[693.247058] [090/131] (330s left) sriov_basic (enable-vfs-autoprobe-off)
[693.326178] Subtest enable-vfs-autoprobe-off: SKIP (0.000s)
[693.490181] [091/131] (330s left) gem_linear_blits (normal)
[694.191490] Starting subtest: normal
[701.738418] Subtest normal: SUCCESS (7.547s)
[702.195531] [092/131] (321s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[702.436803] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[702.437745] Starting dynamic subtest: pipe-A
[702.530267] Dynamic subtest pipe-A: SUCCESS (0.093s)
[702.547856] Starting dynamic subtest: pipe-B
[702.747088] Dynamic subtest pipe-B: SUCCESS (0.216s)
[702.767876] Starting dynamic subtest: pipe-C
[702.982876] Dynamic subtest pipe-C: SUCCESS (0.234s)
[702.998148] Starting dynamic subtest: pipe-D
[703.214363] Dynamic subtest pipe-D: SUCCESS (0.230s)
[703.215203] Subtest planes-unity-scaling-downscale-factor-0-5: SUCCESS (0.778s)
[703.546805] [093/131] (320s left) syncobj_timeline (etime-multi-wait-all-submitted)
[703.633058] Starting subtest: etime-multi-wait-all-submitted
[703.745746] Subtest etime-multi-wait-all-submitted: SUCCESS (0.105s)
[703.872621] [094/131] (320s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[704.063994] Starting subtest: flip-vs-cursor-crc-atomic
[704.721502] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.658s)
[705.051102] [095/131] (319s left) kms_psr (pr-cursor-render)
[705.239240] Subtest pr-cursor-render: SKIP (0.000s)
[705.296029] [096/131] (318s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[705.500028] Starting subtest: x-tiled-64bpp-rotate-90
[705.552039] Subtest x-tiled-64bpp-rotate-90: SKIP (0.051s)
[705.753217] [097/131] (318s left) gem_lmem_swapping (heavy-verify-random)
[708.468812] Starting subtest: heavy-verify-random
[708.469642] Starting dynamic subtest: lmem0
[724.699758] Dynamic subtest lmem0: SUCCESS (16.230s)
[724.700832] Subtest heavy-verify-random: SUCCESS (16.231s)
[725.915801] [FACT gem_lmem_swapping (heavy-verify-random)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[725.916893] [FACT gem_lmem_swapping (heavy-verify-random)] deleted: kernel.kmod_is_loaded.i915: true
[725.919123] [098/131] (298s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-render)
[727.699228] Starting subtest: fbc-1p-offscren-pri-indfb-draw-render
[730.062153] Subtest fbc-1p-offscren-pri-indfb-draw-render: SUCCESS (2.363s)
[730.330351] [FACT kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-render)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[730.332896] [FACT kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-render)] new: kernel.kmod_is_loaded.i915: true
[730.335494] [099/131] (294s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[730.527926] Starting subtest: plane-downscale-factor-0-5-with-rotation
[730.528731] Starting dynamic subtest: pipe-A
[730.906380] Dynamic subtest pipe-A: SUCCESS (0.379s)
[730.931459] Starting dynamic subtest: pipe-B
[731.390203] Dynamic subtest pipe-B: SUCCESS (0.482s)
[731.419344] Starting dynamic subtest: pipe-C
[731.874793] Dynamic subtest pipe-C: SUCCESS (0.482s)
[731.893450] Starting dynamic subtest: pipe-D
[732.359059] Dynamic subtest pipe-D: SUCCESS (0.483s)
[732.360320] Subtest plane-downscale-factor-0-5-with-rotation: SUCCESS (1.833s)
[732.680479] [100/131] (291s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[732.878406] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[735.375778] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (2.498s)
[735.606765] [101/131] (289s left) gem_ctx_exec (basic)
[735.687213] Starting subtest: basic
[735.694703] Subtest basic: SUCCESS (0.007s)
[735.886608] [102/131] (288s left) api_intel_bb (object-reloc-keep-cache)
[735.964494] Starting subtest: object-reloc-keep-cache
[735.968164] Subtest object-reloc-keep-cache: SKIP (0.003s)
[736.145733] [103/131] (288s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[736.337653] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[736.339269] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[736.522446] [104/131] (288s left) sysfs_preempt_timeout (idempotent)
[736.612603] Starting subtest: idempotent
[736.613488] Starting dynamic subtest: vecs0
[736.614385] Dynamic subtest vecs0: SUCCESS (0.001s)
[736.625188] Starting dynamic subtest: ccs0
[736.626160] Dynamic subtest ccs0: SUCCESS (0.001s)
[736.637245] Starting dynamic subtest: vcs0
[736.638353] Dynamic subtest vcs0: SUCCESS (0.001s)
[736.649259] Starting dynamic subtest: bcs0
[736.650563] Dynamic subtest bcs0: SUCCESS (0.001s)
[736.661174] Starting dynamic subtest: vecs1
[736.662371] Dynamic subtest vecs1: SUCCESS (0.001s)
[736.673099] Starting dynamic subtest: rcs0
[736.674356] Dynamic subtest rcs0: SUCCESS (0.001s)
[736.684755] Starting dynamic subtest: vcs1
[736.685905] Dynamic subtest vcs1: SUCCESS (0.001s)
[736.687108] Subtest idempotent: SUCCESS (0.012s)
[736.756245] [105/131] (288s left) kms_getfb (getfb2-handle-zero)
[736.949961] Starting subtest: getfb2-handle-zero
[736.950852] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[737.129934] [106/131] (287s left) gem_exec_whisper (basic-queues-forked-all)
[737.219595] Starting subtest: basic-queues-forked-all
[759.215478] Subtest basic-queues-forked-all: SUCCESS (21.994s)
[759.487650] [107/131] (265s left) syncobj_timeline (single-wait-signaled)
[759.565276] Starting subtest: single-wait-signaled
[759.566177] Subtest single-wait-signaled: SUCCESS (0.000s)
[759.738855] [108/131] (265s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[759.927465] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[759.928378] Starting dynamic subtest: pipe-A-DP-3
[759.936992] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[759.947793] Starting dynamic subtest: pipe-B-DP-3
[759.956237] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[759.966886] Starting dynamic subtest: pipe-C-DP-3
[759.975121] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[759.985802] Starting dynamic subtest: pipe-D-DP-3
[759.996138] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[759.998519] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SKIP (0.009s)
[760.412773] [109/131] (264s left) kms_sequence (get-forked)
[760.605437] Starting subtest: get-forked
[760.606331] Starting dynamic subtest: pipe-A-DP-3
[763.019212] Dynamic subtest pipe-A-DP-3: SUCCESS (2.412s)
[763.037220] Starting dynamic subtest: pipe-B-DP-3
[765.417163] Dynamic subtest pipe-B-DP-3: SUCCESS (2.396s)
[765.429953] Starting dynamic subtest: pipe-C-DP-3
[767.787499] Dynamic subtest pipe-C-DP-3: SUCCESS (2.368s)
[767.803877] Starting dynamic subtest: pipe-D-DP-3
[770.171388] Dynamic subtest pipe-D-DP-3: SUCCESS (2.382s)
[770.172331] Subtest get-forked: SUCCESS (9.566s)
[770.491360] [110/131] (254s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[770.689388] Starting subtest: yf-tiled-32bpp-rotate-180
[770.691232] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[770.871629] [111/131] (254s left) perf_pmu (enable-race)
[770.940375] Starting subtest: enable-race
[770.941305] Starting dynamic subtest: rcs0
[783.710524] Dynamic subtest rcs0: SUCCESS (12.769s)
[783.723660] Starting dynamic subtest: bcs0
[796.451357] Dynamic subtest bcs0: SUCCESS (12.740s)
[796.464147] Starting dynamic subtest: vcs0
[809.190680] Dynamic subtest vcs0: SUCCESS (12.738s)
[809.202008] Starting dynamic subtest: vcs1
[821.929688] Dynamic subtest vcs1: SUCCESS (12.738s)
[821.941208] Starting dynamic subtest: vecs0
[834.670622] Dynamic subtest vecs0: SUCCESS (12.740s)
[834.681667] Starting dynamic subtest: vecs1
[847.410651] Dynamic subtest vecs1: SUCCESS (12.739s)
[847.422133] Starting dynamic subtest: ccs0
[860.148493] Dynamic subtest ccs0: SUCCESS (12.737s)
[860.149366] Subtest enable-race: SUCCESS (89.207s)
[860.301647] [112/131] (165s left) gem_eio (in-flight-internal-1us)
[860.587220] Starting subtest: in-flight-internal-1us
[861.887490] Subtest in-flight-internal-1us: SUCCESS (1.301s)
[862.174437] [113/131] (163s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[862.368330] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[862.370042] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[862.538584] [114/131] (163s left) kms_prop_blob (invalid-get-prop-any)
[862.613469] Starting subtest: invalid-get-prop-any
[862.614370] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[862.816850] [115/131] (162s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[863.018491] Starting subtest: extended-pageflip-modeset-hang-oldfb
[863.020932] Starting dynamic subtest: pipe-A
[870.839452] Dynamic subtest pipe-A: SUCCESS (7.819s)
[870.854171] Starting dynamic subtest: pipe-D
[878.667972] Dynamic subtest pipe-D: SUCCESS (7.824s)
[878.668882] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (15.650s)
[878.956508] [116/131] (146s left) kms_flip (modeset-vs-vblank-race)
[879.146197] Starting subtest: modeset-vs-vblank-race
[879.149476] Starting dynamic subtest: A-DP3
[882.448746] Dynamic subtest A-DP3: SUCCESS (3.298s)
[882.494514] Starting dynamic subtest: B-DP3
[885.716582] Dynamic subtest B-DP3: SUCCESS (3.262s)
[885.762599] Starting dynamic subtest: C-DP3
[888.950251] Dynamic subtest C-DP3: SUCCESS (3.228s)
[888.993089] Starting dynamic subtest: D-DP3
[892.083662] Dynamic subtest D-DP3: SUCCESS (3.128s)
[892.091867] Subtest modeset-vs-vblank-race: SUCCESS (12.946s)
[892.479628] [117/131] (133s left) core_auth (getclient-master-drop)
[892.529846] Starting subtest: getclient-master-drop
[892.579427] Subtest getclient-master-drop: SUCCESS (0.050s)
[892.716481] [118/131] (133s left) i915_pm_rpm (gem-evict-pwrite)
[895.050588] Starting subtest: gem-evict-pwrite
[895.054465] Subtest gem-evict-pwrite: SKIP (0.000s)
[895.513714] [119/131] (130s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-blt)
[895.708384] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-blt
[895.710122] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-blt: SKIP (0.000s)
[895.906393] [120/131] (130s left) kms_pm_rpm (legacy-planes)
[898.038532] Starting subtest: legacy-planes
[898.041476] Starting dynamic subtest: plane-43
[900.845563] Dynamic subtest plane-43: SUCCESS (2.805s)
[900.862401] Starting dynamic subtest: plane-53
[903.659112] Dynamic subtest plane-53: SUCCESS (2.809s)
[903.706914] Starting dynamic subtest: plane-63
[906.867921] Dynamic subtest plane-63: SUCCESS (3.204s)
[906.915377] Starting dynamic subtest: plane-73
[909.587365] Dynamic subtest plane-73: SUCCESS (2.715s)
[909.593513] Subtest legacy-planes: SUCCESS (11.552s)
[910.033151] [121/131] (116s left) gem_ctx_persistence (heartbeat-hostile)
[910.129890] Starting subtest: heartbeat-hostile
[910.131803] Subtest heartbeat-hostile: SKIP (0.000s)
[910.271914] [122/131] (116s left) gem_exec_reloc (basic-wc-read)
[910.359099] Subtest basic-wc-read: SKIP (0.000s)
[910.440980] [123/131] (115s left) kms_cursor_crc (cursor-sliding-64x64)
[910.774235] Starting subtest: cursor-sliding-64x64
[910.779287] Starting dynamic subtest: pipe-A-DP-3
[915.197492] Dynamic subtest pipe-A-DP-3: SUCCESS (4.416s)
[915.252384] Starting dynamic subtest: pipe-D-DP-3
[919.628522] Dynamic subtest pipe-D-DP-3: SUCCESS (4.387s)
[919.629462] Subtest cursor-sliding-64x64: SUCCESS (8.855s)
[920.147395] [124/131] (106s left) gem_exec_schedule (u-fairslice)
[920.241115] Starting subtest: u-fairslice
[920.242176] Starting dynamic subtest: rcs0
[922.294429] Dynamic subtest rcs0: SUCCESS (2.052s)
[922.307057] Starting dynamic subtest: bcs0
[924.316258] Dynamic subtest bcs0: SUCCESS (2.020s)
[924.328580] Starting dynamic subtest: vcs0
[926.336178] Dynamic subtest vcs0: SUCCESS (2.019s)
[926.348501] Starting dynamic subtest: vcs1
[928.358280] Dynamic subtest vcs1: SUCCESS (2.021s)
[928.370927] Starting dynamic subtest: vecs0
[930.378883] Dynamic subtest vecs0: SUCCESS (2.020s)
[930.391384] Starting dynamic subtest: vecs1
[932.401236] Dynamic subtest vecs1: SUCCESS (2.021s)
[932.413228] Starting dynamic subtest: ccs0
[934.425019] Dynamic subtest ccs0: SUCCESS (2.021s)
[934.425970] Subtest u-fairslice: SUCCESS (14.181s)
[934.807390] [125/131] ( 91s left) gem_exec_balancer (parallel-keep-submit-fence)
[935.148841] Starting subtest: parallel-keep-submit-fence
[937.319398] Subtest parallel-keep-submit-fence: SUCCESS (2.171s)
[937.463545] [126/131] ( 89s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[937.659434] Starting subtest: psr-dirtyfb-ioctl
[937.664527] Subtest psr-dirtyfb-ioctl: SKIP (0.000s)
[937.856467] [127/131] ( 88s left) syncobj_timeline (invalid-wait-bad-flags)
[937.934172] Starting subtest: invalid-wait-bad-flags
[937.935056] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[938.139380] [128/131] ( 88s left) gem_exec_fence (submit3)
[938.345778] Starting subtest: submit3
[938.347907] Subtest submit3: SKIP (0.000s)
[939.192634] [129/131] ( 87s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[939.276573] Starting subtest: x-tiled-to-vebox-y-tiled
[939.278370] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[939.506496] [130/131] ( 87s left) gem_fence_thrash (bo-write-verify-y)
[939.554056] Starting subtest: bo-write-verify-y
[939.584432] Subtest bo-write-verify-y: SKIP (0.030s)
[939.698780] [131/131] ( 87s left) dumb_buffer (map-valid)
[939.781397] Starting subtest: map-valid
[939.782231] Subtest map-valid: SUCCESS (0.000s)
[939.970114] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: gem_pxp
results: parsing output: 3/ for test: gem_userptr_blits
results: parsing output: 4/ for test: gem_busy
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_flip_scaled_crc
results: parsing output: 7/ for test: kms_cursor_legacy
results: parsing output: 8/ for test: kms_cursor_legacy
results: parsing output: 9/ for test: gem_softpin
results: parsing output: 10/ for test: kms_ccs
results: parsing output: 11/ for test: kms_pipe_crc_basic
results: parsing output: 12/ for test: kms_cursor_legacy
results: parsing output: 13/ for test: gem_create
results: parsing output: 14/ for test: gem_mmap_gtt
results: parsing output: 15/ for test: syncobj_timeline
results: parsing output: 16/ for test: i915_fb_tiling
results: parsing output: 17/ for test: kms_plane_multiple
results: parsing output: 18/ for test: prime_self_import
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: kms_flip
results: parsing output: 22/ for test: kms_lease
results: parsing output: 23/ for test: kms_feature_discovery
results: parsing output: 24/ for test: i915_pm_rps
results: parsing output: 25/ for test: gem_exec_balancer
results: parsing output: 26/ for test: gem_exec_parallel
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_psr2_sf
results: parsing output: 29/ for test: kms_flip
results: parsing output: 30/ for test: kms_chamelium_frames
results: parsing output: 31/ for test: gen9_exec_parse
results: parsing output: 32/ for test: gem_flink_basic
results: parsing output: 33/ for test: gem_userptr_blits
results: parsing output: 34/ for test: kms_tv_load_detect
results: parsing output: 35/ for test: gem_exec_params
results: parsing output: 36/ for test: kms_flip
results: parsing output: 37/ for test: gem_exec_schedule
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: gem_exec_reloc
results: parsing output: 40/ for test: kms_flip
results: parsing output: 41/ for test: gem_sync
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: gem_pread
results: parsing output: 45/ for test: i915_selftest
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_cursor_edge_walk
results: parsing output: 51/ for test: kms_chamelium_frames
results: parsing output: 52/ for test: kms_properties
results: parsing output: 53/ for test: kms_joiner
results: parsing output: 54/ for test: gem_ctx_param
results: parsing output: 55/ for test: gem_workarounds
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_async_flips
results: parsing output: 58/ for test: kms_cursor_legacy
results: parsing output: 59/ for test: perf_pmu
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_psr2_sf
results: parsing output: 62/ for test: kms_content_protection
results: parsing output: 63/ for test: kms_flip_scaled_crc
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: perf_pmu
results: parsing output: 66/ for test: kms_cursor_legacy
results: parsing output: 67/ for test: gem_ctx_persistence
results: parsing output: 68/ for test: gem_render_copy
results: parsing output: 69/ for test: kms_ccs
results: parsing output: 70/ for test: gem_exec_reloc
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_vrr
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: syncobj_wait
results: parsing output: 75/ for test: kms_ccs
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: gen7_exec_parse
results: parsing output: 78/ for test: kms_cursor_legacy
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_chamelium_hpd
results: parsing output: 82/ for test: gem_exec_flush
results: parsing output: 83/ for test: gem_pread
results: parsing output: 84/ for test: kms_cursor_crc
results: parsing output: 85/ for test: gem_ctx_create
results: parsing output: 86/ for test: kms_vblank
results: parsing output: 87/ for test: gem_basic
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: sriov_basic
results: parsing output: 90/ for test: gem_linear_blits
results: parsing output: 91/ for test: kms_plane_scaling
results: parsing output: 92/ for test: syncobj_timeline
results: parsing output: 93/ for test: kms_cursor_legacy
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: gem_lmem_swapping
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_plane_scaling
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_ctx_exec
results: parsing output: 101/ for test: api_intel_bb
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: sysfs_preempt_timeout
results: parsing output: 104/ for test: kms_getfb
results: parsing output: 105/ for test: gem_exec_whisper
results: parsing output: 106/ for test: syncobj_timeline
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: kms_sequence
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: perf_pmu
results: parsing output: 111/ for test: gem_eio
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_prop_blob
results: parsing output: 114/ for test: kms_busy
results: parsing output: 115/ for test: kms_flip
results: parsing output: 116/ for test: core_auth
results: parsing output: 117/ for test: i915_pm_rpm
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_pm_rpm
results: parsing output: 120/ for test: gem_ctx_persistence
results: parsing output: 121/ for test: gem_exec_reloc
results: parsing output: 122/ for test: kms_cursor_crc
results: parsing output: 123/ for test: gem_exec_schedule
results: parsing output: 124/ for test: gem_exec_balancer
results: parsing output: 125/ for test: kms_dirtyfb
results: parsing output: 126/ for test: syncobj_timeline
results: parsing output: 127/ for test: gem_exec_fence
results: parsing output: 128/ for test: gem_render_copy
results: parsing output: 129/ for test: gem_fence_thrash
results: parsing output: 130/ for test: dumb_buffer
Done.