[61.782484] Initializing watchdogs
[61.782553]   /dev/watchdog0
[61.802727] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[61.814263] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[61.818311] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.820638] [001/131] (960s left) gen9_exec_parse (bb-chained)
[61.908708] Subtest bb-chained: SKIP (0.000s)
[61.990837] [002/131] (960s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[62.171770] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[62.172653] Starting dynamic subtest: pipe-A-DP-3
[62.181150] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[62.188943] Starting dynamic subtest: pipe-B-DP-3
[62.197655] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[62.205289] Starting dynamic subtest: pipe-C-DP-3
[62.213607] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[62.220993] Starting dynamic subtest: pipe-D-DP-3
[62.229593] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[62.231278] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[62.635679] [003/131] (959s left) kms_properties (crtc-properties-atomic)
[62.813997] Starting subtest: crtc-properties-atomic
[62.814985] Starting dynamic subtest: pipe-A-DP-3
[63.170585] Dynamic subtest pipe-A-DP-3: SUCCESS (0.355s)
[63.181034] Starting dynamic subtest: pipe-B-DP-3
[63.513959] Dynamic subtest pipe-B-DP-3: SUCCESS (0.343s)
[63.522197] Starting dynamic subtest: pipe-C-DP-3
[63.870266] Dynamic subtest pipe-C-DP-3: SUCCESS (0.355s)
[63.878556] Starting dynamic subtest: pipe-D-DP-3
[64.208404] Dynamic subtest pipe-D-DP-3: SUCCESS (0.337s)
[64.209327] Subtest crtc-properties-atomic: SUCCESS (1.394s)
[64.559159] [004/131] (957s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[64.753582] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[64.755345] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[64.944076] [005/131] (957s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[65.131953] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[65.132896] Starting dynamic subtest: pipe-A-valid-mode
[65.208133] Dynamic subtest pipe-A-valid-mode: SKIP (0.075s)
[65.209788] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.076s)
[65.439153] [006/131] (957s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[65.624851] Starting subtest: psr-1p-primscrn-cur-indfb-move
[65.626479] Subtest psr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[65.798486] [007/131] (956s left) kms_psr (psr2-primary-mmap-cpu)
[65.977543] Subtest psr2-primary-mmap-cpu: SKIP (0.000s)
[66.031059] [008/131] (956s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[66.217616] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[66.219264] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[66.404670] [009/131] (956s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[66.591778] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[66.593408] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[66.722362] [010/131] (956s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[66.982489] Starting subtest: 4-tiled-addfb-size-offset-overflow
[66.984514] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.001s)
[67.338758] [011/131] (955s left) gem_eio (wait-immediate)
[67.875070] Starting subtest: wait-immediate
[68.519307] Subtest wait-immediate: SUCCESS (0.644s)
[68.759275] [012/131] (954s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[68.950245] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[68.997723] [013/131] (954s left) gem_exec_alignment (many)
[69.074472] Starting subtest: many
[98.303351] Subtest many: SUCCESS (29.229s)
[99.053718] [014/131] (924s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[99.289891] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[102.126949] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (2.838s)
[102.296783] [015/131] (920s left) kms_psr (fbc-psr-cursor-blt)
[102.484518] Subtest fbc-psr-cursor-blt: SKIP (0.000s)
[102.549225] [016/131] (920s left) gem_fence_thrash (bo-write-verify-threaded-y)
[102.593588] Starting subtest: bo-write-verify-threaded-y
[102.622744] Subtest bo-write-verify-threaded-y: SKIP (0.028s)
[102.703238] [017/131] (920s left) fbdev (unaligned-read)
[102.760296] Starting subtest: unaligned-read
[102.774633] Subtest unaligned-read: SUCCESS (0.015s)
[102.920822] [018/131] (920s left) kms_lease (lease-unleased-crtc)
[103.100122] Starting subtest: lease-unleased-crtc
[103.100986] Starting dynamic subtest: pipe-A-DP-3
[103.233450] Dynamic subtest pipe-A-DP-3: SUCCESS (0.133s)
[103.242875] Starting dynamic subtest: pipe-B-DP-3
[103.290562] Dynamic subtest pipe-B-DP-3: SUCCESS (0.056s)
[103.301808] Starting dynamic subtest: pipe-C-DP-3
[103.347646] Dynamic subtest pipe-C-DP-3: SUCCESS (0.056s)
[103.358179] Starting dynamic subtest: pipe-D-DP-3
[103.399758] Dynamic subtest pipe-D-DP-3: SUCCESS (0.051s)
[103.400958] Subtest lease-unleased-crtc: SUCCESS (0.301s)
[103.649195] [019/131] (919s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[103.842057] Starting subtest: x-tiled-16bpp-rotate-0
[105.736543] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.894s)
[105.963649] [020/131] (917s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[106.154525] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[106.208125] [021/131] (917s left) gem_exec_balancer (bonded-false-hang)
[106.602299] Starting subtest: bonded-false-hang
[106.604059] Subtest bonded-false-hang: SKIP (0.000s)
[106.765562] [022/131] (916s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[106.947604] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[106.949322] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[107.151507] [023/131] (916s left) gem_exec_params (mmapped)
[107.232451] Starting subtest: mmapped
[107.234414] Subtest mmapped: SUCCESS (0.002s)
[107.385693] [024/131] (916s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite)
[107.577575] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite
[110.835420] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (3.259s)
[110.998200] [025/131] (912s left) gem_mmap_gtt (cpuset-big-copy)
[111.067081] Subtest cpuset-big-copy: SKIP (0.000s)
[111.128978] [026/131] (912s left) kms_psr (fbc-psr2-sprite-blt)
[111.309035] Subtest fbc-psr2-sprite-blt: SKIP (0.000s)
[111.360073] [027/131] (912s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[111.435170] Subtest flip-primary-invalidate-overlay: SKIP (0.000s)
[111.507701] [028/131] (912s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[111.696542] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[111.698304] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[111.854688] [029/131] (912s left) kms_getfb (getfb-handle-protection)
[112.046375] Starting subtest: getfb-handle-protection
[112.061498] Subtest getfb-handle-protection: SUCCESS (0.015s)
[112.266909] [030/131] (911s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[112.344857] Starting subtest: multi-wait-all-for-submit-submitted
[112.461234] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.108s)
[112.618504] [031/131] (911s left) kms_flip (2x-plain-flip-ts-check)
[112.805931] Starting subtest: 2x-plain-flip-ts-check
[112.821591] Subtest 2x-plain-flip-ts-check: SKIP (0.015s)
[112.981227] [032/131] (911s left) gem_pxp (reject-modify-context-protection-on)
[115.578453] Starting subtest: reject-modify-context-protection-on
[115.581205] Subtest reject-modify-context-protection-on: SKIP (0.000s)
[115.713817] [033/131] (908s left) kms_chamelium_audio (dp-audio-edid)
[115.981660] Subtest dp-audio-edid: SKIP (0.000s)
[116.159244] [034/131] (908s left) sysfs_timeslice_duration (timeout)
[116.241605] Starting subtest: timeout
[116.242510] Starting dynamic subtest: vecs0
[118.187499] Dynamic subtest vecs0: SUCCESS (1.945s)
[118.197123] Starting dynamic subtest: ccs0
[120.039414] Dynamic subtest ccs0: SUCCESS (1.851s)
[120.049979] Starting dynamic subtest: vcs0
[121.729141] Dynamic subtest vcs0: SUCCESS (1.689s)
[121.739899] Starting dynamic subtest: bcs0
[122.955388] Dynamic subtest bcs0: SUCCESS (1.226s)
[122.965192] Starting dynamic subtest: vecs1
[124.764270] Dynamic subtest vecs1: SUCCESS (1.808s)
[124.775027] Starting dynamic subtest: rcs0
[126.497288] Dynamic subtest rcs0: SUCCESS (1.733s)
[126.507220] Starting dynamic subtest: vcs1
[128.208377] Dynamic subtest vcs1: SUCCESS (1.711s)
[128.209417] Subtest timeout: SUCCESS (11.967s)
[128.355552] [035/131] (896s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[128.432968] Starting subtest: invalid-bsd2-flag-on-vebox
[128.434046] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[128.596695] [036/131] (895s left) gem_exercise_blt (fast-copy-emit)
[128.688294] Starting subtest: fast-copy-emit
[128.689220] Starting dynamic subtest: linear-smem-smem-emit
[128.734835] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.046s)
[128.744207] Starting dynamic subtest: linear-smem-lmem0-emit
[128.750465] Dynamic subtest linear-smem-lmem0-emit: SUCCESS (0.015s)
[128.759771] Starting dynamic subtest: linear-lmem0-smem-emit
[128.849757] Dynamic subtest linear-lmem0-smem-emit: SUCCESS (0.099s)
[128.858937] Starting dynamic subtest: linear-lmem0-lmem0-emit
[128.951653] Dynamic subtest linear-lmem0-lmem0-emit: SUCCESS (0.102s)
[128.961174] Starting dynamic subtest: xmajor-smem-smem-emit
[128.967137] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.015s)
[128.976396] Starting dynamic subtest: xmajor-smem-lmem0-emit
[128.981934] Dynamic subtest xmajor-smem-lmem0-emit: SUCCESS (0.015s)
[128.991255] Starting dynamic subtest: xmajor-lmem0-smem-emit
[129.092480] Dynamic subtest xmajor-lmem0-smem-emit: SUCCESS (0.110s)
[129.101749] Starting dynamic subtest: xmajor-lmem0-lmem0-emit
[129.203330] Dynamic subtest xmajor-lmem0-lmem0-emit: SUCCESS (0.111s)
[129.212475] Starting dynamic subtest: tile4-smem-smem-emit
[129.218401] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.015s)
[129.227596] Starting dynamic subtest: tile4-smem-lmem0-emit
[129.233273] Dynamic subtest tile4-smem-lmem0-emit: SUCCESS (0.015s)
[129.242510] Starting dynamic subtest: tile4-lmem0-smem-emit
[129.345457] Dynamic subtest tile4-lmem0-smem-emit: SUCCESS (0.112s)
[129.354583] Starting dynamic subtest: tile4-lmem0-lmem0-emit
[129.455425] Dynamic subtest tile4-lmem0-lmem0-emit: SUCCESS (0.110s)
[129.464569] Starting dynamic subtest: tile64-smem-smem-emit
[129.471487] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.016s)
[129.480632] Starting dynamic subtest: tile64-smem-lmem0-emit
[129.486472] Dynamic subtest tile64-smem-lmem0-emit: SUCCESS (0.015s)
[129.495566] Starting dynamic subtest: tile64-lmem0-smem-emit
[129.599503] Dynamic subtest tile64-lmem0-smem-emit: SUCCESS (0.113s)
[129.608621] Starting dynamic subtest: tile64-lmem0-lmem0-emit
[129.711384] Dynamic subtest tile64-lmem0-lmem0-emit: SUCCESS (0.112s)
[129.712408] Subtest fast-copy-emit: SUCCESS (1.023s)
[129.875552] [037/131] (894s left) kms_plane_multiple (2x-tiling-4)
[130.055591] Starting subtest: 2x-tiling-4
[130.057392] Subtest 2x-tiling-4: SKIP (0.000s)
[130.191600] [038/131] (894s left) dmabuf_sync_file (export-before-signal)
[130.324296] Starting subtest: export-before-signal
[130.325256] Subtest export-before-signal: SUCCESS (0.001s)
[130.487346] [FACT dmabuf_sync_file (export-before-signal)] new: kernel.kmod_is_loaded.vgem: true
[130.489041] [039/131] (894s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[130.684206] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[130.685160] Starting dynamic subtest: pipe-A-DP-3
[130.707139] Dynamic subtest pipe-A-DP-3: SKIP (0.002s)
[130.716409] Starting dynamic subtest: pipe-B-DP-3
[130.738570] Dynamic subtest pipe-B-DP-3: SKIP (0.002s)
[130.747976] Starting dynamic subtest: pipe-C-DP-3
[130.773683] Dynamic subtest pipe-C-DP-3: SKIP (0.002s)
[130.783038] Starting dynamic subtest: pipe-D-DP-3
[130.804854] Dynamic subtest pipe-D-DP-3: SKIP (0.002s)
[130.806524] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.012s)
[131.182603] [040/131] (893s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[131.383366] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[131.385161] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[131.626722] [041/131] (893s left) i915_pm_rpm (gem-pread)
[134.045027] Starting subtest: gem-pread
[134.732226] Subtest gem-pread: SUCCESS (0.686s)
[135.028668] [042/131] (890s left) prime_vgem (fence-wait)
[135.130580] Starting subtest: fence-wait
[135.131606] Starting dynamic subtest: rcs0
[136.199421] Dynamic subtest rcs0: SUCCESS (1.068s)
[136.210529] Starting dynamic subtest: bcs0
[137.262918] Dynamic subtest bcs0: SUCCESS (1.062s)
[137.277614] Starting dynamic subtest: vcs0
[138.305719] Dynamic subtest vcs0: SUCCESS (1.041s)
[138.320017] Starting dynamic subtest: vcs1
[139.352168] Dynamic subtest vcs1: SUCCESS (1.045s)
[139.361845] Starting dynamic subtest: vecs0
[140.395384] Dynamic subtest vecs0: SUCCESS (1.042s)
[140.409216] Starting dynamic subtest: vecs1
[141.438631] Dynamic subtest vecs1: SUCCESS (1.041s)
[141.452825] Starting dynamic subtest: ccs0
[142.481643] Dynamic subtest ccs0: SUCCESS (1.041s)
[142.483683] Subtest fence-wait: SUCCESS (7.351s)
[142.660350] [043/131] (882s left) syncobj_timeline (invalid-wait-bad-flags)
[142.742178] Starting subtest: invalid-wait-bad-flags
[142.743156] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[142.883668] [044/131] (882s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[143.078545] Starting subtest: fbcpsr-rgb565-draw-render
[143.080204] Subtest fbcpsr-rgb565-draw-render: SKIP (0.000s)
[143.278294] [045/131] (881s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[143.359274] Starting subtest: wait-all-for-submit-delayed-submit
[143.467982] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.106s)
[143.630735] [046/131] (881s left) gem_exec_flush (basic-wb-rw-default)
[143.718862] Subtest basic-wb-rw-default: SKIP (0.000s)
[143.803138] [047/131] (881s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[143.992947] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[143.994822] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[144.217807] [048/131] (881s left) kms_pipe_crc_basic (suspend-read-crc)
[144.411175] Starting subtest: suspend-read-crc
[144.412135] Starting dynamic subtest: pipe-A-DP-3
[164.684041] Dynamic subtest pipe-A-DP-3: SUCCESS (5.174s)
[164.698648] Starting dynamic subtest: pipe-B-DP-3
[184.785402] Dynamic subtest pipe-B-DP-3: SUCCESS (4.532s)
[184.798597] Starting dynamic subtest: pipe-C-DP-3
[205.087455] Dynamic subtest pipe-C-DP-3: SUCCESS (4.645s)
[205.100655] Starting dynamic subtest: pipe-D-DP-3
[225.291507] Dynamic subtest pipe-D-DP-3: SUCCESS (4.575s)
[225.292427] Subtest suspend-read-crc: SUCCESS (18.932s)
[225.614679] [049/131] (799s left) gem_exec_reloc (basic-gtt-wc)
[225.705291] Subtest basic-gtt-wc: SKIP (0.000s)
[225.771613] [050/131] (799s left) gem_watchdog (default-physical)
[225.865285] Starting subtest: default-physical
[226.915432] Subtest default-physical: SUCCESS (1.050s)
[227.071732] [051/131] (798s left) gem_fence_thrash (bo-write-verify-threaded-x)
[227.119281] Starting subtest: bo-write-verify-threaded-x
[227.157395] Subtest bo-write-verify-threaded-x: SKIP (0.037s)
[227.242370] [052/131] (798s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[227.437092] Starting subtest: fbc-rgb565-draw-blt
[230.210420] Subtest fbc-rgb565-draw-blt: SUCCESS (2.774s)
[230.439521] [053/131] (795s left) kms_universal_plane (disable-primary-vs-flip)
[230.642830] Starting subtest: disable-primary-vs-flip
[230.645156] Starting dynamic subtest: pipe-A-DP-3
[231.465364] Dynamic subtest pipe-A-DP-3: SUCCESS (0.821s)
[231.477476] Starting dynamic subtest: pipe-B-DP-3
[231.941317] Dynamic subtest pipe-B-DP-3: SUCCESS (0.475s)
[231.955060] Starting dynamic subtest: pipe-C-DP-3
[232.400454] Dynamic subtest pipe-C-DP-3: SUCCESS (0.457s)
[232.422254] Starting dynamic subtest: pipe-D-DP-3
[232.883344] Dynamic subtest pipe-D-DP-3: SUCCESS (0.481s)
[232.884296] Subtest disable-primary-vs-flip: SUCCESS (2.241s)
[233.177349] [054/131] (792s left) kms_cursor_edge_walk (128x128-top-edge)
[233.365998] Starting subtest: 128x128-top-edge
[233.368172] Starting dynamic subtest: pipe-A-DP-3
[236.826933] Dynamic subtest pipe-A-DP-3: SUCCESS (3.458s)
[236.840741] Starting dynamic subtest: pipe-D-DP-3
[240.185636] Dynamic subtest pipe-D-DP-3: SUCCESS (3.359s)
[240.186645] Subtest 128x128-top-edge: SUCCESS (6.820s)
[240.479596] [055/131] (785s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[240.669409] Starting subtest: flip-vs-cursor-busy-crc-legacy
[241.438015] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.768s)
[241.755828] [056/131] (784s left) kms_flip (modeset-vs-vblank-race-interruptible)
[241.965500] Starting subtest: modeset-vs-vblank-race-interruptible
[241.970348] Starting dynamic subtest: A-DP3
[245.122733] Dynamic subtest A-DP3: SUCCESS (3.152s)
[245.166447] Starting dynamic subtest: B-DP3
[248.335378] Dynamic subtest B-DP3: SUCCESS (3.207s)
[248.381912] Starting dynamic subtest: C-DP3
[251.592327] Dynamic subtest C-DP3: SUCCESS (3.252s)
[251.636143] Starting dynamic subtest: D-DP3
[254.663116] Dynamic subtest D-DP3: SUCCESS (3.064s)
[254.671731] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (12.705s)
[255.064296] [057/131] (771s left) perf_pmu (busy-start)
[255.141032] Starting subtest: busy-start
[255.141964] Starting dynamic subtest: rcs0
[257.719936] Dynamic subtest rcs0: SUCCESS (2.577s)
[257.737005] Starting dynamic subtest: bcs0
[260.272149] Dynamic subtest bcs0: SUCCESS (2.547s)
[260.289594] Starting dynamic subtest: vcs0
[262.824289] Dynamic subtest vcs0: SUCCESS (2.547s)
[262.841272] Starting dynamic subtest: vcs1
[265.373618] Dynamic subtest vcs1: SUCCESS (2.546s)
[265.391433] Starting dynamic subtest: vecs0
[267.921761] Dynamic subtest vecs0: SUCCESS (2.547s)
[267.938957] Starting dynamic subtest: vecs1
[270.468757] Dynamic subtest vecs1: SUCCESS (2.546s)
[270.486063] Starting dynamic subtest: ccs0
[273.015472] Dynamic subtest ccs0: SUCCESS (2.545s)
[273.016516] Subtest busy-start: SUCCESS (17.878s)
[273.193414] [058/131] (753s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[273.390405] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[273.392168] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[273.613189] [059/131] (752s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[273.805525] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[273.806454] Starting dynamic subtest: pipe-A-DP-3
[273.809874] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[273.822862] Starting dynamic subtest: pipe-B-DP-3
[273.826406] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[273.839247] Starting dynamic subtest: pipe-C-DP-3
[273.842764] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[273.855563] Starting dynamic subtest: pipe-D-DP-3
[273.859137] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[273.860788] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SKIP (0.008s)
[274.303200] [060/131] (752s left) kms_flip (2x-flip-vs-expired-vblank)
[274.488736] Starting subtest: 2x-flip-vs-expired-vblank
[274.505155] Subtest 2x-flip-vs-expired-vblank: SKIP (0.015s)
[274.713278] [061/131] (751s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[274.908566] Starting subtest: basic-flip-before-cursor-atomic
[275.945014] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.037s)
[276.300001] [062/131] (750s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[276.499636] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[276.501403] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[276.700487] [063/131] (750s left) gem_ctx_param (basic)
[276.792040] Starting subtest: basic
[276.794407] Subtest basic: SUCCESS (0.001s)
[276.981303] [064/131] (749s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[277.168545] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[277.169441] Starting dynamic subtest: pipe-A-valid-mode
[277.303423] Dynamic subtest pipe-A-valid-mode: SKIP (0.134s)
[277.305215] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.136s)
[277.628896] [065/131] (749s left) gem_create (create-ext-placement-each)
[277.821899] Starting subtest: create-ext-placement-each
[277.822975] Subtest create-ext-placement-each: SUCCESS (0.000s)
[278.015537] [066/131] (748s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[278.283929] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[278.465483] [067/131] (748s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[278.659004] Starting subtest: extended-pageflip-modeset-hang-oldfb
[278.661410] Starting dynamic subtest: pipe-A
[286.473506] Dynamic subtest pipe-A: SUCCESS (7.812s)
[286.488611] Starting dynamic subtest: pipe-D
[294.301787] Dynamic subtest pipe-D: SUCCESS (7.826s)
[294.304236] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (15.644s)
[294.563943] [068/131] (732s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[294.644702] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[294.645627] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[294.855283] [069/131] (732s left) api_intel_bb (add-remove-objects)
[294.942462] Starting subtest: add-remove-objects
[294.977291] Subtest add-remove-objects: SUCCESS (0.035s)
[295.224995] [070/131] (732s left) gem_exec_fence (keep-in-fence)
[295.431870] Starting subtest: keep-in-fence
[295.432801] Starting dynamic subtest: rcs0
[295.533669] Dynamic subtest rcs0: SUCCESS (0.101s)
[295.562865] Starting dynamic subtest: bcs0
[295.593451] Dynamic subtest bcs0: SUCCESS (0.057s)
[295.631054] Starting dynamic subtest: vcs0
[295.664672] Dynamic subtest vcs0: SUCCESS (0.069s)
[295.686793] Starting dynamic subtest: vcs1
[295.720811] Dynamic subtest vcs1: SUCCESS (0.054s)
[295.752818] Starting dynamic subtest: vecs0
[295.782615] Dynamic subtest vecs0: SUCCESS (0.060s)
[295.808382] Starting dynamic subtest: vecs1
[295.838674] Dynamic subtest vecs1: SUCCESS (0.054s)
[295.863380] Starting dynamic subtest: ccs0
[296.064400] Dynamic subtest ccs0: SUCCESS (0.224s)
[296.065471] Subtest keep-in-fence: SUCCESS (0.633s)
[296.855574] [071/131] (730s left) api_intel_bb (destroy-bb)
[296.934822] Starting subtest: destroy-bb
[296.970741] Subtest destroy-bb: SUCCESS (0.035s)
[297.208380] [072/131] (730s left) kms_psr (fbc-pr-cursor-render)
[297.395045] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[297.466589] [073/131] (730s left) gem_softpin (safe-alignment)
[297.553843] Starting subtest: safe-alignment
[297.614118] Subtest safe-alignment: SUCCESS (0.060s)
[297.790586] [074/131] (729s left) i915_hangman (gt-engine-error)
[297.885423] Starting subtest: gt-engine-error
[297.886356] Starting dynamic subtest: rcs0
[298.752972] Dynamic subtest rcs0: SUCCESS (0.867s)
[298.769338] Starting dynamic subtest: bcs0
[299.579530] Dynamic subtest bcs0: SUCCESS (0.825s)
[299.597004] Starting dynamic subtest: vcs0
[300.389747] Dynamic subtest vcs0: SUCCESS (0.809s)
[300.403150] Starting dynamic subtest: vcs1
[301.162784] Dynamic subtest vcs1: SUCCESS (0.772s)
[301.179988] Starting dynamic subtest: vecs0
[301.927687] Dynamic subtest vecs0: SUCCESS (0.763s)
[301.944000] Starting dynamic subtest: vecs1
[302.738389] Dynamic subtest vecs1: SUCCESS (0.809s)
[302.753337] Starting dynamic subtest: ccs0
[303.550612] Dynamic subtest ccs0: SUCCESS (0.811s)
[303.551576] Subtest gt-engine-error: SUCCESS (5.666s)
[303.736890] [075/131] (723s left) kms_cursor_crc (cursor-onscreen-512x512)
[304.211770] Starting subtest: cursor-onscreen-512x512
[304.213546] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[304.554461] [076/131] (723s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[304.744613] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[304.745417] Starting dynamic subtest: pipe-A
[304.834614] Dynamic subtest pipe-A: SUCCESS (0.091s)
[304.853899] Starting dynamic subtest: pipe-B
[305.048198] Dynamic subtest pipe-B: SUCCESS (0.212s)
[305.071537] Starting dynamic subtest: pipe-C
[305.262357] Dynamic subtest pipe-C: SUCCESS (0.212s)
[305.286190] Starting dynamic subtest: pipe-D
[305.475204] Dynamic subtest pipe-D: SUCCESS (0.211s)
[305.476287] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (0.732s)
[305.846260] [077/131] (722s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[306.040652] Starting subtest: flip-vs-cursor-busy-crc-atomic
[306.798361] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.758s)
[307.099039] [078/131] (720s left) kms_dp_link_training (uhbr-sst)
[307.305018] Starting subtest: uhbr-sst
[307.306782] Subtest uhbr-sst: SKIP (0.000s)
[307.482276] [079/131] (720s left) perf (blocking-parameterized)
[307.940543] Starting subtest: blocking-parameterized
[327.975973] Subtest blocking-parameterized: SUCCESS (20.035s)
[328.042733] [080/131] (700s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[328.261632] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[328.263656] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[328.475778] [081/131] (699s left) vgem_basic (sysfs)
[328.542680] Starting subtest: sysfs
[328.543581] Subtest sysfs: SUCCESS (0.000s)
[328.679620] [082/131] (699s left) gem_ctx_persistence (engines-hostile)
[328.767633] Starting subtest: engines-hostile
[328.768550] Starting dynamic subtest: rcs0
[328.927472] Dynamic subtest rcs0: SUCCESS (0.158s)
[328.977532] Starting dynamic subtest: bcs0
[328.994723] Dynamic subtest bcs0: SUCCESS (0.063s)
[329.015075] Starting dynamic subtest: vcs0
[329.065638] Dynamic subtest vcs0: SUCCESS (0.069s)
[329.084591] Starting dynamic subtest: vcs1
[329.176335] Dynamic subtest vcs1: SUCCESS (0.108s)
[329.226040] Starting dynamic subtest: vecs0
[329.246446] Dynamic subtest vecs0: SUCCESS (0.066s)
[329.267528] Starting dynamic subtest: vecs1
[329.343612] Dynamic subtest vecs1: SUCCESS (0.095s)
[329.393698] Starting dynamic subtest: ccs0
[329.404460] Dynamic subtest ccs0: SUCCESS (0.057s)
[329.405409] Subtest engines-hostile: SUCCESS (0.638s)
[329.628857] [083/131] (698s left) i915_suspend (fence-restore-untiled)
[329.722569] Starting subtest: fence-restore-untiled
[329.724427] Subtest fence-restore-untiled: SKIP (0.000s)
[329.925679] [084/131] (698s left) syncobj_wait (invalid-reset-illegal-handle)
[330.004691] Starting subtest: invalid-reset-illegal-handle
[330.005663] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[330.160873] [085/131] (698s left) gem_readwrite (write-bad-handle)
[330.242522] Subtest write-bad-handle: SKIP (0.000s)
[330.324868] [086/131] (698s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[330.411266] Subtest no-spare-fences-busy: SKIP (0.000s)
[330.490395] [087/131] (698s left) gem_ctx_persistence (heartbeat-close)
[330.580805] Starting subtest: heartbeat-close
[330.582829] Subtest heartbeat-close: SKIP (0.000s)
[330.781867] [088/131] (697s left) kms_cursor_crc (cursor-onscreen-256x256)
[331.201987] Starting subtest: cursor-onscreen-256x256
[331.207468] Starting dynamic subtest: pipe-A-DP-3
[333.976627] Dynamic subtest pipe-A-DP-3: SUCCESS (2.768s)
[334.030329] Starting dynamic subtest: pipe-D-DP-3
[336.577014] Dynamic subtest pipe-D-DP-3: SUCCESS (2.559s)
[336.578071] Subtest cursor-onscreen-256x256: SUCCESS (5.375s)
[336.972911] [089/131] (691s left) gem_ringfill (engines-basic)
[337.481593] Starting subtest: engines-basic
[337.482795] Starting dynamic subtest: rcs0
[337.575611] Dynamic subtest rcs0: SUCCESS (0.095s)
[337.591755] Starting dynamic subtest: bcs0
[337.616441] Dynamic subtest bcs0: SUCCESS (0.039s)
[337.638762] Starting dynamic subtest: vcs0
[337.658881] Dynamic subtest vcs0: SUCCESS (0.041s)
[337.684815] Starting dynamic subtest: vcs1
[337.703901] Dynamic subtest vcs1: SUCCESS (0.043s)
[337.726119] Starting dynamic subtest: vecs0
[337.748565] Dynamic subtest vecs0: SUCCESS (0.043s)
[337.769786] Starting dynamic subtest: vecs1
[337.790551] Dynamic subtest vecs1: SUCCESS (0.040s)
[337.817871] Starting dynamic subtest: ccs0
[337.834421] Dynamic subtest ccs0: SUCCESS (0.042s)
[337.835491] Subtest engines-basic: SUCCESS (0.356s)
[337.998504] [090/131] (690s left) kms_pm_rpm (cursor)
[340.028042] Starting subtest: cursor
[340.030371] Subtest cursor: SKIP (0.000s)
[340.452812] [091/131] (688s left) gem_pread (bench)
[340.539504] Subtest bench: SKIP (0.000s)
[340.612888] [092/131] (688s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[340.809453] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[343.216609] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (2.407s)
[343.390701] [093/131] (685s left) gem_exec_schedule (submit-golden-slice)
[343.489236] Starting subtest: submit-golden-slice
[343.490212] Starting dynamic subtest: rcs0
[343.571409] Dynamic subtest rcs0: SUCCESS (0.082s)
[343.586488] Starting dynamic subtest: bcs0
[343.628801] Dynamic subtest bcs0: SUCCESS (0.056s)
[343.644626] Starting dynamic subtest: vcs0
[343.683396] Dynamic subtest vcs0: SUCCESS (0.053s)
[343.698544] Starting dynamic subtest: vcs1
[343.740986] Dynamic subtest vcs1: SUCCESS (0.056s)
[343.756399] Starting dynamic subtest: vecs0
[343.794726] Dynamic subtest vecs0: SUCCESS (0.053s)
[343.809777] Starting dynamic subtest: vecs1
[343.853584] Dynamic subtest vecs1: SUCCESS (0.058s)
[343.868342] Starting dynamic subtest: ccs0
[343.905054] Dynamic subtest ccs0: SUCCESS (0.050s)
[343.905990] Subtest submit-golden-slice: SUCCESS (0.416s)
[344.359258] [094/131] (684s left) gem_exec_schedule (preempt-contexts)
[344.452992] Starting subtest: preempt-contexts
[344.453887] Starting dynamic subtest: rcs0
[344.565586] Dynamic subtest rcs0: SUCCESS (0.112s)
[344.581213] Starting dynamic subtest: bcs0
[344.643273] Dynamic subtest bcs0: SUCCESS (0.077s)
[344.658574] Starting dynamic subtest: vcs0
[344.719575] Dynamic subtest vcs0: SUCCESS (0.075s)
[344.733799] Starting dynamic subtest: vcs1
[344.796573] Dynamic subtest vcs1: SUCCESS (0.076s)
[344.811417] Starting dynamic subtest: vecs0
[344.872422] Dynamic subtest vecs0: SUCCESS (0.075s)
[344.887402] Starting dynamic subtest: vecs1
[344.947691] Dynamic subtest vecs1: SUCCESS (0.074s)
[344.962766] Starting dynamic subtest: ccs0
[345.022819] Dynamic subtest ccs0: SUCCESS (0.074s)
[345.023650] Subtest preempt-contexts: SUCCESS (0.571s)
[345.611367] [095/131] (683s left) kms_frontbuffer_tracking (psr-suspend)
[345.810485] Starting subtest: psr-suspend
[345.812202] Subtest psr-suspend: SKIP (0.000s)
[346.001908] [096/131] (683s left) gem_exec_capture (capture-invisible)
[346.100664] Starting subtest: capture-invisible
[346.101625] Starting dynamic subtest: lmem0
[346.103405] Dynamic subtest lmem0: SKIP (0.000s)
[346.117135] Starting dynamic subtest: smem0
[346.119681] Dynamic subtest smem0: SKIP (0.000s)
[346.121805] Subtest capture-invisible: SKIP (0.002s)
[346.278532] [097/131] (683s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[346.482693] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[346.483617] Starting dynamic subtest: pipe-A-DP-3
[346.492189] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[346.505434] Starting dynamic subtest: pipe-B-DP-3
[346.514062] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[346.527130] Starting dynamic subtest: pipe-C-DP-3
[346.535597] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[346.548577] Starting dynamic subtest: pipe-D-DP-3
[346.558060] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[346.560308] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SKIP (0.007s)
[346.996672] [098/131] (682s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[347.209417] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[348.456502] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.234s)
[348.701071] [099/131] (680s left) kms_big_fb (linear-64bpp-rotate-90)
[348.900351] Starting subtest: linear-64bpp-rotate-90
[348.960484] Subtest linear-64bpp-rotate-90: SKIP (0.059s)
[349.182007] [100/131] (680s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[349.378382] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[349.380118] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[349.555024] [101/131] (680s left) kms_content_protection (dp-mst-suspend-resume)
[349.814391] Starting subtest: dp-mst-suspend-resume
[349.816234] Subtest dp-mst-suspend-resume: SKIP (0.000s)
[350.046746] [102/131] (679s left) kms_atomic (plane-primary-legacy)
[350.239604] Starting subtest: plane-primary-legacy
[350.240528] Starting dynamic subtest: pipe-A-DP-3
[351.224799] Dynamic subtest pipe-A-DP-3: SUCCESS (0.984s)
[351.225944] Subtest plane-primary-legacy: SUCCESS (0.986s)
[351.559029] [103/131] (678s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[351.637614] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[351.638682] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[351.826220] [104/131] (678s left) gem_userptr_blits (unsync-unmap-after-close)
[351.925129] Subtest unsync-unmap-after-close: SKIP (0.000s)
[352.124026] [105/131] (677s left) drm_read (empty-nonblock)
[352.386251] Starting subtest: empty-nonblock
[352.387259] Subtest empty-nonblock: SUCCESS (0.000s)
[352.640401] [106/131] (677s left) gem_eio (suspend)
[352.966635] Starting subtest: suspend
[366.850391] Subtest suspend: SUCCESS (13.884s)
[367.122092] [107/131] (663s left) kms_psr (pr-primary-render)
[367.312518] Subtest pr-primary-render: SKIP (0.000s)
[367.409196] [108/131] (662s left) kms_vblank (ts-continuation-suspend)
[367.606213] Starting subtest: ts-continuation-suspend
[367.608582] Starting dynamic subtest: pipe-A-DP-3
[386.999681] Dynamic subtest pipe-A-DP-3: SUCCESS (3.974s)
[387.016315] Starting dynamic subtest: pipe-D-DP-3
[406.258210] Dynamic subtest pipe-D-DP-3: SUCCESS (3.889s)
[406.259161] Subtest ts-continuation-suspend: SUCCESS (7.869s)
[406.637301] [109/131] (623s left) kms_flip (2x-nonexisting-fb-interruptible)
[406.840483] Starting subtest: 2x-nonexisting-fb-interruptible
[406.856992] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.016s)
[407.038152] [110/131] (623s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[407.232061] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[407.233874] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[407.393429] [111/131] (623s left) kms_invalid_mode (uint-max-clock)
[407.580320] Starting subtest: uint-max-clock
[407.581211] Starting dynamic subtest: pipe-A-DP-3
[407.690275] Dynamic subtest pipe-A-DP-3: SUCCESS (0.108s)
[407.716141] Starting dynamic subtest: pipe-B-DP-3
[407.717262] Dynamic subtest pipe-B-DP-3: SUCCESS (0.002s)
[407.731339] Starting dynamic subtest: pipe-C-DP-3
[407.732479] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[407.745514] Starting dynamic subtest: pipe-D-DP-3
[407.746402] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s)
[407.747272] Subtest uint-max-clock: SUCCESS (0.127s)
[408.009311] [112/131] (622s left) kms_properties (get_properties-sanity-non-atomic)
[408.200192] Starting subtest: get_properties-sanity-non-atomic
[408.201434] Subtest get_properties-sanity-non-atomic: SUCCESS (0.002s)
[408.326373] [113/131] (622s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[410.758485] Starting subtest: modeset-non-lpsp-stress-no-wait
[414.821163] Subtest modeset-non-lpsp-stress-no-wait: SUCCESS (4.062s)
[415.121235] [114/131] (615s left) kms_flip (flip-vs-absolute-wf_vblank)
[415.313690] Starting subtest: flip-vs-absolute-wf_vblank
[415.318644] Starting dynamic subtest: A-DP3
[423.453443] Dynamic subtest A-DP3: SUCCESS (8.135s)
[423.469892] Starting dynamic subtest: B-DP3
[431.507466] Dynamic subtest B-DP3: SUCCESS (8.052s)
[431.523227] Starting dynamic subtest: C-DP3
[439.727649] Dynamic subtest C-DP3: SUCCESS (8.219s)
[439.743514] Starting dynamic subtest: D-DP3
[447.949016] Dynamic subtest D-DP3: SUCCESS (8.221s)
[447.951259] Subtest flip-vs-absolute-wf_vblank: SUCCESS (32.639s)
[448.290843] [115/131] (582s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[448.375789] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[448.460968] [116/131] (582s left) gem_exec_whisper (basic-fds-all)
[448.551055] Starting subtest: basic-fds-all
[470.703043] Subtest basic-fds-all: SUCCESS (22.151s)
[470.995194] [117/131] (560s left) kms_properties (invalid-properties-atomic)
[471.179705] Starting subtest: invalid-properties-atomic
[471.668489] Subtest invalid-properties-atomic: SUCCESS (0.488s)
[471.803722] [118/131] (559s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[471.991581] Starting subtest: plane-scaler-unity-scaling-with-rotation
[471.992461] Starting dynamic subtest: pipe-A
[472.361433] Dynamic subtest pipe-A: SUCCESS (0.369s)
[472.396535] Starting dynamic subtest: pipe-B
[472.840484] Dynamic subtest pipe-B: SUCCESS (0.476s)
[472.873326] Starting dynamic subtest: pipe-C
[473.319386] Dynamic subtest pipe-C: SUCCESS (0.476s)
[473.351337] Starting dynamic subtest: pipe-D
[473.799325] Dynamic subtest pipe-D: SUCCESS (0.478s)
[473.800374] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (1.809s)
[474.133532] [119/131] (557s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[474.214270] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[474.321766] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.105s)
[474.500037] [120/131] (556s left) syncobj_basic (bad-pad-handle-to-fd)
[474.581593] Starting subtest: bad-pad-handle-to-fd
[474.582528] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[474.721425] [121/131] (556s left) kms_chamelium_hpd (dp-hpd)
[474.989028] Subtest dp-hpd: SKIP (0.000s)
[475.143949] [122/131] (556s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[475.333503] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[475.562675] Starting dynamic subtest: pipe-A-DP-3-4
[477.842576] Dynamic subtest pipe-A-DP-3-4: SUCCESS (2.279s)
[477.863063] Starting dynamic subtest: pipe-A-DP-3-x
[480.025135] Dynamic subtest pipe-A-DP-3-x: SUCCESS (2.180s)
[480.250118] Starting dynamic subtest: pipe-B-DP-3-4
[482.477007] Dynamic subtest pipe-B-DP-3-4: SUCCESS (2.241s)
[482.491011] Starting dynamic subtest: pipe-B-DP-3-x
[484.639197] Dynamic subtest pipe-B-DP-3-x: SUCCESS (2.161s)
[484.830525] Starting dynamic subtest: pipe-C-DP-3-4
[487.053574] Dynamic subtest pipe-C-DP-3-4: SUCCESS (2.238s)
[487.068187] Starting dynamic subtest: pipe-C-DP-3-x
[489.219819] Dynamic subtest pipe-C-DP-3-x: SUCCESS (2.164s)
[489.423664] Starting dynamic subtest: pipe-D-DP-3-4
[491.655209] Dynamic subtest pipe-D-DP-3-4: SUCCESS (2.246s)
[491.669141] Starting dynamic subtest: pipe-D-DP-3-x
[493.821367] Dynamic subtest pipe-D-DP-3-x: SUCCESS (2.164s)
[493.822228] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (18.488s)
[494.338043] [123/131] (537s left) i915_drm_fdinfo (most-busy-check-all)
[494.410181] Starting subtest: most-busy-check-all
[494.411136] Starting dynamic subtest: rcs0
[494.440174] Dynamic subtest rcs0: SKIP (0.028s)
[494.454922] Starting dynamic subtest: bcs0
[494.457100] Dynamic subtest bcs0: SKIP (0.001s)
[494.471328] Starting dynamic subtest: vcs0
[494.473630] Dynamic subtest vcs0: SKIP (0.000s)
[494.487322] Starting dynamic subtest: vcs1
[494.489555] Dynamic subtest vcs1: SKIP (0.000s)
[494.503148] Starting dynamic subtest: vecs0
[494.505305] Dynamic subtest vecs0: SKIP (0.001s)
[494.518711] Starting dynamic subtest: vecs1
[494.520851] Dynamic subtest vecs1: SKIP (0.000s)
[494.536956] Starting dynamic subtest: ccs0
[494.539248] Dynamic subtest ccs0: SKIP (0.000s)
[494.541434] Subtest most-busy-check-all: SKIP (0.039s)
[494.591415] [124/131] (536s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[494.831522] Starting subtest: fb-8bpc-vs-panel-6bpc
[494.833872] Starting dynamic subtest: pipe-A-DP-3
[495.259683] Dynamic subtest pipe-A-DP-3: SUCCESS (0.425s)
[495.261248] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (0.429s)
[495.509099] [125/131] (536s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[495.700130] Starting subtest: cursorB-vs-flipA-atomic-transitions
[495.705855] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.002s)
[495.834369] [126/131] (535s left) gem_set_tiling_vs_pwrite
[496.011213] [127/131] (535s left) gem_mmap (bad-object)
[496.090968] Subtest bad-object: SKIP (0.000s)
[496.186653] [128/131] (535s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[496.381366] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[496.383155] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[496.550439] [129/131] (535s left) syncobj_wait (multi-wait-for-submit-submitted)
[496.626172] Starting subtest: multi-wait-for-submit-submitted
[496.728252] Subtest multi-wait-for-submit-submitted: SUCCESS (0.101s)
[496.877434] [130/131] (535s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[497.075022] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[497.076772] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[497.284368] [131/131] (534s left) gem_mmap_offset (isolation)
[497.364396] Starting subtest: isolation
[497.371875] Subtest isolation: SUCCESS (0.007s)
[497.520162] Closing watchdogs
results: parsing output: 0/ for test: gen9_exec_parse
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: kms_properties
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_flip_scaled_crc
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: gem_eio
results: parsing output: 11/ for test: kms_psr2_sf
results: parsing output: 12/ for test: gem_exec_alignment
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: gem_fence_thrash
results: parsing output: 16/ for test: fbdev
results: parsing output: 17/ for test: kms_lease
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_psr2_sf
results: parsing output: 20/ for test: gem_exec_balancer
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_exec_params
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: gem_mmap_gtt
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: kms_psr_stress_test
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_getfb
results: parsing output: 29/ for test: syncobj_wait
results: parsing output: 30/ for test: kms_flip
results: parsing output: 31/ for test: gem_pxp
results: parsing output: 32/ for test: kms_chamelium_audio
results: parsing output: 33/ for test: sysfs_timeslice_duration
results: parsing output: 34/ for test: gem_exec_params
results: parsing output: 35/ for test: gem_exercise_blt
results: parsing output: 36/ for test: kms_plane_multiple
results: parsing output: 37/ for test: dmabuf_sync_file
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: i915_pm_rpm
results: parsing output: 41/ for test: prime_vgem
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: syncobj_timeline
results: parsing output: 45/ for test: gem_exec_flush
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_pipe_crc_basic
results: parsing output: 48/ for test: gem_exec_reloc
results: parsing output: 49/ for test: gem_watchdog
results: parsing output: 50/ for test: gem_fence_thrash
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_universal_plane
results: parsing output: 53/ for test: kms_cursor_edge_walk
results: parsing output: 54/ for test: kms_cursor_legacy
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: perf_pmu
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_ccs
results: parsing output: 59/ for test: kms_flip
results: parsing output: 60/ for test: kms_cursor_legacy
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: gem_ctx_param
results: parsing output: 63/ for test: kms_flip_scaled_crc
results: parsing output: 64/ for test: gem_create
results: parsing output: 65/ for test: kms_chamelium_hpd
results: parsing output: 66/ for test: kms_busy
results: parsing output: 67/ for test: syncobj_timeline
results: parsing output: 68/ for test: api_intel_bb
results: parsing output: 69/ for test: gem_exec_fence
results: parsing output: 70/ for test: api_intel_bb
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: gem_softpin
results: parsing output: 73/ for test: i915_hangman
results: parsing output: 74/ for test: kms_cursor_crc
results: parsing output: 75/ for test: kms_plane_scaling
results: parsing output: 76/ for test: kms_cursor_legacy
results: parsing output: 77/ for test: kms_dp_link_training
results: parsing output: 78/ for test: perf
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: vgem_basic
results: parsing output: 81/ for test: gem_ctx_persistence
results: parsing output: 82/ for test: i915_suspend
results: parsing output: 83/ for test: syncobj_wait
results: parsing output: 84/ for test: gem_readwrite
results: parsing output: 85/ for test: gem_fenced_exec_thrash
results: parsing output: 86/ for test: gem_ctx_persistence
results: parsing output: 87/ for test: kms_cursor_crc
results: parsing output: 88/ for test: gem_ringfill
results: parsing output: 89/ for test: kms_pm_rpm
results: parsing output: 90/ for test: gem_pread
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: gem_exec_schedule
results: parsing output: 93/ for test: gem_exec_schedule
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_exec_capture
results: parsing output: 96/ for test: kms_ccs
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_content_protection
results: parsing output: 101/ for test: kms_atomic
results: parsing output: 102/ for test: syncobj_timeline
results: parsing output: 103/ for test: gem_userptr_blits
results: parsing output: 104/ for test: drm_read
results: parsing output: 105/ for test: gem_eio
results: parsing output: 106/ for test: kms_psr
results: parsing output: 107/ for test: kms_vblank
results: parsing output: 108/ for test: kms_flip
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_invalid_mode
results: parsing output: 111/ for test: kms_properties
results: parsing output: 112/ for test: kms_pm_rpm
results: parsing output: 113/ for test: kms_flip
results: parsing output: 114/ for test: gem_exec_flush
results: parsing output: 115/ for test: gem_exec_whisper
results: parsing output: 116/ for test: kms_properties
results: parsing output: 117/ for test: kms_plane_scaling
results: parsing output: 118/ for test: syncobj_timeline
results: parsing output: 119/ for test: syncobj_basic
results: parsing output: 120/ for test: kms_chamelium_hpd
results: parsing output: 121/ for test: kms_async_flips
results: parsing output: 122/ for test: i915_drm_fdinfo
results: parsing output: 123/ for test: kms_dither
results: parsing output: 124/ for test: kms_cursor_legacy
results: parsing output: 125/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 126/ for test: gem_mmap
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: syncobj_wait
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: gem_mmap_offset
Done.