[56.418083] Initializing watchdogs
[56.418150]   /dev/watchdog0
[56.437419] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[56.448067] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[56.451424] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.453597] [001/131] (960s left) kms_psr (fbc-psr-cursor-plane-onoff)
[56.654141] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s)
[56.709610] [002/131] (960s left) gem_readwrite (write-bad-handle)
[56.785066] Subtest write-bad-handle: SKIP (0.000s)
[56.881226] [003/131] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[57.076731] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[57.078381] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[57.211033] [004/131] (959s left) kms_cdclk (mode-transition)
[57.401101] Starting subtest: mode-transition
[57.402053] Starting dynamic subtest: pipe-A-DP-3
[57.483661] Dynamic subtest pipe-A-DP-3: SKIP (0.081s)
[57.493509] Starting dynamic subtest: pipe-B-DP-3
[57.495424] Dynamic subtest pipe-B-DP-3: SKIP (0.003s)
[57.504679] Starting dynamic subtest: pipe-C-DP-3
[57.506458] Dynamic subtest pipe-C-DP-3: SKIP (0.003s)
[57.513987] Starting dynamic subtest: pipe-D-DP-3
[57.515618] Dynamic subtest pipe-D-DP-3: SKIP (0.003s)
[57.517243] Subtest mode-transition: SKIP (0.093s)
[57.701447] [005/131] (959s left) gem_exec_reloc (basic-wc-cpu)
[57.785559] Subtest basic-wc-cpu: SKIP (0.000s)
[57.869588] [006/131] (959s left) kms_psr (psr-sprite-plane-move)
[58.058530] Subtest psr-sprite-plane-move: SKIP (0.000s)
[58.117196] [007/131] (959s left) api_intel_allocator (fork-simple-stress-signal)
[58.187009] Starting subtest: fork-simple-stress-signal
[63.594734] Subtest fork-simple-stress-signal: SUCCESS (5.418s)
[63.760031] [008/131] (953s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[63.849304] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[63.956532] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.105s)
[64.090327] [009/131] (953s left) kms_joiner (invalid-modeset-big-joiner)
[64.282582] Starting subtest: invalid-modeset-big-joiner
[64.284281] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[64.363520] [010/131] (953s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[64.432066] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[64.433039] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[64.589846] [011/131] (952s left) syncobj_wait (wait-all-for-submit-snapshot)
[64.658243] Starting subtest: wait-all-for-submit-snapshot
[64.741373] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[64.832602] [012/131] (952s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[65.031734] Starting subtest: y-tiled-8bpp-rotate-270
[65.033463] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[65.174123] [013/131] (952s left) gem_ctx_isolation (nonpriv-switch)
[65.251494] Starting subtest: nonpriv-switch
[65.252413] Starting dynamic subtest: rcs0
[66.144531] Dynamic subtest rcs0: SUCCESS (0.894s)
[66.153271] Starting dynamic subtest: bcs0
[67.211955] Dynamic subtest bcs0: SUCCESS (1.067s)
[67.220408] Starting dynamic subtest: vcs0
[68.609340] Dynamic subtest vcs0: SUCCESS (1.399s)
[68.617801] Starting dynamic subtest: vcs1
[69.521084] Dynamic subtest vcs1: SUCCESS (0.912s)
[69.529166] Starting dynamic subtest: vecs0
[70.440619] Dynamic subtest vecs0: SUCCESS (0.920s)
[70.448605] Starting dynamic subtest: vecs1
[71.356077] Dynamic subtest vecs1: SUCCESS (0.916s)
[71.363998] Starting dynamic subtest: ccs0
[72.278552] Dynamic subtest ccs0: SUCCESS (0.923s)
[72.279435] Subtest nonpriv-switch: SUCCESS (7.032s)
[72.558829] [014/131] (945s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[72.742172] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[72.743153] Starting dynamic subtest: pipe-A-DP-3
[72.751699] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[72.759534] Starting dynamic subtest: pipe-B-DP-3
[72.768186] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[72.775946] Starting dynamic subtest: pipe-C-DP-3
[72.784136] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[72.791633] Starting dynamic subtest: pipe-D-DP-3
[72.802142] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[72.804551] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[73.177221] [015/131] (944s left) kms_psr (fbc-pr-cursor-plane-move)
[73.369420] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[73.428630] [016/131] (944s left) kms_flip (bo-too-big)
[73.618102] Starting subtest: bo-too-big
[73.621862] Starting dynamic subtest: A-DP3
[73.991386] Dynamic subtest A-DP3: SUCCESS (0.369s)
[74.022381] Starting dynamic subtest: B-DP3
[74.258482] Dynamic subtest B-DP3: SUCCESS (0.266s)
[74.278489] Starting dynamic subtest: C-DP3
[74.497190] Dynamic subtest C-DP3: SUCCESS (0.238s)
[74.505450] Starting dynamic subtest: D-DP3
[74.731280] Dynamic subtest D-DP3: SUCCESS (0.233s)
[74.734526] Subtest bo-too-big: SUCCESS (1.117s)
[75.123056] [017/131] (942s left) gem_exec_balancer (bonded-pair)
[75.204766] Starting subtest: bonded-pair
[75.207068] Subtest bonded-pair: SKIP (0.000s)
[75.625833] [018/131] (942s left) gem_mmap_offset (open-flood)
[75.698134] Starting subtest: open-flood
[97.198210] Subtest open-flood: SUCCESS (21.484s)
[97.323041] [019/131] (920s left) gem_exec_schedule (semaphore-power)
[97.546639] Subtest semaphore-power: SKIP (0.000s)
[97.786330] [020/131] (920s left) kms_cursor_crc (cursor-random-max-size)
[98.294617] Starting subtest: cursor-random-max-size
[98.297229] Subtest cursor-random-max-size: SKIP (0.000s)
[98.462984] [021/131] (919s left) gem_sync (basic-each)
[98.544052] Starting subtest: basic-each
[100.666618] Subtest basic-each: SUCCESS (2.122s)
[100.919860] [022/131] (917s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[101.116220] Starting subtest: 4-tiled-16bpp-rotate-90
[101.181030] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.065s)
[101.374902] [023/131] (916s left) gem_exec_fence (invalid-timeline-fence-array)
[102.062794] Starting subtest: invalid-timeline-fence-array
[102.068239] Subtest invalid-timeline-fence-array: SUCCESS (0.005s)
[102.354186] [FACT gem_exec_fence (invalid-timeline-fence-array)] new: kernel.kmod_is_loaded.vgem: true
[102.356017] [024/131] (916s left) gem_userptr_blits (sd-probe)
[102.442203] Starting subtest: sd-probe
[102.444012] Subtest sd-probe: SKIP (0.000s)
[102.630244] [025/131] (915s left) kms_prop_blob (blob-prop-validate)
[102.708058] Starting subtest: blob-prop-validate
[102.709169] Subtest blob-prop-validate: SUCCESS (0.000s)
[102.870988] [026/131] (915s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[103.079048] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[103.080823] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[103.227309] [027/131] (915s left) kms_legacy_colorkey (invalid-plane)
[103.423221] Starting subtest: invalid-plane
[103.424157] Starting dynamic subtest: zero-id
[103.425037] Dynamic subtest zero-id: SUCCESS (0.000s)
[103.433597] Starting dynamic subtest: outrange-id
[103.434785] Dynamic subtest outrange-id: SUCCESS (0.000s)
[103.435650] Subtest invalid-plane: SUCCESS (0.000s)
[103.518999] [028/131] (915s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[103.724067] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[103.725782] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[103.846670] [029/131] (914s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[104.126094] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[104.277919] [030/131] (914s left) gem_exec_reloc (basic-softpin)
[104.363560] Subtest basic-softpin: SKIP (0.000s)
[104.456895] [031/131] (914s left) syncobj_timeline (etime-single-wait-all-submitted)
[104.538237] Starting subtest: etime-single-wait-all-submitted
[104.643332] Subtest etime-single-wait-all-submitted: SUCCESS (0.104s)
[104.766167] [032/131] (914s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[104.964372] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[104.965307] Starting dynamic subtest: pipe-A-valid-mode
[105.051397] Dynamic subtest pipe-A-valid-mode: SKIP (0.084s)
[105.053158] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.085s)
[105.262756] [033/131] (913s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[105.457254] Starting subtest: plane-downscale-factor-0-75-with-rotation
[105.458085] Starting dynamic subtest: pipe-A
[105.840040] Dynamic subtest pipe-A: SUCCESS (0.382s)
[105.851113] Starting dynamic subtest: pipe-B
[106.305814] Dynamic subtest pipe-B: SUCCESS (0.465s)
[106.317363] Starting dynamic subtest: pipe-C
[106.771947] Dynamic subtest pipe-C: SUCCESS (0.465s)
[106.782768] Starting dynamic subtest: pipe-D
[107.237257] Dynamic subtest pipe-D: SUCCESS (0.464s)
[107.238345] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (1.780s)
[107.563782] [034/131] (911s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[107.769514] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[107.784495] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.014s)
[107.899765] [035/131] (911s left) i915_drm_fdinfo (busy-idle)
[107.969275] Starting subtest: busy-idle
[107.970214] Starting dynamic subtest: rcs0
[108.000448] Dynamic subtest rcs0: SKIP (0.030s)
[108.010435] Starting dynamic subtest: bcs0
[108.012345] Dynamic subtest bcs0: SKIP (0.000s)
[108.022326] Starting dynamic subtest: vcs0
[108.024708] Dynamic subtest vcs0: SKIP (0.000s)
[108.034430] Starting dynamic subtest: vcs1
[108.036802] Dynamic subtest vcs1: SKIP (0.000s)
[108.046723] Starting dynamic subtest: vecs0
[108.048942] Dynamic subtest vecs0: SKIP (0.000s)
[108.060633] Starting dynamic subtest: vecs1
[108.062949] Dynamic subtest vecs1: SKIP (0.000s)
[108.071195] Starting dynamic subtest: ccs0
[108.073427] Dynamic subtest ccs0: SKIP (0.000s)
[108.075367] Subtest busy-idle: SKIP (0.036s)
[108.117674] [036/131] (911s left) kms_flip (2x-modeset-vs-vblank-race)
[108.312070] Starting subtest: 2x-modeset-vs-vblank-race
[108.326891] Subtest 2x-modeset-vs-vblank-race: SKIP (0.014s)
[108.441651] [037/131] (910s left) api_intel_allocator (reserve-simple)
[108.518175] Starting subtest: reserve-simple
[108.545122] Subtest reserve-simple: SUCCESS (0.027s)
[108.691568] [038/131] (910s left) gem_mmap_gtt (cpuset-big-copy-xy)
[108.780055] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[108.843165] [039/131] (910s left) syncobj_wait (wait-all-snapshot)
[108.921262] Starting subtest: wait-all-snapshot
[109.004139] Subtest wait-all-snapshot: SUCCESS (0.082s)
[109.118768] [040/131] (910s left) fbdev (write)
[109.168801] Starting subtest: write
[110.642465] Subtest write: SUCCESS (1.473s)
[110.716012] [041/131] (908s left) syncobj_timeline (multi-wait-for-submit-signaled)
[110.793168] Starting subtest: multi-wait-for-submit-signaled
[110.794159] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[110.945546] [042/131] (908s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[111.140676] Starting subtest: basic-flip-after-cursor-varying-size
[112.195599] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.054s)
[112.479357] [043/131] (907s left) kms_dp_link_training (uhbr-sst)
[112.673417] Starting subtest: uhbr-sst
[112.675276] Subtest uhbr-sst: SKIP (0.000s)
[112.787145] [044/131] (906s left) kms_psr (fbc-psr-sprite-render)
[112.983235] Subtest fbc-psr-sprite-render: SKIP (0.000s)
[113.033490] [045/131] (906s left) gem_barrier_race (remote-request)
[113.118112] Starting subtest: remote-request
[113.119512] Starting dynamic subtest: rcs0
[118.411199] Dynamic subtest rcs0: SUCCESS (5.291s)
[118.412309] Subtest remote-request: SUCCESS (5.291s)
[118.639167] [046/131] (901s left) sysfs_defaults (readonly)
[118.726057] Starting subtest: readonly
[118.727043] Starting dynamic subtest: vecs0
[118.727976] Dynamic subtest vecs0: SUCCESS (0.000s)
[118.736957] Starting dynamic subtest: ccs0
[118.738161] Dynamic subtest ccs0: SUCCESS (0.000s)
[118.746809] Starting dynamic subtest: vcs0
[118.748058] Dynamic subtest vcs0: SUCCESS (0.000s)
[118.756647] Starting dynamic subtest: bcs0
[118.757854] Dynamic subtest bcs0: SUCCESS (0.000s)
[118.766665] Starting dynamic subtest: vecs1
[118.767857] Dynamic subtest vecs1: SUCCESS (0.000s)
[118.776440] Starting dynamic subtest: rcs0
[118.777385] Dynamic subtest rcs0: SUCCESS (0.000s)
[118.786183] Starting dynamic subtest: vcs1
[118.787420] Dynamic subtest vcs1: SUCCESS (0.000s)
[118.788653] Subtest readonly: SUCCESS (0.009s)
[118.841205] [047/131] (901s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[119.050322] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[120.312772] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.261s)
[120.521997] [048/131] (899s left) kms_cursor_crc (cursor-random-128x128)
[120.902921] Starting subtest: cursor-random-128x128
[120.907432] Starting dynamic subtest: pipe-A-DP-3
[125.359385] Dynamic subtest pipe-A-DP-3: SUCCESS (4.449s)
[125.405846] Starting dynamic subtest: pipe-D-DP-3
[129.955443] Dynamic subtest pipe-D-DP-3: SUCCESS (4.557s)
[129.956404] Subtest cursor-random-128x128: SUCCESS (9.051s)
[130.407731] [049/131] (889s left) perf (polling)
[130.624833] Starting subtest: polling
[130.625817] Starting dynamic subtest: 0-rcs0
[140.653424] Dynamic subtest 0-rcs0: SUCCESS (10.027s)
[140.654494] Subtest polling: SUCCESS (10.027s)
[140.705675] [050/131] (879s left) gem_exercise_blt (fast-copy)
[140.793656] Starting subtest: fast-copy
[140.794628] Starting dynamic subtest: linear-smem-smem
[140.847196] Dynamic subtest linear-smem-smem: SUCCESS (0.053s)
[140.856383] Starting dynamic subtest: linear-smem-lmem0
[140.864669] Dynamic subtest linear-smem-lmem0: SUCCESS (0.017s)
[140.873813] Starting dynamic subtest: linear-lmem0-smem
[140.968524] Dynamic subtest linear-lmem0-smem: SUCCESS (0.103s)
[140.977245] Starting dynamic subtest: linear-lmem0-lmem0
[141.069576] Dynamic subtest linear-lmem0-lmem0: SUCCESS (0.100s)
[141.078427] Starting dynamic subtest: xmajor-smem-smem
[141.086395] Dynamic subtest xmajor-smem-smem: SUCCESS (0.016s)
[141.095609] Starting dynamic subtest: xmajor-smem-lmem0
[141.103289] Dynamic subtest xmajor-smem-lmem0: SUCCESS (0.016s)
[141.112378] Starting dynamic subtest: xmajor-lmem0-smem
[141.212885] Dynamic subtest xmajor-lmem0-smem: SUCCESS (0.109s)
[141.221760] Starting dynamic subtest: xmajor-lmem0-lmem0
[141.313285] Dynamic subtest xmajor-lmem0-lmem0: SUCCESS (0.100s)
[141.322209] Starting dynamic subtest: tile4-smem-smem
[141.330178] Dynamic subtest tile4-smem-smem: SUCCESS (0.016s)
[141.339160] Starting dynamic subtest: tile4-smem-lmem0
[141.346664] Dynamic subtest tile4-smem-lmem0: SUCCESS (0.016s)
[141.355605] Starting dynamic subtest: tile4-lmem0-smem
[141.453480] Dynamic subtest tile4-lmem0-smem: SUCCESS (0.106s)
[141.462451] Starting dynamic subtest: tile4-lmem0-lmem0
[141.558869] Dynamic subtest tile4-lmem0-lmem0: SUCCESS (0.104s)
[141.567968] Starting dynamic subtest: tile64-smem-smem
[141.575872] Dynamic subtest tile64-smem-smem: SUCCESS (0.016s)
[141.584964] Starting dynamic subtest: tile64-smem-lmem0
[141.592270] Dynamic subtest tile64-smem-lmem0: SUCCESS (0.016s)
[141.601360] Starting dynamic subtest: tile64-lmem0-smem
[141.694337] Dynamic subtest tile64-lmem0-smem: SUCCESS (0.101s)
[141.703417] Starting dynamic subtest: tile64-lmem0-lmem0
[141.806009] Dynamic subtest tile64-lmem0-lmem0: SUCCESS (0.111s)
[141.806962] Subtest fast-copy: SUCCESS (1.013s)
[141.954739] [051/131] (878s left) kms_async_flips (async-flip-suspend-resume)
[142.150614] Starting subtest: async-flip-suspend-resume
[142.377213] Starting dynamic subtest: pipe-A-DP-3
[162.478647] Dynamic subtest pipe-A-DP-3: SUCCESS (4.967s)
[162.674634] Starting dynamic subtest: pipe-B-DP-3
[164.767846] Dynamic subtest pipe-B-DP-3: SUCCESS (2.102s)
[164.978819] Starting dynamic subtest: pipe-C-DP-3
[167.061993] Dynamic subtest pipe-C-DP-3: SUCCESS (2.094s)
[167.245616] Starting dynamic subtest: pipe-D-DP-3
[169.330650] Dynamic subtest pipe-D-DP-3: SUCCESS (2.098s)
[169.331942] Subtest async-flip-suspend-resume: SUCCESS (12.047s)
[169.812665] [052/131] (850s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[170.024996] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[170.083254] [053/131] (850s left) kms_pm_rpm (fences-dpms)
[172.120281] Starting subtest: fences-dpms
[172.122927] Subtest fences-dpms: SKIP (0.000s)
[172.532773] [054/131] (847s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[172.735212] Starting subtest: fbcpsr-modesetfrombusy
[172.737040] Subtest fbcpsr-modesetfrombusy: SKIP (0.000s)
[172.876641] [055/131] (847s left) gem_pwrite (basic-self)
[172.954351] Subtest basic-self: SKIP (0.000s)
[173.029972] [056/131] (847s left) kms_getfb (getfb-addfb-different-handles)
[173.221735] Starting subtest: getfb-addfb-different-handles
[173.222640] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[173.403738] [057/131] (847s left) kms_cursor_legacy (torture-bo)
[173.601871] Starting subtest: torture-bo
[173.602820] Starting dynamic subtest: pipe-A
[179.195672] Dynamic subtest pipe-A: SUCCESS (5.592s)
[179.207218] Starting dynamic subtest: pipe-B
[184.622560] Dynamic subtest pipe-B: SUCCESS (5.425s)
[184.633664] Starting dynamic subtest: pipe-C
[190.049485] Dynamic subtest pipe-C: SUCCESS (5.425s)
[190.060666] Starting dynamic subtest: pipe-D
[195.475609] Dynamic subtest pipe-D: SUCCESS (5.425s)
[195.488253] Starting dynamic subtest: all-pipes
[200.922556] Dynamic subtest all-pipes: SUCCESS (5.446s)
[200.923537] Subtest torture-bo: SUCCESS (27.318s)
[201.024409] [058/131] (819s left) kms_setmode (invalid-clone-single-crtc)
[201.122546] Starting subtest: invalid-clone-single-crtc
[201.125416] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[201.277501] [059/131] (819s left) i915_pm_rpm (gem-execbuf)
[203.213928] Starting subtest: gem-execbuf
[203.214877] Starting dynamic subtest: lmem0
[204.810173] Dynamic subtest lmem0: SUCCESS (1.592s)
[204.839873] Starting dynamic subtest: smem0
[207.186807] Dynamic subtest smem0: SUCCESS (2.374s)
[207.188948] Subtest gem-execbuf: SUCCESS (3.975s)
[207.595078] [060/131] (813s left) gem_lmem_swapping (massive)
[210.467533] Starting subtest: massive
[210.468407] Starting dynamic subtest: lmem0
[218.053181] Dynamic subtest lmem0: SUCCESS (7.585s)
[218.054165] Subtest massive: SUCCESS (7.586s)
[219.675305] [FACT gem_lmem_swapping (massive)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[219.676332] [FACT gem_lmem_swapping (massive)] deleted: kernel.kmod_is_loaded.i915: true
[219.678306] [061/131] (801s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[221.341414] Starting subtest: psr-rgb101010-draw-mmap-cpu
[221.343272] Subtest psr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[221.483661] [FACT kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[221.486003] [FACT kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)] new: kernel.kmod_is_loaded.i915: true
[221.488761] [062/131] (799s left) kms_lease (invalid-create-leases)
[221.691613] Starting subtest: invalid-create-leases
[221.701227] Subtest invalid-create-leases: SUCCESS (0.009s)
[221.851476] [063/131] (799s left) gen3_mixed_blits
[221.995022] [064/131] (799s left) syncobj_timeline (wait-all-delayed-signal)
[222.076562] Starting subtest: wait-all-delayed-signal
[222.177553] Subtest wait-all-delayed-signal: SUCCESS (0.101s)
[222.265602] [065/131] (798s left) kms_getfb (getfb2-accept-nv12)
[222.463043] Starting subtest: getfb2-accept-nv12
[222.465537] Subtest getfb2-accept-nv12: SUCCESS (0.002s)
[222.648222] [066/131] (798s left) prime_busy (before-wait)
[222.736298] Starting subtest: before-wait
[222.741472] Starting dynamic subtest: rcs0
[222.796382] Dynamic subtest rcs0: SUCCESS (0.055s)
[222.808989] Starting dynamic subtest: bcs0
[222.846470] Dynamic subtest bcs0: SUCCESS (0.049s)
[222.862002] Starting dynamic subtest: vcs0
[222.889499] Dynamic subtest vcs0: SUCCESS (0.042s)
[222.916895] Starting dynamic subtest: vcs1
[222.933253] Dynamic subtest vcs1: SUCCESS (0.042s)
[222.958680] Starting dynamic subtest: vecs0
[222.973083] Dynamic subtest vecs0: SUCCESS (0.037s)
[222.989820] Starting dynamic subtest: vecs1
[223.013301] Dynamic subtest vecs1: SUCCESS (0.039s)
[223.027019] Starting dynamic subtest: ccs0
[223.055826] Dynamic subtest ccs0: SUCCESS (0.041s)
[223.169218] Subtest before-wait: SUCCESS (0.427s)
[223.301044] [067/131] (797s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-gtt)
[223.508211] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-gtt
[223.509843] Subtest psr-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[223.637107] [068/131] (797s left) kms_chamelium_color (ctm-negative)
[223.831181] Subtest ctm-negative: SKIP (0.000s)
[223.895217] [069/131] (797s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[224.096212] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[224.097985] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[224.251421] [070/131] (797s left) gem_wait (busy)
[224.341937] Starting subtest: busy
[224.342772] Starting dynamic subtest: all-engines
[224.958566] Dynamic subtest all-engines: SUCCESS (0.616s)
[224.970684] Starting dynamic subtest: rcs0
[225.498522] Dynamic subtest rcs0: SUCCESS (0.539s)
[225.509294] Starting dynamic subtest: bcs0
[226.038470] Dynamic subtest bcs0: SUCCESS (0.539s)
[226.049215] Starting dynamic subtest: vcs0
[226.578572] Dynamic subtest vcs0: SUCCESS (0.539s)
[226.590693] Starting dynamic subtest: vcs1
[227.117389] Dynamic subtest vcs1: SUCCESS (0.538s)
[227.127891] Starting dynamic subtest: vecs0
[227.656458] Dynamic subtest vecs0: SUCCESS (0.538s)
[227.666973] Starting dynamic subtest: vecs1
[228.195461] Dynamic subtest vecs1: SUCCESS (0.538s)
[228.206255] Starting dynamic subtest: ccs0
[228.734495] Dynamic subtest ccs0: SUCCESS (0.538s)
[228.735462] Subtest busy: SUCCESS (4.393s)
[229.001865] [071/131] (792s left) gem_exec_schedule (thriceslice)
[229.090690] Starting subtest: thriceslice
[229.091596] Starting dynamic subtest: rcs0
[229.143584] Dynamic subtest rcs0: SUCCESS (0.052s)
[229.159242] Starting dynamic subtest: bcs0
[229.177973] Dynamic subtest bcs0: SUCCESS (0.033s)
[229.194969] Starting dynamic subtest: vcs0
[229.213402] Dynamic subtest vcs0: SUCCESS (0.034s)
[229.232442] Starting dynamic subtest: vcs1
[229.250297] Dynamic subtest vcs1: SUCCESS (0.035s)
[229.269670] Starting dynamic subtest: vecs0
[229.289718] Dynamic subtest vecs0: SUCCESS (0.038s)
[229.308655] Starting dynamic subtest: vecs1
[229.326475] Dynamic subtest vecs1: SUCCESS (0.035s)
[229.345484] Starting dynamic subtest: ccs0
[229.385519] Dynamic subtest ccs0: SUCCESS (0.057s)
[229.387028] Subtest thriceslice: SUCCESS (0.296s)
[229.735329] [072/131] (791s left) perf (short-reads)
[230.098226] Starting subtest: short-reads
[230.120241] Subtest short-reads: SUCCESS (0.024s)
[230.183049] [073/131] (791s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[230.382281] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[230.384070] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[230.515076] [074/131] (791s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[230.716194] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[230.717874] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[230.832190] [075/131] (790s left) gem_softpin (evict-active)
[230.918893] Starting subtest: evict-active
[230.936240] Subtest evict-active: SUCCESS (0.017s)
[231.121850] [076/131] (790s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[231.324715] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[231.380510] [077/131] (790s left) gem_sync (basic-store-each)
[231.472474] Starting subtest: basic-store-each
[234.481595] Subtest basic-store-each: SUCCESS (3.010s)
[234.754351] [078/131] (787s left) gem_userptr_blits (stress-mm-invalidate-close)
[234.845250] Starting subtest: stress-mm-invalidate-close
[236.996047] Subtest stress-mm-invalidate-close: SUCCESS (2.149s)
[237.156829] [079/131] (784s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[237.349632] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[237.352229] Starting dynamic subtest: pipe-A-DP-3
[237.360706] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[237.371975] Starting dynamic subtest: pipe-B-DP-3
[237.380501] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[237.392548] Starting dynamic subtest: pipe-C-DP-3
[237.401034] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[237.411686] Starting dynamic subtest: pipe-D-DP-3
[237.422499] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[237.424631] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SKIP (0.009s)
[237.818479] [080/131] (784s left) gem_ctx_shared (q-smoketest)
[237.920003] Starting subtest: Q-smoketest
[237.920965] Starting dynamic subtest: rcs0
[243.369468] Dynamic subtest rcs0: SUCCESS (5.443s)
[243.380614] Starting dynamic subtest: bcs0
[248.791146] Dynamic subtest bcs0: SUCCESS (5.419s)
[248.802372] Starting dynamic subtest: vcs0
[254.208432] Dynamic subtest vcs0: SUCCESS (5.416s)
[254.219572] Starting dynamic subtest: vcs1
[259.629216] Dynamic subtest vcs1: SUCCESS (5.421s)
[259.640858] Starting dynamic subtest: vecs0
[265.039459] Dynamic subtest vecs0: SUCCESS (5.410s)
[265.050720] Starting dynamic subtest: vecs1
[270.456295] Dynamic subtest vecs1: SUCCESS (5.416s)
[270.468176] Starting dynamic subtest: ccs0
[275.884381] Dynamic subtest ccs0: SUCCESS (5.427s)
[275.885601] Subtest Q-smoketest: SUCCESS (37.958s)
[276.165777] [081/131] (746s left) kms_pm_dc (dc5-dpms-negative)
[277.367542] Starting subtest: dc5-dpms-negative
[281.594874] Subtest dc5-dpms-negative: SUCCESS (4.227s)
[281.698297] [082/131] (740s left) vgem_basic (mmap)
[281.758120] Starting subtest: mmap
[281.778029] Subtest mmap: SUCCESS (0.020s)
[281.859561] [083/131] (740s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[282.084866] Starting subtest: extended-modeset-hang-newfb-with-reset
[282.085710] Starting dynamic subtest: pipe-A
[303.335386] Dynamic subtest pipe-A: SUCCESS (21.249s)
[303.359366] Starting dynamic subtest: pipe-D
[324.294797] Dynamic subtest pipe-D: SUCCESS (20.950s)
[324.297734] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (42.211s)
[324.570649] [084/131] (697s left) kms_plane_multiple (2x-tiling-none)
[324.767642] Starting subtest: 2x-tiling-none
[324.769499] Subtest 2x-tiling-none: SKIP (0.000s)
[324.859293] [085/131] (697s left) kms_frontbuffer_tracking (psr-1p-rte)
[325.060304] Starting subtest: psr-1p-rte
[325.062006] Subtest psr-1p-rte: SKIP (0.000s)
[325.229960] [086/131] (697s left) gem_exec_balancer (semaphore)
[325.320249] Starting subtest: semaphore
[326.886374] Subtest semaphore: SUCCESS (1.566s)
[327.304540] [087/131] (695s left) kms_sequence (get-idle)
[327.501588] Starting subtest: get-idle
[327.503938] Starting dynamic subtest: pipe-A-DP-3
[329.880821] Dynamic subtest pipe-A-DP-3: SUCCESS (2.377s)
[329.895600] Starting dynamic subtest: pipe-B-DP-3
[332.199100] Dynamic subtest pipe-B-DP-3: SUCCESS (2.316s)
[332.216903] Starting dynamic subtest: pipe-C-DP-3
[334.510146] Dynamic subtest pipe-C-DP-3: SUCCESS (2.308s)
[334.523948] Starting dynamic subtest: pipe-D-DP-3
[336.805257] Dynamic subtest pipe-D-DP-3: SUCCESS (2.293s)
[336.806249] Subtest get-idle: SUCCESS (9.303s)
[337.077918] [088/131] (685s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[337.271892] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[337.275244] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.002s)
[337.395431] [089/131] (685s left) gem_exec_suspend (basic-s4-devices)
[337.483381] Starting subtest: basic-S4-devices
[337.484329] Starting dynamic subtest: smem
[348.177247] Dynamic subtest smem: SUCCESS (10.692s)
[348.190499] Starting dynamic subtest: lmem0
[358.896993] Dynamic subtest lmem0: SUCCESS (10.718s)
[358.898162] Subtest basic-S4-devices: SUCCESS (21.413s)
[365.162461] [090/131] (663s left) syncobj_basic (bad-pad-fd-to-handle)
[365.249443] Starting subtest: bad-pad-fd-to-handle
[365.250359] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[365.396185] [091/131] (663s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[365.597204] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[368.212975] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (2.615s)
[368.395758] [092/131] (660s left) gem_ctx_persistence (heartbeat-hostile)
[368.481983] Starting subtest: heartbeat-hostile
[368.484080] Subtest heartbeat-hostile: SKIP (0.000s)
[368.608155] [093/131] (660s left) gem_tiled_swapping (non-threaded)
[368.688359] Subtest non-threaded: SKIP (0.000s)
[368.770545] [094/131] (660s left) kms_busy (extended-pageflip-hang-oldfb)
[368.972607] Starting subtest: extended-pageflip-hang-oldfb
[368.975221] Starting dynamic subtest: pipe-A
[369.214048] Dynamic subtest pipe-A: SUCCESS (0.239s)
[369.246571] Starting dynamic subtest: pipe-D
[369.470977] Dynamic subtest pipe-D: SUCCESS (0.245s)
[369.472056] Subtest extended-pageflip-hang-oldfb: SUCCESS (0.499s)
[369.732118] [095/131] (659s left) gem_eio (in-flight-immediate)
[370.095294] Starting subtest: in-flight-immediate
[375.362160] Subtest in-flight-immediate: SUCCESS (5.267s)
[375.596962] [096/131] (653s left) kms_frontbuffer_tracking (fbc-stridechange)
[375.796210] Starting subtest: fbc-stridechange
[378.514822] Subtest fbc-stridechange: SUCCESS (2.718s)
[378.732069] [097/131] (650s left) kms_addfb_basic (invalid-get-prop-any)
[378.810947] Starting subtest: invalid-get-prop-any
[378.811829] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[379.100523] [098/131] (650s left) i915_selftest (live)
[380.273121] Starting subtest: live
[380.274110] Starting dynamic subtest: sanitycheck
[381.854356] Dynamic subtest sanitycheck: SUCCESS (1.580s)
[381.868515] Starting dynamic subtest: uncore
[383.387108] Dynamic subtest uncore: SUCCESS (1.531s)
[383.398036] Starting dynamic subtest: workarounds
[400.074149] Dynamic subtest workarounds: FAIL (16.478s)
[400.083461] Starting dynamic subtest: gt_engines
[402.199198] Dynamic subtest gt_engines: SUCCESS (2.330s)
[402.213676] Starting dynamic subtest: gt_timelines
[421.969506] Dynamic subtest gt_timelines: SUCCESS (19.767s)
[421.985932] Starting dynamic subtest: gt_contexts
[423.585715] Dynamic subtest gt_contexts: SUCCESS (1.614s)
[423.595873] Starting dynamic subtest: gt_lrc
[429.880528] Dynamic subtest gt_lrc: SUCCESS (6.293s)
[429.894700] Starting dynamic subtest: gt_mocs
[433.045495] Dynamic subtest gt_mocs: SUCCESS (3.163s)
[433.068717] Starting dynamic subtest: gt_pm
[437.226204] Dynamic subtest gt_pm: SUCCESS (4.179s)
[437.236632] Starting dynamic subtest: gt_heartbeat
[438.819132] Dynamic subtest gt_heartbeat: SUCCESS (1.592s)
[438.831395] Starting dynamic subtest: gt_tlb
[451.552685] Dynamic subtest gt_tlb: SUCCESS (12.731s)
[451.576514] Starting dynamic subtest: requests
[465.193057] Dynamic subtest requests: SUCCESS (13.637s)
[465.208641] Starting dynamic subtest: migrate
[470.657458] Dynamic subtest migrate: SUCCESS (5.462s)
[470.670248] Starting dynamic subtest: active
[472.205330] Dynamic subtest active: SUCCESS (1.545s)
[472.215727] Starting dynamic subtest: objects
[474.611083] Dynamic subtest objects: SUCCESS (2.405s)
[474.622645] Starting dynamic subtest: mman
[481.258135] Dynamic subtest mman: SUCCESS (6.645s)
[481.269056] Starting dynamic subtest: dmabuf
[482.855986] Dynamic subtest dmabuf: SUCCESS (1.597s)
[482.866533] Starting dynamic subtest: vma
[484.412138] Dynamic subtest vma: SUCCESS (1.555s)
[484.423225] Starting dynamic subtest: coherency
[488.424217] Dynamic subtest coherency: SUCCESS (4.010s)
[488.435306] Starting dynamic subtest: gtt
[498.524834] Dynamic subtest gtt: SUCCESS (10.098s)
[498.536471] Starting dynamic subtest: gem
[500.246184] Dynamic subtest gem: SUCCESS (1.720s)
[500.257052] Starting dynamic subtest: evict
[503.229991] Dynamic subtest evict: SUCCESS (2.982s)
[503.242265] Starting dynamic subtest: hugepages
[521.106637] Dynamic subtest hugepages: SUCCESS (17.874s)
[521.120782] Starting dynamic subtest: gem_contexts
[554.056583] Dynamic subtest gem_contexts: SUCCESS (32.946s)
[554.090240] Starting dynamic subtest: client
[555.671535] Dynamic subtest client: SUCCESS (1.612s)
[555.682242] Starting dynamic subtest: gem_migrate
[559.731679] Dynamic subtest gem_migrate: SUCCESS (4.059s)
[559.742157] Starting dynamic subtest: reset
[561.351010] Dynamic subtest reset: SUCCESS (1.618s)
[561.361889] Starting dynamic subtest: memory_region
[564.541204] Dynamic subtest memory_region: SUCCESS (3.189s)
[564.551699] Starting dynamic subtest: hangcheck
[598.189879] Dynamic subtest hangcheck: SUCCESS (33.645s)
[598.215939] Starting dynamic subtest: execlists
[599.754041] Dynamic subtest execlists: SUCCESS (1.562s)
[599.765700] Starting dynamic subtest: ring_submission
[601.340112] Dynamic subtest ring_submission: SUCCESS (1.585s)
[601.351446] Starting dynamic subtest: perf
[603.028231] Dynamic subtest perf: SUCCESS (1.687s)
[603.038829] Starting dynamic subtest: slpc
[610.228080] Dynamic subtest slpc: SUCCESS (7.198s)
[610.239267] Starting dynamic subtest: guc
[613.232874] Dynamic subtest guc: SUCCESS (3.003s)
[613.245474] Starting dynamic subtest: guc_multi_lrc
[614.835975] Dynamic subtest guc_multi_lrc: SUCCESS (1.602s)
[614.846426] Starting dynamic subtest: guc_hang
[617.243156] Dynamic subtest guc_hang: SUCCESS (2.406s)
[617.253822] Starting dynamic subtest: late_gt_pm
[618.864181] Dynamic subtest late_gt_pm: SUCCESS (1.620s)
[618.865193] Subtest live: FAIL (238.576s)
[618.897675] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[618.898630] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[618.901080] [099/131] (410s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[620.528348] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[620.530069] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[620.666900] [FACT kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[620.669218] [FACT kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)] new: kernel.kmod_is_loaded.i915: true
[620.672033] [100/131] (408s left) gem_exec_reloc (basic-concurrent0)
[620.765615] Subtest basic-concurrent0: SKIP (0.000s)
[620.856328] [101/131] (408s left) kms_flip (flip-vs-panning-vs-hang)
[621.051166] Starting subtest: flip-vs-panning-vs-hang
[621.053545] Starting dynamic subtest: A-DP3
[672.681309] Dynamic subtest A-DP3: SUCCESS (51.624s)
[672.694931] Starting dynamic subtest: D-DP3
[722.644057] Dynamic subtest D-DP3: SUCCESS (49.958s)
[722.646496] Subtest flip-vs-panning-vs-hang: SUCCESS (101.587s)
[722.977980] [102/131] (306s left) perf (sysctl-defaults)
[723.101925] Starting subtest: sysctl-defaults
[723.102863] Subtest sysctl-defaults: SUCCESS (0.000s)
[723.422990] [103/131] (306s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[723.622354] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[723.624168] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[723.775241] [104/131] (306s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[723.974361] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[723.976135] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[724.120457] [105/131] (305s left) kms_universal_plane (universal-plane-functional)
[724.313567] Starting subtest: universal-plane-functional
[724.316008] Starting dynamic subtest: pipe-A-DP-3
[726.685387] Dynamic subtest pipe-A-DP-3: SUCCESS (2.369s)
[726.698837] Starting dynamic subtest: pipe-B-DP-3
[728.896279] Dynamic subtest pipe-B-DP-3: SUCCESS (2.208s)
[728.909312] Starting dynamic subtest: pipe-C-DP-3
[731.127297] Dynamic subtest pipe-C-DP-3: SUCCESS (2.230s)
[731.142722] Starting dynamic subtest: pipe-D-DP-3
[733.334913] Dynamic subtest pipe-D-DP-3: SUCCESS (2.204s)
[733.335861] Subtest universal-plane-functional: SUCCESS (9.020s)
[733.587294] [106/131] (296s left) i915_drm_fdinfo (virtual-busy)
[733.659298] Starting subtest: virtual-busy
[733.661126] Subtest virtual-busy: SKIP (0.000s)
[733.750348] [107/131] (296s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-gtt)
[733.951214] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-gtt
[733.953012] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[734.058330] [108/131] (295s left) perf_pmu (init-busy)
[734.130214] Starting subtest: init-busy
[734.131149] Starting dynamic subtest: rcs0
[734.133492] Dynamic subtest rcs0: SUCCESS (0.003s)
[734.145661] Starting dynamic subtest: bcs0
[734.146561] Dynamic subtest bcs0: SUCCESS (0.001s)
[734.158448] Starting dynamic subtest: vcs0
[734.159389] Dynamic subtest vcs0: SUCCESS (0.001s)
[734.171732] Starting dynamic subtest: vcs1
[734.172621] Dynamic subtest vcs1: SUCCESS (0.000s)
[734.184695] Starting dynamic subtest: vecs0
[734.185924] Dynamic subtest vecs0: SUCCESS (0.001s)
[734.197920] Starting dynamic subtest: vecs1
[734.198840] Dynamic subtest vecs1: SUCCESS (0.001s)
[734.211029] Starting dynamic subtest: ccs0
[734.212694] Dynamic subtest ccs0: SUCCESS (0.000s)
[734.214725] Subtest init-busy: SUCCESS (0.013s)
[734.267745] [109/131] (295s left) core_hotunplug (unbind-rebind)
[734.401725] Starting subtest: unbind-rebind
[738.107439] Subtest unbind-rebind: SUCCESS (3.707s)
[738.164785] [110/131] (291s left) perf_pmu (busy)
[738.236310] Starting subtest: busy
[738.237230] Starting dynamic subtest: rcs0
[738.838143] Dynamic subtest rcs0: SUCCESS (0.600s)
[738.859491] Starting dynamic subtest: bcs0
[739.403977] Dynamic subtest bcs0: SUCCESS (0.561s)
[739.421062] Starting dynamic subtest: vcs0
[739.968133] Dynamic subtest vcs0: SUCCESS (0.559s)
[739.985366] Starting dynamic subtest: vcs1
[740.541018] Dynamic subtest vcs1: SUCCESS (0.568s)
[740.558730] Starting dynamic subtest: vecs0
[741.112037] Dynamic subtest vecs0: SUCCESS (0.566s)
[741.129428] Starting dynamic subtest: vecs1
[741.677951] Dynamic subtest vecs1: SUCCESS (0.561s)
[741.695606] Starting dynamic subtest: ccs0
[742.243983] Dynamic subtest ccs0: SUCCESS (0.561s)
[742.249088] Subtest busy: SUCCESS (4.009s)
[742.407960] [111/131] (287s left) kms_psr (psr2-no-drrs)
[742.604242] Subtest psr2-no-drrs: SKIP (0.000s)
[742.694196] [112/131] (287s left) gem_exec_reloc (basic-cpu-wc-active)
[742.781487] Subtest basic-cpu-wc-active: SKIP (0.000s)
[742.872154] [113/131] (287s left) kms_content_protection (uevent)
[743.140655] Starting subtest: uevent
[743.175671] Starting dynamic subtest: pipe-A-DP-3
[777.785780] Dynamic subtest pipe-A-DP-3: FAIL (34.548s)
[777.835417] Subtest uevent: FAIL (34.691s)
[778.091587] [114/131] (252s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[778.176649] Starting subtest: yf-tiled-ccs-to-x-tiled
[778.178673] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[778.410199] [115/131] (252s left) gem_exec_fence (syncobj-invalid-wait)
[778.974051] Starting subtest: syncobj-invalid-wait
[778.974979] Subtest syncobj-invalid-wait: SUCCESS (0.001s)
[779.348844] [116/131] (251s left) i915_pm_rps (reset)
[779.435160] Starting subtest: reset
[783.314138] Subtest reset: SUCCESS (3.879s)
[783.428817] [117/131] (247s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[783.509477] Starting subtest: multi-wait-all-for-submit-signaled
[783.510386] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[783.650426] [118/131] (247s left) kms_chamelium_frames (hdmi-frame-dump)
[783.937874] Subtest hdmi-frame-dump: SKIP (0.000s)
[784.100789] [119/131] (246s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[784.306248] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[785.655585] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.348s)
[785.877137] [120/131] (244s left) gem_exec_nop (basic-parallel)
[785.965713] Starting subtest: basic-parallel
[790.357124] Subtest basic-parallel: SUCCESS (4.391s)
[790.653665] [121/131] (240s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[790.850710] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[790.853267] Starting dynamic subtest: pipe-A-DP-3
[790.856859] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[790.870911] Starting dynamic subtest: pipe-B-DP-3
[790.874370] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[790.888312] Starting dynamic subtest: pipe-C-DP-3
[790.891783] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[790.905887] Starting dynamic subtest: pipe-D-DP-3
[790.910732] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[790.912977] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.007s)
[791.289398] [122/131] (239s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[791.490079] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[794.504860] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (3.014s)
[794.695833] [123/131] (236s left) kms_big_fb (linear-8bpp-rotate-90)
[794.900299] Starting subtest: linear-8bpp-rotate-90
[794.954712] Subtest linear-8bpp-rotate-90: SKIP (0.054s)
[795.138398] [124/131] (236s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[795.222574] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[795.224358] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[795.459939] [125/131] (235s left) kms_dsc (dsc-with-output-formats-with-bpc)
[795.654696] Starting subtest: dsc-with-output-formats-with-bpc
[795.679637] Subtest dsc-with-output-formats-with-bpc: SKIP (0.002s)
[795.764471] [126/131] (235s left) kms_vrr (lobf)
[795.960593] Starting subtest: lobf
[795.962464] Subtest lobf: SKIP (0.000s)
[796.063268] [127/131] (235s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[796.259713] Starting subtest: plane-primary-toggle-with-vblank-wait
[796.262232] Starting dynamic subtest: pipe-A-DP-3
[796.471482] Dynamic subtest pipe-A-DP-3: SUCCESS (0.209s)
[796.616832] Starting dynamic subtest: pipe-B-DP-3
[796.877639] Dynamic subtest pipe-B-DP-3: SUCCESS (0.279s)
[796.984059] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (0.723s)
[797.212453] [128/131] (234s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[797.290885] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[797.291871] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[797.436208] [129/131] (234s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[797.642957] Starting subtest: yf-tiled-32bpp-rotate-90
[797.644714] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[797.774752] [130/131] (233s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[797.974298] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[797.976104] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[798.117658] [131/131] (233s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[798.315275] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[798.317080] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[798.471880] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: gem_readwrite
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_cdclk
results: parsing output: 4/ for test: gem_exec_reloc
results: parsing output: 5/ for test: kms_psr
results: parsing output: 6/ for test: api_intel_allocator
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: kms_joiner
results: parsing output: 9/ for test: syncobj_wait
results: parsing output: 10/ for test: syncobj_wait
results: parsing output: 11/ for test: kms_big_fb
results: parsing output: 12/ for test: gem_ctx_isolation
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: kms_flip
results: parsing output: 16/ for test: gem_exec_balancer
results: parsing output: 17/ for test: gem_mmap_offset
results: parsing output: 18/ for test: gem_exec_schedule
results: parsing output: 19/ for test: kms_cursor_crc
results: parsing output: 20/ for test: gem_sync
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: gem_exec_fence
results: parsing output: 23/ for test: gem_userptr_blits
results: parsing output: 24/ for test: kms_prop_blob
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_legacy_colorkey
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_chamelium_hpd
results: parsing output: 29/ for test: gem_exec_reloc
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: kms_flip_scaled_crc
results: parsing output: 32/ for test: kms_plane_scaling
results: parsing output: 33/ for test: kms_flip
results: parsing output: 34/ for test: i915_drm_fdinfo
results: parsing output: 35/ for test: kms_flip
results: parsing output: 36/ for test: api_intel_allocator
results: parsing output: 37/ for test: gem_mmap_gtt
results: parsing output: 38/ for test: syncobj_wait
results: parsing output: 39/ for test: fbdev
results: parsing output: 40/ for test: syncobj_timeline
results: parsing output: 41/ for test: kms_cursor_legacy
results: parsing output: 42/ for test: kms_dp_link_training
results: parsing output: 43/ for test: kms_psr
results: parsing output: 44/ for test: gem_barrier_race
results: parsing output: 45/ for test: sysfs_defaults
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: kms_cursor_crc
results: parsing output: 48/ for test: perf
results: parsing output: 49/ for test: gem_exercise_blt
results: parsing output: 50/ for test: kms_async_flips
results: parsing output: 51/ for test: kms_psr2_sf
results: parsing output: 52/ for test: kms_pm_rpm
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_pwrite
results: parsing output: 55/ for test: kms_getfb
results: parsing output: 56/ for test: kms_cursor_legacy
results: parsing output: 57/ for test: kms_setmode
results: parsing output: 58/ for test: i915_pm_rpm
results: parsing output: 59/ for test: gem_lmem_swapping
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_lease
results: parsing output: 62/ for test: gen3_mixed_blits
results: parsing output: 63/ for test: syncobj_timeline
results: parsing output: 64/ for test: kms_getfb
results: parsing output: 65/ for test: prime_busy
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_chamelium_color
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: gem_wait
results: parsing output: 70/ for test: gem_exec_schedule
results: parsing output: 71/ for test: perf
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_softpin
results: parsing output: 75/ for test: kms_psr2_sf
results: parsing output: 76/ for test: gem_sync
results: parsing output: 77/ for test: gem_userptr_blits
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: gem_ctx_shared
results: parsing output: 80/ for test: kms_pm_dc
results: parsing output: 81/ for test: vgem_basic
results: parsing output: 82/ for test: kms_busy
results: parsing output: 83/ for test: kms_plane_multiple
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: gem_exec_balancer
results: parsing output: 86/ for test: kms_sequence
results: parsing output: 87/ for test: kms_cursor_legacy
results: parsing output: 88/ for test: gem_exec_suspend
results: parsing output: 89/ for test: syncobj_basic
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_ctx_persistence
results: parsing output: 92/ for test: gem_tiled_swapping
results: parsing output: 93/ for test: kms_busy
results: parsing output: 94/ for test: gem_eio
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_addfb_basic
results: parsing output: 97/ for test: i915_selftest
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: gem_exec_reloc
results: parsing output: 100/ for test: kms_flip
results: parsing output: 101/ for test: perf
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_universal_plane
results: parsing output: 105/ for test: i915_drm_fdinfo
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: perf_pmu
results: parsing output: 108/ for test: core_hotunplug
results: parsing output: 109/ for test: perf_pmu
results: parsing output: 110/ for test: kms_psr
results: parsing output: 111/ for test: gem_exec_reloc
results: parsing output: 112/ for test: kms_content_protection
results: parsing output: 113/ for test: gem_render_copy
results: parsing output: 114/ for test: gem_exec_fence
results: parsing output: 115/ for test: i915_pm_rps
results: parsing output: 116/ for test: syncobj_timeline
results: parsing output: 117/ for test: kms_chamelium_frames
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: gem_exec_nop
results: parsing output: 120/ for test: kms_ccs
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: gem_render_copy
results: parsing output: 124/ for test: kms_dsc
results: parsing output: 125/ for test: kms_vrr
results: parsing output: 126/ for test: kms_atomic_transition
results: parsing output: 127/ for test: syncobj_wait
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_frontbuffer_tracking
Done.