[57.263312] Initializing watchdogs
[57.263356]   /dev/watchdog0
[57.277154] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.281692] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.283852] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.287023] [001/133] (960s left) gen7_exec_parse (cmd-crossing-page)
[57.375962] Subtest cmd-crossing-page: SKIP (0.000s)
[57.441316] [002/133] (960s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[57.551917] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area
[57.556279] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[57.624211] [003/133] (960s left) vgem_basic (mmap)
[57.692596] Starting subtest: mmap
[57.698826] Subtest mmap: SUCCESS (0.008s)
[57.757174] [FACT vgem_basic (mmap)] new: kernel.kmod_is_loaded.vgem: true
[57.760203] [004/133] (960s left) gem_exec_reloc (basic-write-gtt)
[57.814360] Subtest basic-write-gtt: SKIP (0.000s)
[57.891364] [005/133] (960s left) kms_flip (2x-absolute-wf_vblank)
[57.983102] Starting subtest: 2x-absolute-wf_vblank
[57.992062] Subtest 2x-absolute-wf_vblank: SKIP (0.010s)
[58.066472] [006/133] (959s left) kms_pipe_crc_basic (hang-read-crc)
[58.156045] Starting subtest: hang-read-crc
[58.158129] Starting dynamic subtest: pipe-A-eDP-1
[60.216307] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.066s)
[60.225319] Starting dynamic subtest: pipe-B-eDP-1
[62.884182] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.673s)
[62.893434] Starting dynamic subtest: pipe-C-eDP-1
[65.587349] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.708s)
[65.594726] Starting dynamic subtest: pipe-D-eDP-1
[68.259297] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.676s)
[68.261732] Subtest hang-read-crc: SUCCESS (10.127s)
[69.076750] [007/133] (948s left) kms_psr (psr-primary-mmap-cpu)
[69.169773] Starting subtest: psr-primary-mmap-cpu
[69.172603] Starting dynamic subtest: eDP-1
[70.864687] Dynamic subtest eDP-1: SUCCESS (1.699s)
[70.867069] Subtest psr-primary-mmap-cpu: SUCCESS (1.700s)
[71.733678] [008/133] (946s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[71.838194] Starting subtest: yf-tiled-32bpp-rotate-180
[71.842807] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[71.941664] [009/133] (946s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[72.040720] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[72.045250] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.000s)
[72.123895] [010/133] (946s left) gem_ringfill (engines-basic)
[77.911664] Starting subtest: engines-basic
[77.914303] Starting dynamic subtest: rcs0
[77.969641] Dynamic subtest rcs0: SUCCESS (0.059s)
[77.979710] Starting dynamic subtest: bcs0
[78.013895] Dynamic subtest bcs0: SUCCESS (0.043s)
[78.022596] Starting dynamic subtest: vcs0
[78.057255] Dynamic subtest vcs0: SUCCESS (0.042s)
[78.067448] Starting dynamic subtest: vcs1
[78.100051] Dynamic subtest vcs1: SUCCESS (0.042s)
[78.109069] Starting dynamic subtest: vecs0
[78.141929] Dynamic subtest vecs0: SUCCESS (0.041s)
[78.150992] Starting dynamic subtest: ccs0
[78.186669] Dynamic subtest ccs0: SUCCESS (0.044s)
[78.189074] Subtest engines-basic: SUCCESS (0.277s)
[78.264326] [011/133] (939s left) gem_exec_schedule (u-semaphore-codependency)
[78.339122] Starting subtest: u-semaphore-codependency
[78.356368] Subtest u-semaphore-codependency: SUCCESS (0.023s)
[78.692593] [012/133] (939s left) gem_workarounds (reset-fd)
[78.758290] Starting subtest: reset-fd
[78.872540] Subtest reset-fd: SUCCESS (0.114s)
[79.001085] [013/133] (939s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[79.100024] Starting subtest: bad-rotation-90-yf-tiled-ccs
[79.102351] Starting dynamic subtest: pipe-A-eDP-1
[79.127411] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[79.137183] Starting dynamic subtest: pipe-B-eDP-1
[79.158823] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[79.165786] Starting dynamic subtest: pipe-C-eDP-1
[79.187817] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[79.194854] Starting dynamic subtest: pipe-D-eDP-1
[79.217577] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[79.221891] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.003s)
[81.397821] [014/133] (936s left) kms_properties (invalid-properties-atomic)
[81.488942] Starting subtest: invalid-properties-atomic
[81.795744] Subtest invalid-properties-atomic: SUCCESS (0.306s)
[81.862862] [015/133] (936s left) gem_exec_flush (basic-uc-ro-default)
[81.917229] Starting subtest: basic-uc-ro-default
[87.402395] Subtest basic-uc-ro-default: SUCCESS (5.463s)
[87.600851] [016/133] (930s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[87.712762] Starting subtest: bo-too-small-due-to-tiling
[87.716861] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[87.815406] [017/133] (930s left) gem_exec_whisper (basic-queues-priority-all)
[87.883669] Starting subtest: basic-queues-priority-all
[110.275089] Subtest basic-queues-priority-all: SUCCESS (22.387s)
[110.460874] [018/133] (908s left) gem_mmap_offset (isolation)
[110.530578] Starting subtest: isolation
[110.548186] Subtest isolation: SUCCESS (0.006s)
[110.651908] [019/133] (907s left) gem_exec_reloc (basic-concurrent0)
[110.709913] Subtest basic-concurrent0: SKIP (0.000s)
[110.787312] [020/133] (907s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[110.879882] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[110.882237] Starting dynamic subtest: pipe-A
[111.927493] Dynamic subtest pipe-A: SUCCESS (1.050s)
[111.935701] Starting dynamic subtest: pipe-B
[114.007530] Dynamic subtest pipe-B: SUCCESS (2.080s)
[114.017381] Starting dynamic subtest: pipe-C
[115.199894] Dynamic subtest pipe-C: SUCCESS (1.191s)
[115.214840] Starting dynamic subtest: pipe-D
[116.421275] Dynamic subtest pipe-D: SUCCESS (1.221s)
[116.423525] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.544s)
[117.631484] [021/133] (900s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[117.731870] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[124.528189] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.799s)
[124.685724] [022/133] (893s left) core_setmaster (master-drop-set-shared-fd)
[124.757845] Starting subtest: master-drop-set-shared-fd
[124.779372] Subtest master-drop-set-shared-fd: SUCCESS (0.022s)
[124.817685] [023/133] (893s left) gem_exec_balancer (sequential)
[124.878583] Starting subtest: sequential
[127.975764] Subtest sequential: SUCCESS (3.097s)
[128.319122] [024/133] (890s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[128.420540] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[128.425053] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[128.521738] [025/133] (890s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[128.624209] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[128.628170] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[128.737419] [026/133] (890s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[128.828187] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[128.830421] Starting dynamic subtest: pipe-A-eDP-1
[128.853347] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[128.864051] Starting dynamic subtest: pipe-B-eDP-1
[128.885590] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[128.893983] Starting dynamic subtest: pipe-C-eDP-1
[128.915601] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[128.923572] Starting dynamic subtest: pipe-D-eDP-1
[128.945816] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[128.949833] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[131.015756] [027/133] (887s left) gem_partial_pwrite_pread (writes-after-reads-display)
[131.082086] Subtest writes-after-reads-display: SKIP (0.000s)
[131.152623] [028/133] (887s left) kms_cursor_crc (cursor-sliding-512x512)
[131.427435] Starting subtest: cursor-sliding-512x512
[131.432031] Subtest cursor-sliding-512x512: SKIP (0.001s)
[131.603244] [029/133] (887s left) kms_rotation_crc (primary-rotation-90)
[131.702739] Starting subtest: primary-rotation-90
[131.707217] Subtest primary-rotation-90: SKIP (0.001s)
[131.773068] [030/133] (887s left) gem_wait (write-busy)
[131.832633] Starting subtest: write-busy
[131.835074] Starting dynamic subtest: all-engines
[132.440790] Dynamic subtest all-engines: SUCCESS (0.608s)
[132.457127] Starting dynamic subtest: rcs0
[132.993079] Dynamic subtest rcs0: SUCCESS (0.551s)
[133.009174] Starting dynamic subtest: bcs0
[133.544643] Dynamic subtest bcs0: SUCCESS (0.551s)
[133.559081] Starting dynamic subtest: vcs0
[134.932618] Dynamic subtest vcs0: SUCCESS (1.386s)
[134.948820] Starting dynamic subtest: vcs1
[136.916043] Dynamic subtest vcs1: SUCCESS (1.982s)
[136.931932] Starting dynamic subtest: vecs0
[138.899796] Dynamic subtest vecs0: SUCCESS (1.982s)
[138.915496] Starting dynamic subtest: ccs0
[139.449059] Dynamic subtest ccs0: SUCCESS (0.549s)
[139.451556] Subtest write-busy: SUCCESS (7.617s)
[139.646409] [031/133] (879s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[139.745289] Starting subtest: primary-y-tiled-reflect-x-180
[139.804594] Subtest primary-y-tiled-reflect-x-180: SKIP (0.059s)
[139.905548] [032/133] (879s left) kms_psr (fbc-psr-no-drrs)
[140.002988] Starting subtest: fbc-psr-no-drrs
[140.005287] Starting dynamic subtest: eDP-1
[140.009470] Dynamic subtest eDP-1: SKIP (0.000s)
[140.013713] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[140.073879] [033/133] (878s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[140.125009] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[140.127397] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[140.249224] [034/133] (878s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[140.350085] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[144.723939] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.378s)
[145.922699] [035/133] (873s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[145.984069] Starting subtest: single-wait-all-for-submit-available-submitted
[145.986389] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[146.086305] [036/133] (873s left) kms_getfb (getfb-handle-protection)
[146.170828] Starting subtest: getfb-handle-protection
[146.189983] Subtest getfb-handle-protection: SUCCESS (0.020s)
[146.288626] [037/133] (872s left) kms_vrr (seamless-rr-switch-virtual)
[146.386932] Starting subtest: seamless-rr-switch-virtual
[146.393252] Subtest seamless-rr-switch-virtual: SKIP (0.000s)
[146.458521] [038/133] (872s left) gem_ctx_persistence (engines-persistence)
[146.533881] Starting subtest: engines-persistence
[146.536262] Starting dynamic subtest: rcs0
[147.361843] Dynamic subtest rcs0: SUCCESS (0.827s)
[147.373197] Starting dynamic subtest: bcs0
[148.114798] Dynamic subtest bcs0: SUCCESS (0.751s)
[148.127023] Starting dynamic subtest: vcs0
[148.887820] Dynamic subtest vcs0: SUCCESS (0.771s)
[148.899318] Starting dynamic subtest: vcs1
[149.642976] Dynamic subtest vcs1: SUCCESS (0.753s)
[149.653899] Starting dynamic subtest: vecs0
[150.395830] Dynamic subtest vecs0: SUCCESS (0.751s)
[150.406220] Starting dynamic subtest: ccs0
[151.189761] Dynamic subtest ccs0: SUCCESS (0.792s)
[151.192217] Subtest engines-persistence: SUCCESS (4.656s)
[151.272444] [039/133] (868s left) i915_drm_fdinfo (all-busy-idle-check-all)
[151.326858] Starting subtest: all-busy-idle-check-all
[151.334581] Subtest all-busy-idle-check-all: SKIP (0.006s)
[151.421119] [040/133] (867s left) kms_cdclk (plane-scaling)
[151.549165] Starting subtest: plane-scaling
[151.551411] Starting dynamic subtest: pipe-A-eDP-1
[151.848893] Dynamic subtest pipe-A-eDP-1: SKIP (0.296s)
[151.858607] Starting dynamic subtest: pipe-B-eDP-1
[151.862939] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[151.871256] Starting dynamic subtest: pipe-C-eDP-1
[151.875634] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[151.883674] Starting dynamic subtest: pipe-D-eDP-1
[151.888046] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[151.892294] Subtest plane-scaling: SKIP (0.304s)
[152.651355] [041/133] (866s left) kms_vblank (crtc-id)
[152.747855] Starting subtest: crtc-id
[152.749749] Starting dynamic subtest: pipe-A-eDP-1
[153.203726] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.455s)
[153.218208] Starting dynamic subtest: pipe-D-eDP-1
[154.373063] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.166s)
[154.375271] Subtest crtc-id: SUCCESS (1.624s)
[155.208368] [042/133] (864s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[155.316608] Starting subtest: fbcpsr-tiling-linear
[161.910991] Subtest fbcpsr-tiling-linear: SUCCESS (6.597s)
[162.046513] [043/133] (857s left) gem_userptr_blits (sync-unmap)
[162.123075] Starting subtest: sync-unmap
[162.137358] Subtest sync-unmap: SUCCESS (0.014s)
[162.297291] [044/133] (857s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[162.396908] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[162.401487] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[162.474800] [045/133] (857s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[162.583454] Starting subtest: y-tiled-64bpp-rotate-270
[162.587406] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[162.705236] [046/133] (856s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[162.801445] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[166.761777] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (3.963s)
[167.964537] [047/133] (851s left) sw_sync (sync_multi_consumer)
[168.002604] Starting subtest: sync_multi_consumer
[168.481130] Subtest sync_multi_consumer: SUCCESS (0.479s)
[168.541071] [048/133] (851s left) kms_pipe_crc_basic (bad-source)
[168.623189] Starting subtest: bad-source
[168.625515] Subtest bad-source: SUCCESS (0.000s)
[168.693121] [049/133] (851s left) fbdev (write)
[168.746989] Starting subtest: write
[169.105983] Subtest write: SUCCESS (0.357s)
[169.181555] [050/133] (850s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[169.290289] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[169.294626] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[169.383438] [051/133] (850s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[169.471979] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[169.476175] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[169.564976] [052/133] (850s left) kms_content_protection (suspend-resume)
[169.704794] Starting subtest: suspend-resume
[169.709317] Subtest suspend-resume: SKIP (0.000s)
[169.819243] [053/133] (850s left) intel_hwmon (hwmon-read)
[169.879675] Subtest hwmon-read: SKIP (0.000s)
[169.945942] [054/133] (850s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[170.041523] Starting subtest: fbc-rgb565-draw-mmap-wc
[174.100207] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (4.061s)
[175.270966] [055/133] (844s left) kms_psr (fbc-pr-cursor-blt)
[175.361224] Starting subtest: fbc-pr-cursor-blt
[175.365360] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[175.432563] [056/133] (844s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier)
[175.515318] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier
[175.519646] Subtest pixel-format-4-tiled-lnl-ccs-modifier: SKIP (0.000s)
[175.587627] [057/133] (844s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier)
[175.688841] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier
[175.693190] Subtest pixel-format-4-tiled-bmg-ccs-modifier: SKIP (0.000s)
[175.760946] [058/133] (844s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[175.853722] Starting subtest: psr-dirtyfb-ioctl
[175.855643] Starting dynamic subtest: A-eDP-1
[179.767601] Dynamic subtest A-eDP-1: SUCCESS (3.912s)
[179.769976] Subtest psr-dirtyfb-ioctl: SUCCESS (3.913s)
[180.567939] [059/133] (839s left) gem_exec_reloc (basic-cpu-active)
[180.625029] Subtest basic-cpu-active: SKIP (0.000s)
[180.694978] [060/133] (839s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[180.801446] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[180.805618] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[180.907141] [061/133] (839s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[181.022591] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[181.026994] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[181.166780] [062/133] (839s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[181.268863] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[181.271197] Starting dynamic subtest: A-eDP1
[184.885182] Dynamic subtest A-eDP1: SUCCESS (3.613s)
[184.894423] Starting dynamic subtest: B-eDP1
[188.088402] Dynamic subtest B-eDP1: SUCCESS (3.203s)
[188.097819] Starting dynamic subtest: C-eDP1
[191.191741] Dynamic subtest C-eDP1: SUCCESS (3.099s)
[191.201528] Starting dynamic subtest: D-eDP1
[194.298632] Dynamic subtest D-eDP1: SUCCESS (3.110s)
[194.300989] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.032s)
[195.098201] [063/133] (825s left) kms_cursor_crc (cursor-offscreen-64x21)
[195.294668] Starting subtest: cursor-offscreen-64x21
[195.339191] Subtest cursor-offscreen-64x21: SKIP (0.041s)
[195.577773] [064/133] (824s left) i915_suspend (basic-s3-without-i915)
[195.608486] Starting subtest: basic-s3-without-i915
[197.309873] Subtest basic-s3-without-i915: SKIP (1.696s)
[198.860910] [065/133] (821s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[198.962404] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[198.964757] Starting dynamic subtest: pipe-A
[200.089391] Dynamic subtest pipe-A: SUCCESS (1.130s)
[200.096871] Starting dynamic subtest: pipe-B
[202.384863] Dynamic subtest pipe-B: SUCCESS (2.294s)
[202.395647] Starting dynamic subtest: pipe-C
[203.540948] Dynamic subtest pipe-C: SUCCESS (1.153s)
[203.549465] Starting dynamic subtest: pipe-D
[204.766910] Dynamic subtest pipe-D: SUCCESS (1.225s)
[204.769328] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.808s)
[205.970401] [066/133] (814s left) gem_ctx_param (invalid-param-set)
[206.030197] Starting subtest: invalid-param-set
[206.032545] Subtest invalid-param-set: SUCCESS (0.000s)
[206.103165] [067/133] (814s left) kms_psr (pr-sprite-blt)
[206.196871] Starting subtest: pr-sprite-blt
[206.200666] Subtest pr-sprite-blt: SKIP (0.000s)
[206.276463] [068/133] (814s left) gem_mmap_gtt (basic-copy)
[206.340638] Subtest basic-copy: SKIP (0.000s)
[206.403311] [069/133] (814s left) gem_partial_pwrite_pread (write)
[206.474973] Subtest write: SKIP (0.000s)
[206.540839] [070/133] (814s left) kms_async_flips (test-time-stamp-atomic)
[206.629105] Starting subtest: test-time-stamp-atomic
[207.019418] Starting dynamic subtest: pipe-A-eDP-1
[207.781968] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.760s)
[208.170860] Starting dynamic subtest: pipe-B-eDP-1
[208.926153] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.760s)
[209.292845] Starting dynamic subtest: pipe-C-eDP-1
[210.056862] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.768s)
[210.417655] Starting dynamic subtest: pipe-D-eDP-1
[211.183512] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.770s)
[211.186048] Subtest test-time-stamp-atomic: SUCCESS (4.555s)
[212.346138] [071/133] (808s left) gem_workarounds (basic-read-context)
[212.407578] Starting subtest: basic-read-context
[212.421376] Subtest basic-read-context: SUCCESS (0.013s)
[212.554082] [072/133] (808s left) gem_cs_tlb (engines)
[212.623835] Starting subtest: engines
[212.626149] Starting dynamic subtest: rcs0
[214.839657] Dynamic subtest rcs0: SUCCESS (2.152s)
[214.847341] Starting dynamic subtest: bcs0
[216.932328] Dynamic subtest bcs0: SUCCESS (2.151s)
[216.945630] Starting dynamic subtest: vcs0
[219.138064] Dynamic subtest vcs0: SUCCESS (2.153s)
[219.146427] Starting dynamic subtest: vcs1
[221.291472] Dynamic subtest vcs1: SUCCESS (2.152s)
[221.301974] Starting dynamic subtest: vecs0
[223.444391] Dynamic subtest vecs0: SUCCESS (2.153s)
[223.455209] Starting dynamic subtest: ccs0
[225.598864] Dynamic subtest ccs0: SUCCESS (2.153s)
[225.601298] Subtest engines: SUCCESS (12.920s)
[225.678713] [073/133] (795s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[225.791820] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[225.796116] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[225.880353] [074/133] (794s left) kms_psr (psr2-cursor-mmap-cpu)
[225.970369] Starting subtest: psr2-cursor-mmap-cpu
[225.972668] Starting dynamic subtest: eDP-1
[227.732196] Dynamic subtest eDP-1: SUCCESS (1.762s)
[227.734878] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.763s)
[228.619062] [075/133] (792s left) prime_busy (after)
[228.680254] Starting subtest: after
[228.685316] Starting dynamic subtest: rcs0
[228.713970] Dynamic subtest rcs0: SUCCESS (0.030s)
[228.723665] Starting dynamic subtest: bcs0
[228.753253] Dynamic subtest bcs0: SUCCESS (0.039s)
[228.761651] Starting dynamic subtest: vcs0
[228.794053] Dynamic subtest vcs0: SUCCESS (0.040s)
[228.802929] Starting dynamic subtest: vcs1
[228.834293] Dynamic subtest vcs1: SUCCESS (0.040s)
[228.842795] Starting dynamic subtest: vecs0
[228.874710] Dynamic subtest vecs0: SUCCESS (0.039s)
[228.882880] Starting dynamic subtest: ccs0
[228.915806] Dynamic subtest ccs0: SUCCESS (0.040s)
[229.024509] Subtest after: SUCCESS (0.342s)
[229.099581] [076/133] (791s left) kms_selftest (drm_cmdline_parser)
[229.137247] Starting subtest: drm_cmdline_parser
[229.181547] Starting dynamic subtest: drm_test_cmdline_force_d_only
[229.259709] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.079s)
[229.268720] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[229.372420] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.111s)
[229.381952] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[229.468151] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.096s)
[229.477742] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[229.565332] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.096s)
[229.573629] Starting dynamic subtest: drm_test_cmdline_force_e_only
[229.667203] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.101s)
[229.676627] Starting dynamic subtest: drm_test_cmdline_res
[229.786046] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.117s)
[229.795555] Starting dynamic subtest: drm_test_cmdline_res_vesa
[229.884168] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.099s)
[229.893614] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[229.987542] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.102s)
[229.996949] Starting dynamic subtest: drm_test_cmdline_res_rblank
[230.071124] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.083s)
[230.080280] Starting dynamic subtest: drm_test_cmdline_res_bpp
[230.159330] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.087s)
[230.168840] Starting dynamic subtest: drm_test_cmdline_res_refresh
[230.254352] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.094s)
[230.263642] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[230.351572] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.097s)
[230.365469] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[230.447511] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.095s)
[230.460966] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[230.545513] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.097s)
[230.555378] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[230.644472] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.098s)
[230.654066] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[230.752989] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.108s)
[230.762616] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[230.855957] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.102s)
[230.864742] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[230.939440] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.084s)
[230.948572] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[231.047646] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.108s)
[231.056914] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[231.151351] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.103s)
[231.160538] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[231.258882] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.107s)
[231.266367] Starting dynamic subtest: drm_test_cmdline_name
[231.360873] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.101s)
[231.368326] Starting dynamic subtest: drm_test_cmdline_name_bpp
[231.447298] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.085s)
[231.456062] Starting dynamic subtest: drm_test_cmdline_name_option
[231.548160] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.100s)
[231.555107] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[231.646823] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.097s)
[231.655898] Starting dynamic subtest: drm_test_cmdline_rotate_0
[231.744693] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.097s)
[231.753630] Starting dynamic subtest: drm_test_cmdline_rotate_90
[231.840698] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.095s)
[231.847911] Starting dynamic subtest: drm_test_cmdline_rotate_180
[231.936558] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.095s)
[231.944623] Starting dynamic subtest: drm_test_cmdline_rotate_270
[232.060334] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.122s)
[232.070153] Starting dynamic subtest: drm_test_cmdline_hmirror
[232.154515] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.094s)
[232.162677] Starting dynamic subtest: drm_test_cmdline_vmirror
[232.249506] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.095s)
[232.257566] Starting dynamic subtest: drm_test_cmdline_margin_options
[232.339286] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.088s)
[232.346869] Starting dynamic subtest: drm_test_cmdline_multiple_options
[232.448110] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.109s)
[232.455574] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[232.550230] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.101s)
[232.557534] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[232.644276] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.093s)
[232.651578] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[232.730080] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.085s)
[232.737507] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[232.819115] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.088s)
[232.826585] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[232.903241] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.084s)
[232.910888] Starting dynamic subtest: drm_test_cmdline_invalid
[233.004930] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.103s)
[233.014571] Starting dynamic subtest: drm_test_cmdline_tv_options
[233.132431] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.124s)
[233.134423] Subtest drm_cmdline_parser: SUCCESS (3.995s)
[233.304336] [077/133] (787s left) perf_pmu (rc6-suspend)
[233.347681] Starting subtest: rc6-suspend
[256.279387] Subtest rc6-suspend: SUCCESS (7.743s)
[257.175606] [078/133] (763s left) gem_readwrite (beyond-eob)
[257.247225] Subtest beyond-EOB: SKIP (0.000s)
[257.308350] [079/133] (763s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[257.424284] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[264.680147] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.313s)
[264.779320] [080/133] (756s left) i915_drm_fdinfo (virtual-busy-idle-all)
[264.815514] Starting subtest: virtual-busy-idle-all
[264.819564] Subtest virtual-busy-idle-all: SKIP (0.000s)
[264.879011] [081/133] (756s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k)
[265.264481] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s)
[266.081796] [082/133] (755s left) gem_eio (wait-immediate)
[266.309304] Starting subtest: wait-immediate
[266.663933] Subtest wait-immediate: SUCCESS (0.355s)
[266.808321] [083/133] (754s left) gem_madvise (dontneed-before-exec)
[266.847607] Starting subtest: dontneed-before-exec
[266.868351] Subtest dontneed-before-exec: SKIP (0.018s)
[266.922241] [084/133] (754s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[267.023611] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[267.027110] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[267.122886] [085/133] (754s left) syncobj_eventfd (invalid-bad-flags)
[267.171260] Starting subtest: invalid-bad-flags
[267.173459] Subtest invalid-bad-flags: SUCCESS (0.000s)
[267.274556] [086/133] (754s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[267.374913] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[274.479727] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.123s)
[274.590856] [087/133] (746s left) perf (i915-ref-count)
[274.653780] Starting subtest: i915-ref-count
[274.751077] Subtest i915-ref-count: SUCCESS (0.099s)
[274.816667] [088/133] (746s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[274.923409] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[275.735007] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.815s)
[275.921602] [089/133] (745s left) kms_vblank (wait-forked-hang)
[276.014755] Starting subtest: wait-forked-hang
[276.017110] Starting dynamic subtest: pipe-A-eDP-1
[302.894725] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.882s)
[302.911048] Starting dynamic subtest: pipe-D-eDP-1
[327.919685] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.027s)
[327.922475] Subtest wait-forked-hang: SUCCESS (51.913s)
[328.770614] [090/133] (692s left) gem_lmem_swapping (random-engines)
[328.818266] Subtest random-engines: SKIP (0.000s)
[328.869058] [091/133] (692s left) gem_exec_reloc (basic-gtt-read-noreloc)
[328.920453] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[328.990213] [092/133] (692s left) gem_exec_nop (basic-series)
[329.055008] Starting subtest: basic-series
[345.134486] Subtest basic-series: SUCCESS (16.092s)
[345.357681] [093/133] (676s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[345.464871] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[346.598936] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.134s)
[346.726182] [094/133] (674s left) i915_pm_rpm (gem-mmap-type)
[348.238936] Starting subtest: gem-mmap-type
[348.241385] Starting dynamic subtest: wb-smem0
[352.412345] Dynamic subtest wb-smem0: SUCCESS (4.168s)
[352.422307] Starting dynamic subtest: wc-smem0
[355.585867] Dynamic subtest wc-smem0: SUCCESS (3.172s)
[355.596247] Starting dynamic subtest: uc-smem0
[358.766270] Dynamic subtest uc-smem0: SUCCESS (3.177s)
[358.768576] Subtest gem-mmap-type: SUCCESS (10.521s)
[358.888244] [095/133] (662s left) gem_ctx_persistence (heartbeat-many)
[358.953957] Starting subtest: heartbeat-many
[358.958856] Subtest heartbeat-many: SKIP (0.000s)
[359.075959] [096/133] (662s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[359.163509] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[359.167976] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[359.272083] [097/133] (662s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[359.371212] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[359.375572] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[359.485780] [098/133] (662s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[359.588066] Starting subtest: plane-lut1d-post-ctm3x4
[359.755745] Starting dynamic subtest: pipe-A-plane-0
[359.922004] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s)
[359.930732] Starting dynamic subtest: pipe-A-plane-1
[360.133285] Dynamic subtest pipe-A-plane-1: SUCCESS (0.210s)
[360.142268] Starting dynamic subtest: pipe-A-plane-2
[360.277718] Dynamic subtest pipe-A-plane-2: SUCCESS (0.144s)
[361.418193] Starting dynamic subtest: pipe-B-plane-0
[361.554347] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s)
[361.563951] Starting dynamic subtest: pipe-B-plane-1
[361.688243] Dynamic subtest pipe-B-plane-1: SUCCESS (0.133s)
[361.698238] Starting dynamic subtest: pipe-B-plane-2
[361.832496] Dynamic subtest pipe-B-plane-2: SUCCESS (0.144s)
[363.075887] Starting dynamic subtest: pipe-C-plane-0
[363.198370] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[363.207977] Starting dynamic subtest: pipe-C-plane-1
[363.366053] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s)
[363.375938] Starting dynamic subtest: pipe-C-plane-2
[363.531886] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s)
[364.682768] Starting dynamic subtest: pipe-D-plane-0
[364.819192] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[364.829015] Starting dynamic subtest: pipe-D-plane-1
[364.963648] Dynamic subtest pipe-D-plane-1: SUCCESS (0.143s)
[364.973597] Starting dynamic subtest: pipe-D-plane-2
[365.096901] Dynamic subtest pipe-D-plane-2: SUCCESS (0.133s)
[365.381330] Subtest plane-lut1d-post-ctm3x4: SUCCESS (5.794s)
[366.252100] [099/133] (655s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[366.340874] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[373.193016] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.855s)
[373.304607] [100/133] (648s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[373.403177] Starting subtest: 4-tiled-32bpp-rotate-90
[373.422504] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.019s)
[373.524790] [101/133] (648s left) kms_cursor_crc (cursor-random-128x128)
[373.737920] Starting subtest: cursor-random-128x128
[373.743041] Starting dynamic subtest: pipe-A-eDP-1
[377.104410] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.360s)
[377.134502] Starting dynamic subtest: pipe-D-eDP-1
[381.125156] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.999s)
[381.127728] Subtest cursor-random-128x128: SUCCESS (7.387s)
[381.938478] [102/133] (640s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[382.041860] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[382.046307] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s)
[382.114424] [103/133] (639s left) gem_ppgtt (shrink-vs-evict-pinned)
[382.177955] Starting subtest: shrink-vs-evict-pinned
[389.170447] Subtest shrink-vs-evict-pinned: SUCCESS (6.939s)
[389.209248] [104/133] (632s left) syncobj_wait (invalid-signal-bad-pad)
[389.277521] Starting subtest: invalid-signal-bad-pad
[389.279981] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[389.386206] [105/133] (632s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[389.800706] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[390.653716] [106/133] (631s left) api_intel_bb (object-noreloc-keep-cache-simple)
[390.710462] Starting subtest: object-noreloc-keep-cache-simple
[390.714893] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.007s)
[390.804286] [107/133] (631s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[390.855887] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[390.956580] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.101s)
[391.050713] [108/133] (631s left) prime_mmap_coherency (write)
[391.105214] Starting subtest: write
[396.535618] Subtest write: SUCCESS (5.378s)
[396.615973] [109/133] (625s left) gem_exec_whisper (basic-fds)
[396.678186] Starting subtest: basic-fds
[405.472766] Subtest basic-fds: SUCCESS (8.792s)
[405.655073] [110/133] (616s left) api_intel_allocator (reloc-allocator)
[405.707648] Starting subtest: reloc-allocator
[405.709693] Starting dynamic subtest: basic
[405.712162] Dynamic subtest basic: SUCCESS (0.006s)
[405.724159] Starting dynamic subtest: parallel-one
[405.726063] Dynamic subtest parallel-one: SUCCESS (0.007s)
[405.735763] Starting dynamic subtest: print
[405.737932] Dynamic subtest print: SUCCESS (0.000s)
[405.751668] Starting dynamic subtest: reuse
[405.753980] Dynamic subtest reuse: SUCCESS (0.000s)
[405.762944] Starting dynamic subtest: fork-reopen-allocator
[405.765094] Dynamic subtest fork-reopen-allocator: SUCCESS (0.010s)
[405.767242] Subtest reloc-allocator: SUCCESS (0.027s)
[405.857620] [111/133] (616s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[405.950178] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[409.688423] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.742s)
[410.869560] [112/133] (611s left) gem_pxp (reject-modify-context-protection-off-3)
[410.995025] Starting subtest: reject-modify-context-protection-off-3
[410.997520] Subtest reject-modify-context-protection-off-3: SUCCESS (0.001s)
[411.117865] [113/133] (611s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[411.205628] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[411.208149] Starting dynamic subtest: pipe-A-eDP-1
[411.303906] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[411.315977] Starting dynamic subtest: pipe-B-eDP-1
[412.430425] Dynamic subtest pipe-B-eDP-1: SKIP (1.125s)
[412.435259] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.228s)
[413.609002] [114/133] (608s left) gem_softpin (allocator-evict)
[413.669635] Starting subtest: allocator-evict
[413.672021] Starting dynamic subtest: rcs0
[437.714425] Dynamic subtest rcs0: SUCCESS (24.049s)
[437.727896] Starting dynamic subtest: bcs0
[461.341180] Dynamic subtest bcs0: SUCCESS (23.629s)
[461.353870] Starting dynamic subtest: vcs0
[485.007924] Dynamic subtest vcs0: SUCCESS (23.666s)
[485.020477] Starting dynamic subtest: vcs1
[508.908958] Dynamic subtest vcs1: SUCCESS (23.893s)
[508.924237] Starting dynamic subtest: vecs0
[532.575763] Dynamic subtest vecs0: SUCCESS (23.661s)
[532.586145] Starting dynamic subtest: ccs0
[556.742622] Dynamic subtest ccs0: SUCCESS (24.165s)
[556.745661] Subtest allocator-evict: SUCCESS (143.072s)
[556.828765] [115/133] (465s left) kms_psr (fbc-pr-sprite-plane-move)
[556.970327] Starting subtest: fbc-pr-sprite-plane-move
[556.974964] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[557.047890] [116/133] (465s left) gem_ctx_shared (single-timeline)
[557.111414] Starting subtest: single-timeline
[557.131576] Subtest single-timeline: SUCCESS (0.014s)
[557.357314] [117/133] (465s left) gem_exec_suspend (basic-s3)
[557.412351] Starting subtest: basic-S3
[557.414706] Starting dynamic subtest: smem
[578.055735] Dynamic subtest smem: SUCCESS (6.751s)
[578.058205] Subtest basic-S3: SUCCESS (6.753s)
[578.256962] [118/133] (444s left) gem_exec_schedule (pi-distinct-iova)
[578.455004] Starting subtest: pi-distinct-iova
[578.457261] Starting dynamic subtest: rcs0
[578.535607] Dynamic subtest rcs0: SUCCESS (0.080s)
[578.548908] Starting dynamic subtest: vcs0
[578.619045] Dynamic subtest vcs0: SUCCESS (0.088s)
[578.629113] Starting dynamic subtest: vcs1
[578.696915] Dynamic subtest vcs1: SUCCESS (0.078s)
[578.710391] Starting dynamic subtest: vecs0
[578.776406] Dynamic subtest vecs0: SUCCESS (0.080s)
[578.790125] Starting dynamic subtest: ccs0
[578.878665] Dynamic subtest ccs0: SUCCESS (0.102s)
[578.881053] Subtest pi-distinct-iova: SUCCESS (0.434s)
[580.207821] [119/133] (442s left) gem_exec_fence (parallel)
[580.381296] Starting subtest: parallel
[580.383674] Starting dynamic subtest: rcs0
[582.508871] Dynamic subtest rcs0: SUCCESS (2.151s)
[582.519952] Starting dynamic subtest: bcs0
[584.643808] Dynamic subtest bcs0: SUCCESS (2.152s)
[584.653148] Starting dynamic subtest: vcs0
[586.784580] Dynamic subtest vcs0: SUCCESS (2.153s)
[586.796795] Starting dynamic subtest: vcs1
[588.929338] Dynamic subtest vcs1: SUCCESS (2.154s)
[588.940479] Starting dynamic subtest: vecs0
[591.072201] Dynamic subtest vecs0: SUCCESS (2.150s)
[591.082404] Starting dynamic subtest: ccs0
[593.216956] Dynamic subtest ccs0: SUCCESS (2.150s)
[593.219002] Subtest parallel: SUCCESS (12.916s)
[594.211021] [120/133] (428s left) kms_pm_dc (dc5-dpms-negative)
[595.310248] Starting subtest: dc5-dpms-negative
[595.314850] Subtest dc5-dpms-negative: SKIP (0.000s)
[595.382561] [121/133] (427s left) kms_prime (d3hot)
[595.463904] Subtest D3hot: SKIP (0.000s)
[595.556967] [122/133] (427s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[595.660528] Starting subtest: crc-primary-basic-y-tiled-ccs
[595.662763] Starting dynamic subtest: pipe-A-eDP-1
[595.685515] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[595.695464] Starting dynamic subtest: pipe-B-eDP-1
[595.716962] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[595.726379] Starting dynamic subtest: pipe-C-eDP-1
[595.747834] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[595.757303] Starting dynamic subtest: pipe-D-eDP-1
[595.779282] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[595.783279] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.006s)
[597.900123] [123/133] (424s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[598.004201] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[598.008305] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[598.102159] [124/133] (424s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[598.206704] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[598.210754] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[598.312615] [125/133] (424s left) kms_setmode (basic-clone-single-crtc)
[598.372907] Starting subtest: basic-clone-single-crtc
[598.379615] Subtest basic-clone-single-crtc: SKIP (0.000s)
[598.488616] [126/133] (424s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[598.539527] Starting subtest: multi-wait-all-for-submit-available-submitted
[598.541409] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[598.635219] [127/133] (424s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs)
[598.724259] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs
[598.728470] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s)
[599.819368] [128/133] (423s left) kms_dsc (dsc-basic)
[599.908491] Starting subtest: dsc-basic
[599.921697] Subtest dsc-basic: SKIP (0.000s)
[599.980742] [129/133] (423s left) sysfs_preempt_timeout (invalid)
[600.042509] Starting subtest: invalid
[600.044893] Starting dynamic subtest: vecs0
[600.047226] Dynamic subtest vecs0: SUCCESS (0.000s)
[600.058525] Starting dynamic subtest: ccs0
[600.060733] Dynamic subtest ccs0: SUCCESS (0.000s)
[600.070197] Starting dynamic subtest: vcs0
[600.072378] Dynamic subtest vcs0: SUCCESS (0.000s)
[600.081638] Starting dynamic subtest: bcs0
[600.083849] Dynamic subtest bcs0: SUCCESS (0.000s)
[600.093225] Starting dynamic subtest: rcs0
[600.095180] Dynamic subtest rcs0: SUCCESS (0.000s)
[600.104665] Starting dynamic subtest: vcs1
[600.106895] Dynamic subtest vcs1: SUCCESS (0.000s)
[600.109109] Subtest invalid: SUCCESS (0.005s)
[600.147392] [130/133] (423s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[600.245464] Starting subtest: invalid-modeset-force-ultra-joiner
[600.249834] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[600.311133] [131/133] (422s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[600.416366] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[600.426926] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.010s)
[600.518193] [132/133] (422s left) gem_exec_balancer (hang)
[600.777314] Starting subtest: hang
[602.441229] Subtest hang: SUCCESS (1.667s)
[602.551616] [133/133] (420s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[602.655063] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[602.659523] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[602.754562] Closing watchdogs
results: parsing output: 0/ for test: gen7_exec_parse
results: parsing output: 1/ for test: kms_psr2_sf
results: parsing output: 2/ for test: vgem_basic
results: parsing output: 3/ for test: gem_exec_reloc
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: kms_pipe_crc_basic
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: kms_flip_scaled_crc
results: parsing output: 9/ for test: gem_ringfill
results: parsing output: 10/ for test: gem_exec_schedule
results: parsing output: 11/ for test: gem_workarounds
results: parsing output: 12/ for test: kms_ccs
results: parsing output: 13/ for test: kms_properties
results: parsing output: 14/ for test: gem_exec_flush
results: parsing output: 15/ for test: kms_addfb_basic
results: parsing output: 16/ for test: gem_exec_whisper
results: parsing output: 17/ for test: gem_mmap_offset
results: parsing output: 18/ for test: gem_exec_reloc
results: parsing output: 19/ for test: kms_plane_scaling
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: core_setmaster
results: parsing output: 22/ for test: gem_exec_balancer
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: gem_partial_pwrite_pread
results: parsing output: 27/ for test: kms_cursor_crc
results: parsing output: 28/ for test: kms_rotation_crc
results: parsing output: 29/ for test: gem_wait
results: parsing output: 30/ for test: kms_rotation_crc
results: parsing output: 31/ for test: kms_psr
results: parsing output: 32/ for test: syncobj_timeline
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: syncobj_timeline
results: parsing output: 35/ for test: kms_getfb
results: parsing output: 36/ for test: kms_vrr
results: parsing output: 37/ for test: gem_ctx_persistence
results: parsing output: 38/ for test: i915_drm_fdinfo
results: parsing output: 39/ for test: kms_cdclk
results: parsing output: 40/ for test: kms_vblank
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: gem_userptr_blits
results: parsing output: 43/ for test: kms_joiner
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: sw_sync
results: parsing output: 47/ for test: kms_pipe_crc_basic
results: parsing output: 48/ for test: fbdev
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: kms_content_protection
results: parsing output: 52/ for test: intel_hwmon
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: kms_plane
results: parsing output: 56/ for test: kms_plane
results: parsing output: 57/ for test: kms_dirtyfb
results: parsing output: 58/ for test: gem_exec_reloc
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_cursor_legacy
results: parsing output: 61/ for test: kms_flip
results: parsing output: 62/ for test: kms_cursor_crc
results: parsing output: 63/ for test: i915_suspend
results: parsing output: 64/ for test: kms_plane_scaling
results: parsing output: 65/ for test: gem_ctx_param
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: gem_mmap_gtt
results: parsing output: 68/ for test: gem_partial_pwrite_pread
results: parsing output: 69/ for test: kms_async_flips
results: parsing output: 70/ for test: gem_workarounds
results: parsing output: 71/ for test: gem_cs_tlb
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: prime_busy
results: parsing output: 75/ for test: kms_selftest
results: parsing output: 76/ for test: perf_pmu
results: parsing output: 77/ for test: gem_readwrite
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: i915_drm_fdinfo
results: parsing output: 80/ for test: kms_chamelium_edid
results: parsing output: 81/ for test: gem_eio
results: parsing output: 82/ for test: gem_madvise
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: syncobj_eventfd
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: perf
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: kms_vblank
results: parsing output: 89/ for test: gem_lmem_swapping
results: parsing output: 90/ for test: gem_exec_reloc
results: parsing output: 91/ for test: gem_exec_nop
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: i915_pm_rpm
results: parsing output: 94/ for test: gem_ctx_persistence
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_color_pipeline
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_cursor_crc
results: parsing output: 101/ for test: kms_flip_scaled_crc
results: parsing output: 102/ for test: gem_ppgtt
results: parsing output: 103/ for test: syncobj_wait
results: parsing output: 104/ for test: kms_chamelium_hpd
results: parsing output: 105/ for test: api_intel_bb
results: parsing output: 106/ for test: syncobj_timeline
results: parsing output: 107/ for test: prime_mmap_coherency
results: parsing output: 108/ for test: gem_exec_whisper
results: parsing output: 109/ for test: api_intel_allocator
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: gem_pxp
results: parsing output: 112/ for test: kms_psr2_sf
results: parsing output: 113/ for test: gem_softpin
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: gem_ctx_shared
results: parsing output: 116/ for test: gem_exec_suspend
results: parsing output: 117/ for test: gem_exec_schedule
results: parsing output: 118/ for test: gem_exec_fence
results: parsing output: 119/ for test: kms_pm_dc
results: parsing output: 120/ for test: kms_prime
results: parsing output: 121/ for test: kms_ccs
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_setmode
results: parsing output: 125/ for test: syncobj_timeline
results: parsing output: 126/ for test: kms_ccs
results: parsing output: 127/ for test: kms_dsc
results: parsing output: 128/ for test: sysfs_preempt_timeout
results: parsing output: 129/ for test: kms_joiner
results: parsing output: 130/ for test: kms_flip
results: parsing output: 131/ for test: gem_exec_balancer
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.