[54.863514] Initializing watchdogs
[54.863647]   /dev/watchdog0
[54.877960] [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]
[54.882155] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[54.884262] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[54.887464] [001/131] (960s left) kms_psr (fbc-psr-cursor-plane-onoff)
[55.001308] Starting subtest: fbc-psr-cursor-plane-onoff
[55.003643] Starting dynamic subtest: eDP-1
[55.007989] Dynamic subtest eDP-1: SKIP (0.000s)
[55.012387] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s)
[55.070770] [002/131] (960s left) gem_readwrite (write-bad-handle)
[55.125368] Subtest write-bad-handle: SKIP (0.000s)
[55.180590] [003/131] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[55.285743] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[55.289860] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[55.383076] [004/131] (960s left) kms_cdclk (mode-transition)
[55.469854] Starting subtest: mode-transition
[55.472033] Starting dynamic subtest: pipe-A-eDP-1
[55.762239] Dynamic subtest pipe-A-eDP-1: SKIP (0.287s)
[55.771230] Starting dynamic subtest: pipe-B-eDP-1
[55.775904] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[55.783272] Starting dynamic subtest: pipe-C-eDP-1
[55.787981] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[55.794588] Starting dynamic subtest: pipe-D-eDP-1
[55.799096] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[55.803546] Subtest mode-transition: SKIP (0.292s)
[56.575991] [005/131] (958s left) gem_exec_reloc (basic-wc-cpu)
[56.646883] Subtest basic-wc-cpu: SKIP (0.000s)
[56.722754] [006/131] (958s left) kms_psr (psr-sprite-plane-move)
[56.814306] Starting subtest: psr-sprite-plane-move
[56.816621] Starting dynamic subtest: eDP-1
[58.619238] Dynamic subtest eDP-1: SUCCESS (1.799s)
[58.621644] Subtest psr-sprite-plane-move: SUCCESS (1.799s)
[59.426731] [007/131] (956s left) api_intel_allocator (fork-simple-stress-signal)
[59.486867] Starting subtest: fork-simple-stress-signal
[64.895673] Subtest fork-simple-stress-signal: SUCCESS (5.403s)
[65.016885] [008/131] (950s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[65.078984] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[65.183779] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.104s)
[65.259225] [009/131] (950s left) kms_joiner (invalid-modeset-big-joiner)
[65.373275] Starting subtest: invalid-modeset-big-joiner
[65.377733] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[65.438261] [010/131] (950s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[65.490847] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[65.493275] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[65.609980] [011/131] (950s left) syncobj_wait (wait-all-for-submit-snapshot)
[65.670919] Starting subtest: wait-all-for-submit-snapshot
[65.751562] Subtest wait-all-for-submit-snapshot: SUCCESS (0.081s)
[65.823886] [012/131] (949s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[65.927362] Starting subtest: y-tiled-8bpp-rotate-270
[65.931747] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[66.038868] [013/131] (949s left) gem_ctx_isolation (nonpriv-switch)
[66.107471] Starting subtest: nonpriv-switch
[66.109946] Starting dynamic subtest: rcs0
[66.674562] Dynamic subtest rcs0: SUCCESS (0.567s)
[66.683612] Starting dynamic subtest: bcs0
[67.287843] Dynamic subtest bcs0: SUCCESS (0.613s)
[67.294739] Starting dynamic subtest: vcs0
[67.898825] Dynamic subtest vcs0: SUCCESS (0.610s)
[67.909064] Starting dynamic subtest: vcs1
[69.471089] Dynamic subtest vcs1: SUCCESS (1.571s)
[69.481935] Starting dynamic subtest: vecs0
[71.663142] Dynamic subtest vecs0: SUCCESS (2.191s)
[71.674295] Starting dynamic subtest: ccs0
[73.579918] Dynamic subtest ccs0: SUCCESS (1.915s)
[73.582359] Subtest nonpriv-switch: SUCCESS (7.467s)
[73.827566] [014/131] (942s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[73.929112] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[73.931523] Starting dynamic subtest: pipe-A-eDP-1
[73.954889] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[73.964511] Starting dynamic subtest: pipe-B-eDP-1
[73.986452] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[73.992891] Starting dynamic subtest: pipe-C-eDP-1
[74.015049] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[74.021645] Starting dynamic subtest: pipe-D-eDP-1
[74.044162] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[74.048619] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.002s)
[76.186935] [015/131] (939s left) kms_psr (fbc-pr-cursor-plane-move)
[76.286335] Starting subtest: fbc-pr-cursor-plane-move
[76.290973] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[76.353276] [016/131] (939s left) kms_flip (bo-too-big)
[76.445761] Starting subtest: bo-too-big
[76.448065] Starting dynamic subtest: A-eDP1
[78.173283] Dynamic subtest A-eDP1: SUCCESS (1.727s)
[78.182183] Starting dynamic subtest: B-eDP1
[79.882587] Dynamic subtest B-eDP1: SUCCESS (1.708s)
[79.891493] Starting dynamic subtest: C-eDP1
[81.613533] Dynamic subtest C-eDP1: SUCCESS (1.730s)
[81.622181] Starting dynamic subtest: D-eDP1
[83.334224] Dynamic subtest D-eDP1: SUCCESS (1.719s)
[83.339362] Subtest bo-too-big: SUCCESS (6.891s)
[84.608704] [017/131] (931s left) gem_exec_balancer (bonded-pair)
[84.667319] Starting subtest: bonded-pair
[84.671912] Subtest bonded-pair: SKIP (0.000s)
[84.960778] [018/131] (931s left) gem_mmap_offset (open-flood)
[85.009629] Starting subtest: open-flood
[106.499347] Subtest open-flood: SUCCESS (21.489s)
[106.626130] [019/131] (909s left) gem_exec_schedule (semaphore-power)
[106.828051] Subtest semaphore-power: SKIP (0.000s)
[107.002356] [020/131] (909s left) kms_cursor_crc (cursor-random-max-size)
[107.299552] Starting subtest: cursor-random-max-size
[107.306348] Subtest cursor-random-max-size: SKIP (0.000s)
[107.440659] [021/131] (908s left) gem_sync (basic-each)
[107.514503] Starting subtest: basic-each
[110.001055] Subtest basic-each: SUCCESS (2.498s)
[110.181125] [022/131] (905s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[110.288828] Starting subtest: 4-tiled-16bpp-rotate-90
[110.311623] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.023s)
[110.454195] [023/131] (905s left) gem_exec_fence (invalid-timeline-fence-array)
[111.034733] Starting subtest: invalid-timeline-fence-array
[111.040285] Subtest invalid-timeline-fence-array: SUCCESS (0.005s)
[111.945587] [FACT gem_exec_fence (invalid-timeline-fence-array)] new: kernel.kmod_is_loaded.vgem: true
[111.948823] [024/131] (904s left) gem_userptr_blits (sd-probe)
[112.012897] Starting subtest: sd-probe
[112.015270] Subtest sd-probe: SUCCESS (0.000s)
[112.144425] [025/131] (904s left) kms_prop_blob (blob-prop-validate)
[112.195152] Starting subtest: blob-prop-validate
[112.197485] Subtest blob-prop-validate: SUCCESS (0.000s)
[112.308921] [026/131] (903s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[112.418702] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[112.422767] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[112.509767] [027/131] (903s left) kms_legacy_colorkey (invalid-plane)
[112.592953] Starting subtest: invalid-plane
[112.595349] Starting dynamic subtest: zero-id
[112.597249] Dynamic subtest zero-id: SUCCESS (0.000s)
[112.603826] Starting dynamic subtest: outrange-id
[112.605859] Dynamic subtest outrange-id: SUCCESS (0.000s)
[112.608188] Subtest invalid-plane: SUCCESS (0.000s)
[112.661463] [028/131] (903s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[112.767456] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[112.771663] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[112.881248] [029/131] (903s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[113.269067] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[114.115091] [030/131] (902s left) gem_exec_reloc (basic-softpin)
[114.179629] Subtest basic-softpin: SKIP (0.000s)
[114.266419] [031/131] (902s left) syncobj_timeline (etime-single-wait-all-submitted)
[114.320072] Starting subtest: etime-single-wait-all-submitted
[114.423197] Subtest etime-single-wait-all-submitted: SUCCESS (0.103s)
[114.495365] [032/131] (902s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[114.599251] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[114.601636] Starting dynamic subtest: pipe-A-default-mode
[114.890818] Dynamic subtest pipe-A-default-mode: SKIP (0.288s)
[114.895501] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.289s)
[115.756621] [033/131] (900s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[115.850066] Starting subtest: plane-downscale-factor-0-75-with-rotation
[115.852456] Starting dynamic subtest: pipe-A
[116.188905] Dynamic subtest pipe-A: SUCCESS (0.339s)
[116.197920] Starting dynamic subtest: pipe-B
[117.634221] Dynamic subtest pipe-B: SUCCESS (1.445s)
[117.643268] Starting dynamic subtest: pipe-C
[119.063373] Dynamic subtest pipe-C: SUCCESS (1.429s)
[119.072329] Starting dynamic subtest: pipe-D
[120.490614] Dynamic subtest pipe-D: SUCCESS (1.427s)
[120.493062] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.640s)
[121.658017] [034/131] (894s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[121.759399] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[121.769642] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.010s)
[121.842928] [035/131] (894s left) i915_drm_fdinfo (busy-idle)
[121.877465] Starting subtest: busy-idle
[121.879364] Starting dynamic subtest: rcs0
[121.928414] Dynamic subtest rcs0: SKIP (0.049s)
[121.936061] Starting dynamic subtest: bcs0
[121.939955] Dynamic subtest bcs0: SKIP (0.001s)
[121.947537] Starting dynamic subtest: vcs0
[121.951729] Dynamic subtest vcs0: SKIP (0.000s)
[121.958706] Starting dynamic subtest: vcs1
[121.962665] Dynamic subtest vcs1: SKIP (0.000s)
[121.969098] Starting dynamic subtest: vecs0
[121.973053] Dynamic subtest vecs0: SKIP (0.000s)
[121.980129] Starting dynamic subtest: ccs0
[121.984214] Dynamic subtest ccs0: SKIP (0.000s)
[121.988196] Subtest busy-idle: SKIP (0.054s)
[122.021513] [036/131] (894s left) kms_flip (2x-modeset-vs-vblank-race)
[122.110941] Starting subtest: 2x-modeset-vs-vblank-race
[122.121750] Subtest 2x-modeset-vs-vblank-race: SKIP (0.010s)
[122.196110] [037/131] (894s left) api_intel_allocator (reserve-simple)
[122.251797] Starting subtest: reserve-simple
[122.254289] Subtest reserve-simple: SUCCESS (0.003s)
[122.377228] [038/131] (894s left) gem_mmap_gtt (cpuset-big-copy-xy)
[122.436624] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[122.493718] [039/131] (894s left) syncobj_wait (wait-all-snapshot)
[122.543466] Starting subtest: wait-all-snapshot
[122.622946] Subtest wait-all-snapshot: SUCCESS (0.081s)
[122.697824] [040/131] (894s left) fbdev (write)
[122.737919] Starting subtest: write
[123.202986] Subtest write: SUCCESS (0.464s)
[123.265033] [041/131] (893s left) syncobj_timeline (multi-wait-for-submit-signaled)
[123.326948] Starting subtest: multi-wait-for-submit-signaled
[123.329332] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[123.428242] [042/131] (893s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[123.540482] Starting subtest: basic-flip-after-cursor-varying-size
[124.478964] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.939s)
[125.280365] [043/131] (891s left) kms_dp_link_training (uhbr-sst)
[125.382319] Starting subtest: uhbr-sst
[125.391286] Subtest uhbr-sst: SKIP (0.000s)
[125.453183] [044/131] (891s left) kms_psr (fbc-psr-sprite-render)
[125.537317] Starting subtest: fbc-psr-sprite-render
[125.539643] Starting dynamic subtest: eDP-1
[125.544084] Dynamic subtest eDP-1: SKIP (0.000s)
[125.548524] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[125.611887] [045/131] (891s left) gem_barrier_race (remote-request)
[125.672094] Starting subtest: remote-request
[125.673870] Starting dynamic subtest: rcs0
[130.833318] Dynamic subtest rcs0: SUCCESS (5.162s)
[130.835268] Subtest remote-request: SUCCESS (5.162s)
[130.973587] [046/131] (886s left) sysfs_defaults (readonly)
[131.026457] Starting subtest: readonly
[131.028384] Starting dynamic subtest: vecs0
[131.030336] Dynamic subtest vecs0: SUCCESS (0.000s)
[131.037456] Starting dynamic subtest: ccs0
[131.039062] Dynamic subtest ccs0: SUCCESS (0.000s)
[131.045580] Starting dynamic subtest: vcs0
[131.047225] Dynamic subtest vcs0: SUCCESS (0.000s)
[131.054028] Starting dynamic subtest: bcs0
[131.055695] Dynamic subtest bcs0: SUCCESS (0.000s)
[131.062113] Starting dynamic subtest: rcs0
[131.063673] Dynamic subtest rcs0: SUCCESS (0.000s)
[131.070146] Starting dynamic subtest: vcs1
[131.071772] Dynamic subtest vcs1: SUCCESS (0.000s)
[131.073336] Subtest readonly: SUCCESS (0.004s)
[131.169736] [047/131] (885s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[131.278318] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[132.514645] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.235s)
[132.635756] [048/131] (884s left) kms_cursor_crc (cursor-random-128x128)
[132.828510] Starting subtest: cursor-random-128x128
[132.833971] Starting dynamic subtest: pipe-A-eDP-1
[136.639608] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.806s)
[136.671910] Starting dynamic subtest: pipe-D-eDP-1
[141.253921] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.586s)
[141.256180] Subtest cursor-random-128x128: SUCCESS (8.423s)
[142.045198] [049/131] (875s left) perf (polling)
[142.127598] Starting subtest: polling
[142.129988] Starting dynamic subtest: 0-rcs0
[152.148750] Dynamic subtest 0-rcs0: SUCCESS (10.016s)
[152.156549] Starting dynamic subtest: 1-vcs0
[162.167262] Dynamic subtest 1-vcs0: SUCCESS (10.019s)
[162.169953] Subtest polling: SUCCESS (20.037s)
[162.212519] [050/131] (854s left) gem_exercise_blt (fast-copy)
[162.268132] Starting subtest: fast-copy
[162.270447] Starting dynamic subtest: linear-smem-smem
[162.299410] Dynamic subtest linear-smem-smem: SUCCESS (0.031s)
[162.308976] Starting dynamic subtest: xmajor-smem-smem
[162.321529] Dynamic subtest xmajor-smem-smem: SUCCESS (0.021s)
[162.329074] Starting dynamic subtest: tile4-smem-smem
[162.343456] Dynamic subtest tile4-smem-smem: SUCCESS (0.022s)
[162.351184] Starting dynamic subtest: tile64-smem-smem
[162.365511] Dynamic subtest tile64-smem-smem: SUCCESS (0.021s)
[162.367974] Subtest fast-copy: SUCCESS (0.097s)
[162.503219] [051/131] (854s left) kms_async_flips (async-flip-suspend-resume)
[162.599474] Starting subtest: async-flip-suspend-resume
[162.973736] Starting dynamic subtest: pipe-A-eDP-1
[180.299620] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.987s)
[180.676570] Starting dynamic subtest: pipe-B-eDP-1
[183.445574] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.758s)
[183.807385] Starting dynamic subtest: pipe-C-eDP-1
[186.580915] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.767s)
[186.961730] Starting dynamic subtest: pipe-D-eDP-1
[189.718173] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.758s)
[189.720411] Subtest async-flip-suspend-resume: SUCCESS (12.740s)
[190.907690] [052/131] (826s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[195.982981] Starting subtest: pr-primary-plane-update-sf-dmg-area
[195.987847] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.002s)
[196.820692] [053/131] (820s left) kms_pm_rpm (fences-dpms)
[198.352521] Starting subtest: fences-dpms
[198.357436] Subtest fences-dpms: SKIP (0.000s)
[199.059756] [054/131] (818s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[199.158312] Starting subtest: fbcpsr-modesetfrombusy
[205.391240] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.232s)
[205.551072] [055/131] (811s left) gem_pwrite (basic-self)
[205.607229] Subtest basic-self: SKIP (0.000s)
[205.675791] [056/131] (811s left) kms_getfb (getfb-addfb-different-handles)
[205.776291] Starting subtest: getfb-addfb-different-handles
[205.778231] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[205.874166] [057/131] (811s left) kms_cursor_legacy (torture-bo)
[205.983301] Starting subtest: torture-bo
[205.985249] Starting dynamic subtest: pipe-A
[211.685637] Dynamic subtest pipe-A: SUCCESS (5.695s)
[211.696047] Starting dynamic subtest: pipe-B
[217.869162] Dynamic subtest pipe-B: SUCCESS (6.185s)
[217.880001] Starting dynamic subtest: pipe-C
[223.512645] Dynamic subtest pipe-C: SUCCESS (5.641s)
[223.527267] Starting dynamic subtest: pipe-D
[230.220424] Dynamic subtest pipe-D: SUCCESS (6.704s)
[230.232675] Starting dynamic subtest: all-pipes
[236.662980] Dynamic subtest all-pipes: SUCCESS (6.441s)
[236.665533] Subtest torture-bo: SUCCESS (30.677s)
[236.816715] [058/131] (780s left) kms_setmode (invalid-clone-single-crtc)
[236.877405] Starting subtest: invalid-clone-single-crtc
[236.884135] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[236.985124] [059/131] (780s left) i915_pm_rpm (gem-execbuf)
[238.525525] Starting subtest: gem-execbuf
[238.528529] Starting dynamic subtest: smem0
[240.274445] Dynamic subtest smem0: SUCCESS (1.748s)
[240.276888] Subtest gem-execbuf: SUCCESS (1.749s)
[240.371874] [060/131] (777s left) gem_lmem_swapping (massive)
[240.412547] Subtest massive: SKIP (0.000s)
[240.457541] [061/131] (777s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[240.558246] Starting subtest: psr-rgb101010-draw-mmap-cpu
[247.485537] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (6.926s)
[247.605907] [062/131] (770s left) kms_lease (invalid-create-leases)
[247.704126] Starting subtest: invalid-create-leases
[247.709300] Subtest invalid-create-leases: SUCCESS (0.005s)
[247.822226] [063/131] (769s left) gen3_mixed_blits
[247.944837] [064/131] (769s left) syncobj_timeline (wait-all-delayed-signal)
[247.997461] Starting subtest: wait-all-delayed-signal
[248.100420] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[248.176403] [065/131] (769s left) kms_getfb (getfb2-accept-nv12)
[248.260956] Starting subtest: getfb2-accept-nv12
[248.263294] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[248.363885] [066/131] (769s left) prime_busy (before-wait)
[248.418686] Starting subtest: before-wait
[248.423505] Starting dynamic subtest: rcs0
[248.448399] Dynamic subtest rcs0: SUCCESS (0.027s)
[248.457060] Starting dynamic subtest: bcs0
[248.509380] Dynamic subtest bcs0: SUCCESS (0.060s)
[248.518331] Starting dynamic subtest: vcs0
[248.549843] Dynamic subtest vcs0: SUCCESS (0.040s)
[248.558506] Starting dynamic subtest: vcs1
[248.589860] Dynamic subtest vcs1: SUCCESS (0.039s)
[248.598713] Starting dynamic subtest: vecs0
[248.630201] Dynamic subtest vecs0: SUCCESS (0.040s)
[248.639243] Starting dynamic subtest: ccs0
[248.670991] Dynamic subtest ccs0: SUCCESS (0.040s)
[248.778916] Subtest before-wait: SUCCESS (0.358s)
[248.857244] [067/131] (769s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-gtt)
[248.951348] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-gtt
[248.955651] Subtest psr-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[249.049613] [068/131] (768s left) kms_chamelium_color (ctm-negative)
[249.144101] Subtest ctm-negative: SKIP (0.000s)
[249.189291] [069/131] (768s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[249.285958] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[256.009379] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.724s)
[256.120160] [070/131] (761s left) gem_wait (busy)
[256.180350] Starting subtest: busy
[256.182631] Starting dynamic subtest: all-engines
[258.263189] Dynamic subtest all-engines: SUCCESS (2.080s)
[258.274510] Starting dynamic subtest: rcs0
[258.807047] Dynamic subtest rcs0: SUCCESS (0.541s)
[258.818467] Starting dynamic subtest: bcs0
[259.346177] Dynamic subtest bcs0: SUCCESS (0.539s)
[259.355884] Starting dynamic subtest: vcs0
[261.269859] Dynamic subtest vcs0: SUCCESS (1.921s)
[261.281480] Starting dynamic subtest: vcs1
[263.253516] Dynamic subtest vcs1: SUCCESS (1.981s)
[263.264792] Starting dynamic subtest: vecs0
[265.238326] Dynamic subtest vecs0: SUCCESS (1.982s)
[265.250588] Starting dynamic subtest: ccs0
[265.780374] Dynamic subtest ccs0: SUCCESS (0.541s)
[265.782851] Subtest busy: SUCCESS (9.597s)
[265.975838] [071/131] (752s left) gem_exec_schedule (thriceslice)
[266.052019] Starting subtest: thriceslice
[266.054072] Starting dynamic subtest: rcs0
[266.102978] Dynamic subtest rcs0: SUCCESS (0.057s)
[266.114549] Starting dynamic subtest: bcs0
[266.158378] Dynamic subtest bcs0: SUCCESS (0.054s)
[266.169864] Starting dynamic subtest: vcs0
[266.213988] Dynamic subtest vcs0: SUCCESS (0.054s)
[266.222373] Starting dynamic subtest: vcs1
[266.270040] Dynamic subtest vcs1: SUCCESS (0.053s)
[266.278561] Starting dynamic subtest: vecs0
[266.301271] Dynamic subtest vecs0: SUCCESS (0.030s)
[266.311244] Starting dynamic subtest: ccs0
[266.359794] Dynamic subtest ccs0: SUCCESS (0.058s)
[266.362112] Subtest thriceslice: SUCCESS (0.316s)
[266.658385] [072/131] (751s left) perf (short-reads)
[266.734701] Starting subtest: short-reads
[266.752652] Subtest short-reads: SUCCESS (0.020s)
[266.802701] [073/131] (751s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[266.913175] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[266.917274] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[267.017448] [074/131] (751s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[267.128372] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[273.506464] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.380s)
[273.640345] [075/131] (744s left) gem_softpin (evict-active)
[273.708108] Starting subtest: evict-active
[273.713615] Subtest evict-active: SUCCESS (0.006s)
[273.849153] [076/131] (744s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[278.846408] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[278.851238] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.002s)
[279.705809] [077/131] (738s left) gem_sync (basic-store-each)
[279.783725] Starting subtest: basic-store-each
[282.166013] Subtest basic-store-each: SUCCESS (2.394s)
[282.351820] [078/131] (735s left) gem_userptr_blits (stress-mm-invalidate-close)
[282.420076] Starting subtest: stress-mm-invalidate-close
[284.566472] Subtest stress-mm-invalidate-close: SUCCESS (2.148s)
[284.715935] [079/131] (733s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[284.811851] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[284.814177] Starting dynamic subtest: pipe-A-eDP-1
[285.687313] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.863s)
[285.698061] Starting dynamic subtest: pipe-B-eDP-1
[287.272913] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.588s)
[287.282475] Starting dynamic subtest: pipe-C-eDP-1
[288.801608] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.527s)
[288.811855] Starting dynamic subtest: pipe-D-eDP-1
[290.232632] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.428s)
[290.235048] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.411s)
[291.398780] [080/131] (726s left) gem_ctx_shared (q-smoketest)
[291.465582] Starting subtest: Q-smoketest
[291.468039] Starting dynamic subtest: rcs0
[297.013034] Dynamic subtest rcs0: SUCCESS (5.496s)
[297.022591] Starting dynamic subtest: bcs0
[302.518009] Dynamic subtest bcs0: SUCCESS (5.503s)
[302.528233] Starting dynamic subtest: vcs0
[308.006933] Dynamic subtest vcs0: SUCCESS (5.492s)
[308.021540] Starting dynamic subtest: vcs1
[313.489077] Dynamic subtest vcs1: SUCCESS (5.477s)
[313.499128] Starting dynamic subtest: vecs0
[318.966168] Dynamic subtest vecs0: SUCCESS (5.475s)
[318.977507] Starting dynamic subtest: ccs0
[324.461203] Dynamic subtest ccs0: SUCCESS (5.496s)
[324.463529] Subtest Q-smoketest: SUCCESS (32.945s)
[324.598593] [081/131] (693s left) kms_pm_dc (dc5-dpms-negative)
[325.709971] Starting subtest: dc5-dpms-negative
[325.714517] Subtest dc5-dpms-negative: SKIP (0.000s)
[325.778159] [082/131] (692s left) vgem_basic (mmap)
[325.817555] Starting subtest: mmap
[325.834019] Subtest mmap: SUCCESS (0.023s)
[325.893956] [083/131] (692s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[326.002671] Starting subtest: extended-modeset-hang-newfb-with-reset
[326.005032] Starting dynamic subtest: pipe-A
[341.131509] Dynamic subtest pipe-A: SUCCESS (15.125s)
[341.142551] Starting dynamic subtest: pipe-D
[356.999673] Dynamic subtest pipe-D: SUCCESS (15.862s)
[357.002173] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (30.992s)
[357.805508] [084/131] (660s left) kms_plane_multiple (2x-tiling-none)
[357.907549] Starting subtest: 2x-tiling-none
[357.912127] Subtest 2x-tiling-none: SKIP (0.000s)
[357.984229] [085/131] (660s left) kms_frontbuffer_tracking (psr-1p-rte)
[358.086634] Starting subtest: psr-1p-rte
[363.434233] Subtest psr-1p-rte: SUCCESS (5.349s)
[363.601747] [086/131] (655s left) gem_exec_balancer (semaphore)
[363.662078] Starting subtest: semaphore
[365.287516] Subtest semaphore: SUCCESS (1.623s)
[365.612731] [087/131] (653s left) kms_sequence (get-idle)
[365.709510] Starting subtest: get-idle
[365.711823] Starting dynamic subtest: pipe-A-eDP-1
[367.522230] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.811s)
[367.533805] Starting dynamic subtest: pipe-B-eDP-1
[369.941037] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.415s)
[369.950857] Starting dynamic subtest: pipe-C-eDP-1
[372.365618] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.421s)
[372.375442] Starting dynamic subtest: pipe-D-eDP-1
[374.790514] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.425s)
[374.792963] Subtest get-idle: SUCCESS (9.078s)
[375.588635] [088/131] (643s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[375.714046] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[375.718580] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[375.857504] [089/131] (642s left) gem_exec_suspend (basic-s4-devices)
[375.922743] Starting subtest: basic-S4-devices
[375.925102] Starting dynamic subtest: smem
[387.225046] Dynamic subtest smem: SUCCESS (11.296s)
[387.227645] Subtest basic-S4-devices: SUCCESS (11.298s)
[393.422460] [090/131] (631s left) syncobj_basic (bad-pad-fd-to-handle)
[393.487470] Starting subtest: bad-pad-fd-to-handle
[393.489684] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[393.610337] [091/131] (631s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[393.710363] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[398.158999] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.453s)
[399.275972] [092/131] (625s left) gem_ctx_persistence (heartbeat-hostile)
[399.344806] Starting subtest: heartbeat-hostile
[399.349615] Subtest heartbeat-hostile: SKIP (0.000s)
[399.460098] [093/131] (625s left) gem_tiled_swapping (non-threaded)
[399.526792] Subtest non-threaded: SKIP (0.000s)
[399.588521] [094/131] (625s left) kms_busy (extended-pageflip-hang-oldfb)
[399.686970] Starting subtest: extended-pageflip-hang-oldfb
[399.689333] Starting dynamic subtest: pipe-A
[400.125609] Dynamic subtest pipe-A: SUCCESS (0.437s)
[400.136070] Starting dynamic subtest: pipe-D
[401.280575] Dynamic subtest pipe-D: SUCCESS (1.152s)
[401.283002] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.593s)
[402.106811] [095/131] (622s left) gem_eio (in-flight-immediate)
[402.345918] Starting subtest: in-flight-immediate
[411.225537] Subtest in-flight-immediate: SUCCESS (8.879s)
[411.397741] [096/131] (613s left) kms_frontbuffer_tracking (fbc-stridechange)
[411.500202] Starting subtest: fbc-stridechange
[414.853274] Subtest fbc-stridechange: SUCCESS (3.357s)
[415.982676] [097/131] (609s left) kms_addfb_basic (invalid-get-prop-any)
[416.033385] Starting subtest: invalid-get-prop-any
[416.035659] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[416.159621] [098/131] (608s left) i915_selftest (live)
[419.591674] Starting subtest: live
[419.593935] Starting dynamic subtest: sanitycheck
[423.920738] Dynamic subtest sanitycheck: SUCCESS (4.328s)
[423.931082] Starting dynamic subtest: uncore
[428.310061] Dynamic subtest uncore: SUCCESS (4.387s)
[428.319608] Starting dynamic subtest: workarounds
[431.606748] Dynamic subtest workarounds: SUCCESS (3.295s)
[431.621972] Starting dynamic subtest: gt_engines
[436.300946] Dynamic subtest gt_engines: SUCCESS (4.692s)
[436.316093] Starting dynamic subtest: gt_timelines
[451.822591] Dynamic subtest gt_timelines: SUCCESS (15.517s)
[451.833016] Starting dynamic subtest: gt_contexts
[456.238418] Dynamic subtest gt_contexts: SUCCESS (4.413s)
[456.248985] Starting dynamic subtest: gt_lrc
[462.536600] Dynamic subtest gt_lrc: SUCCESS (6.296s)
[462.546478] Starting dynamic subtest: gt_mocs
[465.630812] Dynamic subtest gt_mocs: SUCCESS (3.089s)
[465.640844] Starting dynamic subtest: gt_pm
[470.536217] Dynamic subtest gt_pm: SUCCESS (4.906s)
[470.544530] Starting dynamic subtest: gt_heartbeat
[474.899067] Dynamic subtest gt_heartbeat: SUCCESS (4.360s)
[474.909006] Starting dynamic subtest: gt_tlb
[484.313717] Dynamic subtest gt_tlb: SUCCESS (9.411s)
[484.324114] Starting dynamic subtest: requests
[497.966348] Dynamic subtest requests: SUCCESS (13.648s)
[497.976507] Starting dynamic subtest: migrate
[506.198172] Dynamic subtest migrate: SUCCESS (8.229s)
[506.208336] Starting dynamic subtest: active
[510.580489] Dynamic subtest active: SUCCESS (4.367s)
[510.591056] Starting dynamic subtest: objects
[515.361319] Dynamic subtest objects: SUCCESS (4.791s)
[515.371881] Starting dynamic subtest: mman
[520.399804] Dynamic subtest mman: SUCCESS (5.035s)
[520.409843] Starting dynamic subtest: dmabuf
[524.900048] Dynamic subtest dmabuf: SUCCESS (4.498s)
[524.910141] Starting dynamic subtest: vma
[529.319164] Dynamic subtest vma: SUCCESS (4.416s)
[529.329354] Starting dynamic subtest: coherency
[534.466297] Dynamic subtest coherency: SUCCESS (5.144s)
[534.476811] Starting dynamic subtest: gtt
[546.283811] Dynamic subtest gtt: SUCCESS (11.813s)
[546.293853] Starting dynamic subtest: gem
[554.147287] Dynamic subtest gem: SUCCESS (7.862s)
[554.157228] Starting dynamic subtest: evict
[559.694627] Dynamic subtest evict: SUCCESS (5.544s)
[559.704923] Starting dynamic subtest: hugepages
[570.824106] Dynamic subtest hugepages: SUCCESS (11.126s)
[570.831226] Starting dynamic subtest: gem_contexts
[597.923155] Dynamic subtest gem_contexts: SUCCESS (27.092s)
[597.933025] Starting dynamic subtest: client
[602.345496] Dynamic subtest client: SUCCESS (4.420s)
[602.357619] Starting dynamic subtest: gem_migrate
[606.806630] Dynamic subtest gem_migrate: SUCCESS (4.459s)
[606.816331] Starting dynamic subtest: reset
[609.652202] Dynamic subtest reset: SUCCESS (2.842s)
[609.662539] Starting dynamic subtest: memory_region
[612.403460] Dynamic subtest memory_region: SUCCESS (2.749s)
[612.413258] Starting dynamic subtest: hangcheck
[625.607727] Dynamic subtest hangcheck: SUCCESS (13.199s)
[625.620788] Starting dynamic subtest: execlists
[630.064414] Dynamic subtest execlists: SUCCESS (4.453s)
[630.077059] Starting dynamic subtest: ring_submission
[634.411203] Dynamic subtest ring_submission: SUCCESS (4.344s)
[634.421376] Starting dynamic subtest: perf
[638.791826] Dynamic subtest perf: SUCCESS (4.378s)
[638.802093] Starting dynamic subtest: slpc
[652.948698] Dynamic subtest slpc: SUCCESS (14.153s)
[652.958264] Starting dynamic subtest: guc
[656.941810] Dynamic subtest guc: SUCCESS (3.990s)
[656.952003] Starting dynamic subtest: guc_multi_lrc
[659.750350] Dynamic subtest guc_multi_lrc: SUCCESS (2.806s)
[659.760793] Starting dynamic subtest: guc_hang
[664.777062] Dynamic subtest guc_hang: SUCCESS (5.023s)
[664.787805] Starting dynamic subtest: late_gt_pm
[669.227344] Dynamic subtest late_gt_pm: SUCCESS (4.447s)
[669.229989] Subtest live: SUCCESS (249.585s)
[669.260246] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[669.260927] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[669.264120] [099/131] (355s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[670.727196] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[670.731281] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[670.802377] [FACT kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[670.803612] [FACT kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)] new: kernel.kmod_is_loaded.i915: true
[670.807272] [100/131] (354s left) gem_exec_reloc (basic-concurrent0)
[670.877338] Subtest basic-concurrent0: SKIP (0.000s)
[670.952510] [101/131] (354s left) kms_flip (flip-vs-panning-vs-hang)
[671.049925] Starting subtest: flip-vs-panning-vs-hang
[671.052290] Starting dynamic subtest: A-eDP1
[710.716036] Dynamic subtest A-eDP1: SUCCESS (39.656s)
[710.725065] Starting dynamic subtest: D-eDP1
[750.718506] Dynamic subtest D-eDP1: SUCCESS (39.992s)
[750.721131] Subtest flip-vs-panning-vs-hang: SUCCESS (79.651s)
[751.856974] [102/131] (273s left) perf (sysctl-defaults)
[751.916955] Starting subtest: sysctl-defaults
[751.919334] Subtest sysctl-defaults: SUCCESS (0.000s)
[751.998797] [103/131] (273s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[752.090625] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[752.094988] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[752.213154] [104/131] (273s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[752.318035] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[752.322025] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[752.415012] [105/131] (272s left) kms_universal_plane (universal-plane-functional)
[752.506557] Starting subtest: universal-plane-functional
[752.511521] Starting dynamic subtest: pipe-A-eDP-1
[756.489726] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.978s)
[756.499179] Starting dynamic subtest: pipe-B-eDP-1
[760.999659] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.506s)
[761.008543] Starting dynamic subtest: pipe-C-eDP-1
[765.235215] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.233s)
[765.244843] Starting dynamic subtest: pipe-D-eDP-1
[769.497432] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.261s)
[769.499829] Subtest universal-plane-functional: SUCCESS (16.986s)
[770.286353] [106/131] (255s left) i915_drm_fdinfo (virtual-busy)
[770.328406] Starting subtest: virtual-busy
[770.332431] Subtest virtual-busy: SKIP (0.000s)
[770.399821] [107/131] (255s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-gtt)
[770.511058] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-gtt
[770.515462] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[770.601624] [108/131] (254s left) perf_pmu (init-busy)
[770.641244] Starting subtest: init-busy
[770.643616] Starting dynamic subtest: rcs0
[770.646003] Dynamic subtest rcs0: SUCCESS (0.001s)
[770.656301] Starting dynamic subtest: bcs0
[770.658163] Dynamic subtest bcs0: SUCCESS (0.001s)
[770.666397] Starting dynamic subtest: vcs0
[770.668301] Dynamic subtest vcs0: SUCCESS (0.001s)
[770.676454] Starting dynamic subtest: vcs1
[770.678329] Dynamic subtest vcs1: SUCCESS (0.001s)
[770.686509] Starting dynamic subtest: vecs0
[770.688447] Dynamic subtest vecs0: SUCCESS (0.000s)
[770.696455] Starting dynamic subtest: ccs0
[770.698368] Dynamic subtest ccs0: SUCCESS (0.000s)
[770.700286] Subtest init-busy: SUCCESS (0.009s)
[770.779267] [109/131] (254s left) core_hotunplug (unbind-rebind)
[770.861803] Starting subtest: unbind-rebind
[776.953442] Subtest unbind-rebind: SUCCESS (6.092s)
[776.989875] [110/131] (248s left) perf_pmu (busy)
[777.028605] Starting subtest: busy
[777.031149] Starting dynamic subtest: rcs0
[778.781029] Dynamic subtest rcs0: SUCCESS (1.755s)
[778.791440] Starting dynamic subtest: bcs0
[779.349124] Dynamic subtest bcs0: SUCCESS (0.566s)
[779.361435] Starting dynamic subtest: vcs0
[781.270685] Dynamic subtest vcs0: SUCCESS (1.918s)
[781.282870] Starting dynamic subtest: vcs1
[783.256863] Dynamic subtest vcs1: SUCCESS (1.983s)
[783.269248] Starting dynamic subtest: vecs0
[785.239036] Dynamic subtest vecs0: SUCCESS (1.979s)
[785.249435] Starting dynamic subtest: ccs0
[785.811260] Dynamic subtest ccs0: SUCCESS (0.572s)
[785.813818] Subtest busy: SUCCESS (8.784s)
[785.929913] [111/131] (239s left) kms_psr (psr2-no-drrs)
[786.031056] Starting subtest: psr2-no-drrs
[786.033431] Starting dynamic subtest: eDP-1
[787.687587] Dynamic subtest eDP-1: SUCCESS (1.658s)
[787.689968] Subtest psr2-no-drrs: SUCCESS (1.659s)
[788.491787] [112/131] (237s left) gem_exec_reloc (basic-cpu-wc-active)
[788.552347] Subtest basic-cpu-wc-active: SKIP (0.000s)
[788.626957] [113/131] (237s left) kms_content_protection (uevent)
[788.785023] Starting subtest: uevent
[792.100582] Subtest uevent: SKIP (3.312s)
[793.276262] [114/131] (232s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[793.336431] Starting subtest: yf-tiled-ccs-to-x-tiled
[793.341053] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[793.517564] [115/131] (232s left) gem_exec_fence (syncobj-invalid-wait)
[793.931637] Starting subtest: syncobj-invalid-wait
[793.934234] Subtest syncobj-invalid-wait: SUCCESS (0.000s)
[795.306620] [116/131] (230s left) i915_pm_rps (reset)
[795.369166] Starting subtest: reset
[795.454427] Subtest reset: FAIL (0.027s)
[795.529622] [117/131] (230s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[795.579421] Starting subtest: multi-wait-all-for-submit-signaled
[795.581808] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[795.681498] [118/131] (230s left) kms_chamelium_frames (hdmi-frame-dump)
[796.058953] Subtest hdmi-frame-dump: SKIP (0.000s)
[796.881874] [119/131] (229s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[796.988084] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[798.155816] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.167s)
[798.318395] [120/131] (227s left) gem_exec_nop (basic-parallel)
[798.396502] Starting subtest: basic-parallel
[814.233962] Subtest basic-parallel: SUCCESS (15.844s)
[814.462329] [121/131] (211s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[814.560645] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[814.563014] Starting dynamic subtest: pipe-A-eDP-1
[814.572122] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[814.582350] Starting dynamic subtest: pipe-B-eDP-1
[814.591610] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[814.600754] Starting dynamic subtest: pipe-C-eDP-1
[814.609423] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[814.618586] Starting dynamic subtest: pipe-D-eDP-1
[814.627179] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[814.631319] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[816.756854] [122/131] (209s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[816.866099] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[823.102453] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.238s)
[824.258920] [123/131] (201s left) kms_big_fb (linear-8bpp-rotate-90)
[824.367976] Starting subtest: linear-8bpp-rotate-90
[824.388747] Subtest linear-8bpp-rotate-90: SKIP (0.020s)
[824.525867] [124/131] (201s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[824.580113] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[824.584382] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[824.759788] [125/131] (201s left) kms_dsc (dsc-with-output-formats-with-bpc)
[824.844044] Starting subtest: dsc-with-output-formats-with-bpc
[824.902555] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s)
[824.945530] [126/131] (201s left) kms_vrr (lobf)
[825.046846] Starting subtest: lobf
[825.051133] Subtest lobf: SKIP (0.000s)
[825.117228] [127/131] (201s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[825.216730] Starting subtest: plane-primary-toggle-with-vblank-wait
[825.219127] Starting dynamic subtest: pipe-A-eDP-1
[825.400380] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.183s)
[825.716576] Starting dynamic subtest: pipe-B-eDP-1
[826.653992] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.946s)
[826.950214] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.732s)
[827.801683] [128/131] (198s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[827.854580] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[827.856923] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[827.948160] [129/131] (198s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[828.042151] Starting subtest: yf-tiled-32bpp-rotate-90
[828.046556] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[828.140050] [130/131] (198s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[828.236695] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[828.240673] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[828.339409] [131/131] (198s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[828.440622] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[835.349433] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (6.909s)
[835.471105] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: gem_readwrite
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_cdclk
results: parsing output: 4/ for test: gem_exec_reloc
results: parsing output: 5/ for test: kms_psr
results: parsing output: 6/ for test: api_intel_allocator
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: kms_joiner
results: parsing output: 9/ for test: syncobj_wait
results: parsing output: 10/ for test: syncobj_wait
results: parsing output: 11/ for test: kms_big_fb
results: parsing output: 12/ for test: gem_ctx_isolation
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: kms_flip
results: parsing output: 16/ for test: gem_exec_balancer
results: parsing output: 17/ for test: gem_mmap_offset
results: parsing output: 18/ for test: gem_exec_schedule
results: parsing output: 19/ for test: kms_cursor_crc
results: parsing output: 20/ for test: gem_sync
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: gem_exec_fence
results: parsing output: 23/ for test: gem_userptr_blits
results: parsing output: 24/ for test: kms_prop_blob
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_legacy_colorkey
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_chamelium_hpd
results: parsing output: 29/ for test: gem_exec_reloc
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: kms_flip_scaled_crc
results: parsing output: 32/ for test: kms_plane_scaling
results: parsing output: 33/ for test: kms_flip
results: parsing output: 34/ for test: i915_drm_fdinfo
results: parsing output: 35/ for test: kms_flip
results: parsing output: 36/ for test: api_intel_allocator
results: parsing output: 37/ for test: gem_mmap_gtt
results: parsing output: 38/ for test: syncobj_wait
results: parsing output: 39/ for test: fbdev
results: parsing output: 40/ for test: syncobj_timeline
results: parsing output: 41/ for test: kms_cursor_legacy
results: parsing output: 42/ for test: kms_dp_link_training
results: parsing output: 43/ for test: kms_psr
results: parsing output: 44/ for test: gem_barrier_race
results: parsing output: 45/ for test: sysfs_defaults
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: kms_cursor_crc
results: parsing output: 48/ for test: perf
results: parsing output: 49/ for test: gem_exercise_blt
results: parsing output: 50/ for test: kms_async_flips
results: parsing output: 51/ for test: kms_psr2_sf
results: parsing output: 52/ for test: kms_pm_rpm
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_pwrite
results: parsing output: 55/ for test: kms_getfb
results: parsing output: 56/ for test: kms_cursor_legacy
results: parsing output: 57/ for test: kms_setmode
results: parsing output: 58/ for test: i915_pm_rpm
results: parsing output: 59/ for test: gem_lmem_swapping
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_lease
results: parsing output: 62/ for test: gen3_mixed_blits
results: parsing output: 63/ for test: syncobj_timeline
results: parsing output: 64/ for test: kms_getfb
results: parsing output: 65/ for test: prime_busy
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_chamelium_color
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: gem_wait
results: parsing output: 70/ for test: gem_exec_schedule
results: parsing output: 71/ for test: perf
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_softpin
results: parsing output: 75/ for test: kms_psr2_sf
results: parsing output: 76/ for test: gem_sync
results: parsing output: 77/ for test: gem_userptr_blits
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: gem_ctx_shared
results: parsing output: 80/ for test: kms_pm_dc
results: parsing output: 81/ for test: vgem_basic
results: parsing output: 82/ for test: kms_busy
results: parsing output: 83/ for test: kms_plane_multiple
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: gem_exec_balancer
results: parsing output: 86/ for test: kms_sequence
results: parsing output: 87/ for test: kms_cursor_legacy
results: parsing output: 88/ for test: gem_exec_suspend
results: parsing output: 89/ for test: syncobj_basic
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_ctx_persistence
results: parsing output: 92/ for test: gem_tiled_swapping
results: parsing output: 93/ for test: kms_busy
results: parsing output: 94/ for test: gem_eio
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_addfb_basic
results: parsing output: 97/ for test: i915_selftest
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: gem_exec_reloc
results: parsing output: 100/ for test: kms_flip
results: parsing output: 101/ for test: perf
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_universal_plane
results: parsing output: 105/ for test: i915_drm_fdinfo
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: perf_pmu
results: parsing output: 108/ for test: core_hotunplug
results: parsing output: 109/ for test: perf_pmu
results: parsing output: 110/ for test: kms_psr
results: parsing output: 111/ for test: gem_exec_reloc
results: parsing output: 112/ for test: kms_content_protection
results: parsing output: 113/ for test: gem_render_copy
results: parsing output: 114/ for test: gem_exec_fence
results: parsing output: 115/ for test: i915_pm_rps
results: parsing output: 116/ for test: syncobj_timeline
results: parsing output: 117/ for test: kms_chamelium_frames
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: gem_exec_nop
results: parsing output: 120/ for test: kms_ccs
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: gem_render_copy
results: parsing output: 124/ for test: kms_dsc
results: parsing output: 125/ for test: kms_vrr
results: parsing output: 126/ for test: kms_atomic_transition
results: parsing output: 127/ for test: syncobj_wait
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_frontbuffer_tracking
Done.