[54.616695] Initializing watchdogs
[54.616833]   /dev/watchdog0
[54.632478] [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.636988] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[54.639529] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[54.643061] [001/131] (960s left) kms_psr (fbc-psr-cursor-plane-onoff)
[54.764704] Starting subtest: fbc-psr-cursor-plane-onoff
[54.767239] Starting dynamic subtest: eDP-1
[54.772055] Dynamic subtest eDP-1: SKIP (0.000s)
[54.776367] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s)
[54.839074] [002/131] (960s left) gem_readwrite (write-bad-handle)
[54.898414] Subtest write-bad-handle: SKIP (0.000s)
[54.976118] [003/131] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[55.072997] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[55.077711] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[55.177331] [004/131] (960s left) kms_cdclk (mode-transition)
[55.270829] Starting subtest: mode-transition
[55.273043] Starting dynamic subtest: pipe-A-eDP-1
[55.568921] Dynamic subtest pipe-A-eDP-1: SKIP (0.288s)
[55.576058] Starting dynamic subtest: pipe-B-eDP-1
[55.581021] Dynamic subtest pipe-B-eDP-1: SKIP (0.002s)
[55.588521] Starting dynamic subtest: pipe-C-eDP-1
[55.593286] Dynamic subtest pipe-C-eDP-1: SKIP (0.002s)
[55.601003] Starting dynamic subtest: pipe-D-eDP-1
[55.605260] Dynamic subtest pipe-D-eDP-1: SKIP (0.003s)
[55.609339] Subtest mode-transition: SKIP (0.296s)
[56.441765] [005/131] (958s left) gem_exec_reloc (basic-wc-cpu)
[56.516257] Subtest basic-wc-cpu: SKIP (0.000s)
[56.598029] [006/131] (958s left) kms_psr (psr-sprite-plane-move)
[56.695295] Starting subtest: psr-sprite-plane-move
[56.697637] Starting dynamic subtest: eDP-1
[58.495447] Dynamic subtest eDP-1: SUCCESS (1.780s)
[58.497957] Subtest psr-sprite-plane-move: SUCCESS (1.780s)
[59.321483] [007/131] (956s left) api_intel_allocator (fork-simple-stress-signal)
[59.374216] Starting subtest: fork-simple-stress-signal
[64.806521] Subtest fork-simple-stress-signal: SUCCESS (5.404s)
[64.932221] [008/131] (950s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[64.989260] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[65.097383] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.107s)
[65.170125] [009/131] (950s left) kms_joiner (invalid-modeset-big-joiner)
[65.275337] Starting subtest: invalid-modeset-big-joiner
[65.279940] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[65.339090] [010/131] (950s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[65.395171] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[65.397675] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[65.511253] [011/131] (950s left) syncobj_wait (wait-all-for-submit-snapshot)
[65.570922] Starting subtest: wait-all-for-submit-snapshot
[65.651664] Subtest wait-all-for-submit-snapshot: SUCCESS (0.081s)
[65.723230] [012/131] (949s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[65.826958] Starting subtest: y-tiled-8bpp-rotate-270
[65.831051] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[65.944738] [013/131] (949s left) gem_ctx_isolation (nonpriv-switch)
[66.008496] Starting subtest: nonpriv-switch
[66.011314] Starting dynamic subtest: rcs0
[66.609467] Dynamic subtest rcs0: SUCCESS (0.599s)
[66.618899] Starting dynamic subtest: bcs0
[67.252068] Dynamic subtest bcs0: SUCCESS (0.641s)
[67.261691] Starting dynamic subtest: vcs0
[67.881985] Dynamic subtest vcs0: SUCCESS (0.628s)
[67.891398] Starting dynamic subtest: vcs1
[69.551797] Dynamic subtest vcs1: SUCCESS (1.666s)
[69.561863] Starting dynamic subtest: vecs0
[71.700506] Dynamic subtest vecs0: SUCCESS (2.144s)
[71.709466] Starting dynamic subtest: ccs0
[73.607826] Dynamic subtest ccs0: SUCCESS (1.905s)
[73.610330] Subtest nonpriv-switch: SUCCESS (7.585s)
[73.860628] [014/131] (941s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[73.969956] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[73.972227] Starting dynamic subtest: pipe-A-eDP-1
[73.994157] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[74.003449] Starting dynamic subtest: pipe-B-eDP-1
[74.024166] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[74.030482] Starting dynamic subtest: pipe-C-eDP-1
[74.051018] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[74.057680] Starting dynamic subtest: pipe-D-eDP-1
[74.079276] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[74.083767] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.002s)
[76.124775] [015/131] (939s left) kms_psr (fbc-pr-cursor-plane-move)
[76.226848] Starting subtest: fbc-pr-cursor-plane-move
[76.231610] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[76.304556] [016/131] (939s left) kms_flip (bo-too-big)
[76.404227] Starting subtest: bo-too-big
[76.406507] Starting dynamic subtest: A-eDP1
[78.217869] Dynamic subtest A-eDP1: SUCCESS (1.812s)
[78.226706] Starting dynamic subtest: B-eDP1
[79.942682] Dynamic subtest B-eDP1: SUCCESS (1.723s)
[79.952244] Starting dynamic subtest: C-eDP1
[81.664091] Dynamic subtest C-eDP1: SUCCESS (1.720s)
[81.673069] Starting dynamic subtest: D-eDP1
[83.398266] Dynamic subtest D-eDP1: SUCCESS (1.732s)
[83.400967] Subtest bo-too-big: SUCCESS (6.994s)
[84.654134] [017/131] (931s left) gem_exec_balancer (bonded-pair)
[84.713243] Starting subtest: bonded-pair
[84.717517] Subtest bonded-pair: SKIP (0.000s)
[85.018560] [018/131] (930s left) gem_mmap_offset (open-flood)
[85.070017] Starting subtest: open-flood
[106.562501] Subtest open-flood: SUCCESS (21.489s)
[106.692872] [019/131] (909s left) gem_exec_schedule (semaphore-power)
[106.888793] Subtest semaphore-power: SKIP (0.000s)
[107.063225] [020/131] (908s left) kms_cursor_crc (cursor-random-max-size)
[107.352683] Starting subtest: cursor-random-max-size
[107.359367] Subtest cursor-random-max-size: SKIP (0.000s)
[107.498786] [021/131] (908s left) gem_sync (basic-each)
[107.580452] Starting subtest: basic-each
[109.962284] Subtest basic-each: SUCCESS (2.393s)
[110.143434] [022/131] (905s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[110.249864] Starting subtest: 4-tiled-16bpp-rotate-90
[110.269836] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.020s)
[110.400457] [023/131] (905s left) gem_exec_fence (invalid-timeline-fence-array)
[110.961191] Starting subtest: invalid-timeline-fence-array
[110.963948] Subtest invalid-timeline-fence-array: SUCCESS (0.005s)
[111.986494] [FACT gem_exec_fence (invalid-timeline-fence-array)] new: kernel.kmod_is_loaded.vgem: true
[111.989931] [024/131] (904s left) gem_userptr_blits (sd-probe)
[112.048383] Starting subtest: sd-probe
[112.050341] Subtest sd-probe: SUCCESS (0.000s)
[112.170434] [025/131] (903s left) kms_prop_blob (blob-prop-validate)
[112.233468] Starting subtest: blob-prop-validate
[112.235534] Subtest blob-prop-validate: SUCCESS (0.000s)
[112.342288] [026/131] (903s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[112.446876] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[112.450999] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[112.551914] [027/131] (903s left) kms_legacy_colorkey (invalid-plane)
[112.653938] Starting subtest: invalid-plane
[112.656356] Starting dynamic subtest: zero-id
[112.658582] Dynamic subtest zero-id: SUCCESS (0.000s)
[112.667078] Starting dynamic subtest: outrange-id
[112.669215] Dynamic subtest outrange-id: SUCCESS (0.000s)
[112.671072] Subtest invalid-plane: SUCCESS (0.000s)
[112.726927] [028/131] (903s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[112.827382] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[112.831903] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[112.915587] [029/131] (903s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[113.297388] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[114.064901] [030/131] (902s left) gem_exec_reloc (basic-softpin)
[114.118909] Subtest basic-softpin: SKIP (0.000s)
[114.196868] [031/131] (902s left) syncobj_timeline (etime-single-wait-all-submitted)
[114.253194] Starting subtest: etime-single-wait-all-submitted
[114.361900] Subtest etime-single-wait-all-submitted: SUCCESS (0.109s)
[114.432933] [032/131] (901s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[114.520199] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[114.522655] Starting dynamic subtest: pipe-A-default-mode
[114.810612] Dynamic subtest pipe-A-default-mode: SKIP (0.286s)
[114.815410] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.287s)
[115.607109] [033/131] (900s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[115.706159] Starting subtest: plane-downscale-factor-0-75-with-rotation
[115.708510] Starting dynamic subtest: pipe-A
[116.045750] Dynamic subtest pipe-A: SUCCESS (0.340s)
[116.054439] Starting dynamic subtest: pipe-B
[117.484398] Dynamic subtest pipe-B: SUCCESS (1.438s)
[117.496134] Starting dynamic subtest: pipe-C
[118.908548] Dynamic subtest pipe-C: SUCCESS (1.423s)
[118.917924] Starting dynamic subtest: pipe-D
[120.337430] Dynamic subtest pipe-D: SUCCESS (1.428s)
[120.339848] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.631s)
[121.511384] [034/131] (894s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[121.617514] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[121.628568] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.011s)
[121.698534] [035/131] (894s left) i915_drm_fdinfo (busy-idle)
[121.739445] Starting subtest: busy-idle
[121.741321] Starting dynamic subtest: rcs0
[121.768073] Dynamic subtest rcs0: SKIP (0.028s)
[121.776421] Starting dynamic subtest: bcs0
[121.780464] Dynamic subtest bcs0: SKIP (0.000s)
[121.787525] Starting dynamic subtest: vcs0
[121.791680] Dynamic subtest vcs0: SKIP (0.000s)
[121.798618] Starting dynamic subtest: vcs1
[121.802514] Dynamic subtest vcs1: SKIP (0.000s)
[121.809046] Starting dynamic subtest: vecs0
[121.812976] Dynamic subtest vecs0: SKIP (0.000s)
[121.819453] Starting dynamic subtest: ccs0
[121.823290] Dynamic subtest ccs0: SKIP (0.000s)
[121.827184] Subtest busy-idle: SKIP (0.032s)
[121.861198] [036/131] (894s left) kms_flip (2x-modeset-vs-vblank-race)
[121.950149] Starting subtest: 2x-modeset-vs-vblank-race
[121.961327] Subtest 2x-modeset-vs-vblank-race: SKIP (0.011s)
[122.038652] [037/131] (894s left) api_intel_allocator (reserve-simple)
[122.092502] Starting subtest: reserve-simple
[122.094948] Subtest reserve-simple: SUCCESS (0.003s)
[122.229023] [038/131] (894s left) gem_mmap_gtt (cpuset-big-copy-xy)
[122.285839] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[122.357048] [039/131] (894s left) syncobj_wait (wait-all-snapshot)
[122.414907] Starting subtest: wait-all-snapshot
[122.496444] Subtest wait-all-snapshot: SUCCESS (0.081s)
[122.569364] [040/131] (894s left) fbdev (write)
[122.611526] Starting subtest: write
[122.974161] Subtest write: SUCCESS (0.360s)
[123.033661] [041/131] (893s left) syncobj_timeline (multi-wait-for-submit-signaled)
[123.088552] Starting subtest: multi-wait-for-submit-signaled
[123.091024] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[123.189158] [042/131] (893s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[123.311897] Starting subtest: basic-flip-after-cursor-varying-size
[124.260244] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.948s)
[125.131404] [043/131] (891s left) kms_dp_link_training (uhbr-sst)
[125.232344] Starting subtest: uhbr-sst
[125.241074] Subtest uhbr-sst: SKIP (0.000s)
[125.302764] [044/131] (891s left) kms_psr (fbc-psr-sprite-render)
[125.391370] Starting subtest: fbc-psr-sprite-render
[125.393805] Starting dynamic subtest: eDP-1
[125.398323] Dynamic subtest eDP-1: SKIP (0.000s)
[125.402863] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[125.466785] [045/131] (891s left) gem_barrier_race (remote-request)
[125.530694] Starting subtest: remote-request
[125.533244] Starting dynamic subtest: rcs0
[130.699411] Dynamic subtest rcs0: SUCCESS (5.171s)
[130.701335] Subtest remote-request: SUCCESS (5.172s)
[130.837689] [046/131] (886s left) sysfs_defaults (readonly)
[130.896499] Starting subtest: readonly
[130.898372] Starting dynamic subtest: vecs0
[130.900752] Dynamic subtest vecs0: SUCCESS (0.000s)
[130.908972] Starting dynamic subtest: ccs0
[130.910525] Dynamic subtest ccs0: SUCCESS (0.000s)
[130.917752] Starting dynamic subtest: vcs0
[130.919488] Dynamic subtest vcs0: SUCCESS (0.000s)
[130.926447] Starting dynamic subtest: bcs0
[130.929282] Dynamic subtest bcs0: SUCCESS (0.000s)
[130.936835] Starting dynamic subtest: rcs0
[130.938565] Dynamic subtest rcs0: SUCCESS (0.000s)
[130.945740] Starting dynamic subtest: vcs1
[130.947550] Dynamic subtest vcs1: SUCCESS (0.000s)
[130.949320] Subtest readonly: SUCCESS (0.005s)
[130.996458] [047/131] (885s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[131.105454] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[132.383225] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.279s)
[132.561588] [048/131] (884s left) kms_cursor_crc (cursor-random-128x128)
[132.767688] Starting subtest: cursor-random-128x128
[132.772207] Starting dynamic subtest: pipe-A-eDP-1
[136.680676] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.909s)
[136.711567] Starting dynamic subtest: pipe-D-eDP-1
[141.210753] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.506s)
[141.213154] Subtest cursor-random-128x128: SUCCESS (8.440s)
[141.992420] [049/131] (874s left) perf (polling)
[142.086726] Starting subtest: polling
[142.089088] Starting dynamic subtest: 0-rcs0
[152.114572] Dynamic subtest 0-rcs0: SUCCESS (10.025s)
[152.125690] Starting dynamic subtest: 1-vcs1
[162.134644] Dynamic subtest 1-vcs1: SUCCESS (10.019s)
[162.137149] Subtest polling: SUCCESS (20.046s)
[162.182678] [050/131] (854s left) gem_exercise_blt (fast-copy)
[162.241245] Starting subtest: fast-copy
[162.243093] Starting dynamic subtest: linear-smem-smem
[162.272399] Dynamic subtest linear-smem-smem: SUCCESS (0.033s)
[162.282124] Starting dynamic subtest: xmajor-smem-smem
[162.294973] Dynamic subtest xmajor-smem-smem: SUCCESS (0.022s)
[162.302694] Starting dynamic subtest: tile4-smem-smem
[162.317337] Dynamic subtest tile4-smem-smem: SUCCESS (0.022s)
[162.325188] Starting dynamic subtest: tile64-smem-smem
[162.341088] Dynamic subtest tile64-smem-smem: SUCCESS (0.023s)
[162.343378] Subtest fast-copy: SUCCESS (0.103s)
[162.473049] [051/131] (854s left) kms_async_flips (async-flip-suspend-resume)
[162.576501] Starting subtest: async-flip-suspend-resume
[162.953576] Starting dynamic subtest: pipe-A-eDP-1
[180.665801] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.091s)
[181.032905] Starting dynamic subtest: pipe-B-eDP-1
[183.812722] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.722s)
[184.183699] Starting dynamic subtest: pipe-C-eDP-1
[186.901361] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.680s)
[187.273233] Starting dynamic subtest: pipe-D-eDP-1
[190.071402] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.775s)
[190.073842] Subtest async-flip-suspend-resume: SUCCESS (12.727s)
[191.282313] [052/131] (825s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[196.366078] Starting subtest: pr-primary-plane-update-sf-dmg-area
[196.371852] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.002s)
[197.206127] [053/131] (819s left) kms_pm_rpm (fences-dpms)
[198.743214] Starting subtest: fences-dpms
[198.748345] Subtest fences-dpms: SKIP (0.000s)
[199.446979] [054/131] (817s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[199.538503] Starting subtest: fbcpsr-modesetfrombusy
[205.665359] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.117s)
[205.828711] [055/131] (811s left) gem_pwrite (basic-self)
[205.891787] Subtest basic-self: SKIP (0.000s)
[205.963790] [056/131] (811s left) kms_getfb (getfb-addfb-different-handles)
[206.066894] Starting subtest: getfb-addfb-different-handles
[206.068845] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[206.195987] [057/131] (811s left) kms_cursor_legacy (torture-bo)
[206.313419] Starting subtest: torture-bo
[206.315325] Starting dynamic subtest: pipe-A
[212.374176] Dynamic subtest pipe-A: SUCCESS (6.052s)
[212.386449] Starting dynamic subtest: pipe-B
[219.119374] Dynamic subtest pipe-B: SUCCESS (6.741s)
[219.130273] Starting dynamic subtest: pipe-C
[225.992170] Dynamic subtest pipe-C: SUCCESS (6.868s)
[226.003888] Starting dynamic subtest: pipe-D
[231.951873] Dynamic subtest pipe-D: SUCCESS (5.957s)
[231.961416] Starting dynamic subtest: all-pipes
[238.121936] Dynamic subtest all-pipes: SUCCESS (6.163s)
[238.124525] Subtest torture-bo: SUCCESS (31.790s)
[238.279312] [058/131] (779s left) kms_setmode (invalid-clone-single-crtc)
[238.334820] Starting subtest: invalid-clone-single-crtc
[238.341334] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[238.422774] [059/131] (778s left) i915_pm_rpm (gem-execbuf)
[240.672460] Starting subtest: gem-execbuf
[240.674972] Starting dynamic subtest: smem0
[242.058124] Dynamic subtest smem0: SUCCESS (1.382s)
[242.060531] Subtest gem-execbuf: SUCCESS (1.384s)
[242.177217] [060/131] (775s left) gem_lmem_swapping (massive)
[242.221415] Subtest massive: SKIP (0.000s)
[242.268237] [061/131] (775s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[242.379846] Starting subtest: psr-rgb101010-draw-mmap-cpu
[249.376570] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (6.996s)
[249.512122] [062/131] (767s left) kms_lease (invalid-create-leases)
[249.609323] Starting subtest: invalid-create-leases
[249.614362] Subtest invalid-create-leases: SUCCESS (0.005s)
[249.717977] [063/131] (767s left) gen3_mixed_blits
[249.840543] [064/131] (767s left) syncobj_timeline (wait-all-delayed-signal)
[249.895888] Starting subtest: wait-all-delayed-signal
[249.998716] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[250.072110] [065/131] (767s left) kms_getfb (getfb2-accept-nv12)
[250.157551] Starting subtest: getfb2-accept-nv12
[250.159891] Subtest getfb2-accept-nv12: SUCCESS (0.002s)
[250.266787] [066/131] (767s left) prime_busy (before-wait)
[250.320531] Starting subtest: before-wait
[250.325691] Starting dynamic subtest: rcs0
[250.357259] Dynamic subtest rcs0: SUCCESS (0.033s)
[250.367973] Starting dynamic subtest: bcs0
[250.419988] Dynamic subtest bcs0: SUCCESS (0.062s)
[250.430332] Starting dynamic subtest: vcs0
[250.461917] Dynamic subtest vcs0: SUCCESS (0.041s)
[250.471180] Starting dynamic subtest: vcs1
[250.503276] Dynamic subtest vcs1: SUCCESS (0.041s)
[250.512494] Starting dynamic subtest: vecs0
[250.543896] Dynamic subtest vecs0: SUCCESS (0.040s)
[250.553035] Starting dynamic subtest: ccs0
[250.583681] Dynamic subtest ccs0: SUCCESS (0.040s)
[250.693217] Subtest before-wait: SUCCESS (0.370s)
[250.766794] [067/131] (766s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-gtt)
[250.864596] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-gtt
[250.868877] Subtest psr-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[250.982837] [068/131] (766s left) kms_chamelium_color (ctm-negative)
[251.071653] Subtest ctm-negative: SKIP (0.000s)
[251.119515] [069/131] (766s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[251.215988] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[258.025414] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.809s)
[258.159862] [070/131] (759s left) gem_wait (busy)
[258.229497] Starting subtest: busy
[258.231908] Starting dynamic subtest: all-engines
[259.506955] Dynamic subtest all-engines: SUCCESS (1.275s)
[259.518377] Starting dynamic subtest: rcs0
[260.047239] Dynamic subtest rcs0: SUCCESS (0.540s)
[260.057915] Starting dynamic subtest: bcs0
[260.585675] Dynamic subtest bcs0: SUCCESS (0.537s)
[260.596962] Starting dynamic subtest: vcs0
[262.514506] Dynamic subtest vcs0: SUCCESS (1.926s)
[262.527151] Starting dynamic subtest: vcs1
[264.562142] Dynamic subtest vcs1: SUCCESS (2.045s)
[264.573854] Starting dynamic subtest: vecs0
[266.546350] Dynamic subtest vecs0: SUCCESS (1.981s)
[266.557726] Starting dynamic subtest: ccs0
[267.087312] Dynamic subtest ccs0: SUCCESS (0.541s)
[267.089859] Subtest busy: SUCCESS (8.854s)
[267.285525] [071/131] (750s left) gem_exec_schedule (thriceslice)
[267.358537] Starting subtest: thriceslice
[267.360818] Starting dynamic subtest: rcs0
[267.412570] Dynamic subtest rcs0: SUCCESS (0.060s)
[267.424697] Starting dynamic subtest: bcs0
[267.470741] Dynamic subtest bcs0: SUCCESS (0.056s)
[267.481897] Starting dynamic subtest: vcs0
[267.506005] Dynamic subtest vcs0: SUCCESS (0.033s)
[267.516886] Starting dynamic subtest: vcs1
[267.559142] Dynamic subtest vcs1: SUCCESS (0.052s)
[267.570360] Starting dynamic subtest: vecs0
[267.613210] Dynamic subtest vecs0: SUCCESS (0.053s)
[267.624450] Starting dynamic subtest: ccs0
[267.647267] Dynamic subtest ccs0: SUCCESS (0.034s)
[267.649635] Subtest thriceslice: SUCCESS (0.296s)
[267.949564] [072/131] (749s left) perf (short-reads)
[268.022636] Starting subtest: short-reads
[268.041937] Subtest short-reads: SUCCESS (0.021s)
[268.081952] [073/131] (749s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[268.186383] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[268.190900] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[268.299667] [074/131] (749s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[268.407593] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[274.787537] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.378s)
[274.903171] [075/131] (743s left) gem_softpin (evict-active)
[274.970551] Starting subtest: evict-active
[274.977338] Subtest evict-active: SUCCESS (0.007s)
[275.129982] [076/131] (742s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[280.201229] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[280.206051] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.003s)
[281.053754] [077/131] (737s left) gem_sync (basic-store-each)
[281.129401] Starting subtest: basic-store-each
[283.289109] Subtest basic-store-each: SUCCESS (2.172s)
[283.468670] [078/131] (734s left) gem_userptr_blits (stress-mm-invalidate-close)
[283.536500] Starting subtest: stress-mm-invalidate-close
[285.680639] Subtest stress-mm-invalidate-close: SUCCESS (2.148s)
[285.825106] [079/131] (732s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[285.927810] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[285.930352] Starting dynamic subtest: pipe-A-eDP-1
[286.800069] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.862s)
[286.810216] Starting dynamic subtest: pipe-B-eDP-1
[288.393898] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.592s)
[288.403716] Starting dynamic subtest: pipe-C-eDP-1
[289.878568] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.486s)
[289.887854] Starting dynamic subtest: pipe-D-eDP-1
[291.399556] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.519s)
[291.401685] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.463s)
[292.644670] [080/131] (725s left) gem_ctx_shared (q-smoketest)
[292.707816] Starting subtest: Q-smoketest
[292.710360] Starting dynamic subtest: rcs0
[298.259813] Dynamic subtest rcs0: SUCCESS (5.507s)
[298.269372] Starting dynamic subtest: bcs0
[303.749560] Dynamic subtest bcs0: SUCCESS (5.481s)
[303.759866] Starting dynamic subtest: vcs0
[309.246566] Dynamic subtest vcs0: SUCCESS (5.496s)
[309.260826] Starting dynamic subtest: vcs1
[314.718448] Dynamic subtest vcs1: SUCCESS (5.474s)
[314.728145] Starting dynamic subtest: vecs0
[320.191612] Dynamic subtest vecs0: SUCCESS (5.475s)
[320.200970] Starting dynamic subtest: ccs0
[325.680523] Dynamic subtest ccs0: SUCCESS (5.483s)
[325.682832] Subtest Q-smoketest: SUCCESS (32.923s)
[325.817905] [081/131] (692s left) kms_pm_dc (dc5-dpms-negative)
[326.935433] Starting subtest: dc5-dpms-negative
[326.939803] Subtest dc5-dpms-negative: SKIP (0.000s)
[327.008676] [082/131] (691s left) vgem_basic (mmap)
[327.049131] Starting subtest: mmap
[327.072166] Subtest mmap: SUCCESS (0.025s)
[327.127633] [083/131] (691s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[327.244713] Starting subtest: extended-modeset-hang-newfb-with-reset
[327.246879] Starting dynamic subtest: pipe-A
[342.435070] Dynamic subtest pipe-A: SUCCESS (15.186s)
[342.445589] Starting dynamic subtest: pipe-D
[357.280394] Dynamic subtest pipe-D: SUCCESS (14.841s)
[357.282775] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (30.031s)
[358.079032] [084/131] (660s left) kms_plane_multiple (2x-tiling-none)
[358.177431] Starting subtest: 2x-tiling-none
[358.181933] Subtest 2x-tiling-none: SKIP (0.000s)
[358.250644] [085/131] (660s left) kms_frontbuffer_tracking (psr-1p-rte)
[358.356172] Starting subtest: psr-1p-rte
[363.736650] Subtest psr-1p-rte: SUCCESS (5.382s)
[363.886330] [086/131] (654s left) gem_exec_balancer (semaphore)
[363.947070] Starting subtest: semaphore
[365.551723] Subtest semaphore: SUCCESS (1.602s)
[365.886341] [087/131] (652s left) kms_sequence (get-idle)
[365.982479] Starting subtest: get-idle
[365.984705] Starting dynamic subtest: pipe-A-eDP-1
[367.784526] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.803s)
[367.794537] Starting dynamic subtest: pipe-B-eDP-1
[370.241894] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.455s)
[370.252382] Starting dynamic subtest: pipe-C-eDP-1
[372.656233] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.413s)
[372.666599] Starting dynamic subtest: pipe-D-eDP-1
[375.084755] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.426s)
[375.087154] Subtest get-idle: SUCCESS (9.101s)
[375.885556] [088/131] (642s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[376.001486] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[376.006047] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[376.149655] [089/131] (642s left) gem_exec_suspend (basic-s4-devices)
[376.205745] Starting subtest: basic-S4-devices
[376.208187] Starting dynamic subtest: smem
[387.507866] Dynamic subtest smem: SUCCESS (11.296s)
[387.510601] Subtest basic-S4-devices: SUCCESS (11.298s)
[393.710190] [090/131] (630s left) syncobj_basic (bad-pad-fd-to-handle)
[393.772874] Starting subtest: bad-pad-fd-to-handle
[393.775272] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[393.866058] [091/131] (630s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[393.965883] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[398.477733] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.516s)
[399.643488] [092/131] (625s left) gem_ctx_persistence (heartbeat-hostile)
[399.710778] Starting subtest: heartbeat-hostile
[399.715730] Subtest heartbeat-hostile: SKIP (0.000s)
[399.833525] [093/131] (624s left) gem_tiled_swapping (non-threaded)
[399.899215] Subtest non-threaded: SKIP (0.000s)
[399.970176] [094/131] (624s left) kms_busy (extended-pageflip-hang-oldfb)
[400.067402] Starting subtest: extended-pageflip-hang-oldfb
[400.069354] Starting dynamic subtest: pipe-A
[400.498946] Dynamic subtest pipe-A: SUCCESS (0.432s)
[400.510064] Starting dynamic subtest: pipe-D
[401.659099] Dynamic subtest pipe-D: SUCCESS (1.157s)
[401.661662] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.593s)
[402.477645] [095/131] (622s left) gem_eio (in-flight-immediate)
[402.717239] Starting subtest: in-flight-immediate
[411.609059] Subtest in-flight-immediate: SUCCESS (8.889s)
[411.731366] [096/131] (613s left) kms_frontbuffer_tracking (fbc-stridechange)
[411.831497] Starting subtest: fbc-stridechange
[415.084008] Subtest fbc-stridechange: SUCCESS (3.258s)
[417.297225] [097/131] (607s left) kms_addfb_basic (invalid-get-prop-any)
[417.360550] Starting subtest: invalid-get-prop-any
[417.363047] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[417.511960] [098/131] (607s left) i915_selftest (live)
[419.414375] Starting subtest: live
[419.416551] Starting dynamic subtest: sanitycheck
[423.904158] Dynamic subtest sanitycheck: SUCCESS (4.489s)
[423.911863] Starting dynamic subtest: uncore
[428.298591] Dynamic subtest uncore: SUCCESS (4.392s)
[428.309070] Starting dynamic subtest: workarounds
[431.594900] Dynamic subtest workarounds: SUCCESS (3.294s)
[431.605522] Starting dynamic subtest: gt_engines
[434.872634] Dynamic subtest gt_engines: SUCCESS (3.276s)
[434.882606] Starting dynamic subtest: gt_timelines
[452.599971] Dynamic subtest gt_timelines: SUCCESS (17.723s)
[452.610376] Starting dynamic subtest: gt_contexts
[457.052848] Dynamic subtest gt_contexts: SUCCESS (4.423s)
[457.063592] Starting dynamic subtest: gt_lrc
[463.365921] Dynamic subtest gt_lrc: SUCCESS (6.338s)
[463.375712] Starting dynamic subtest: gt_mocs
[466.482777] Dynamic subtest gt_mocs: SUCCESS (3.114s)
[466.492325] Starting dynamic subtest: gt_pm
[473.399338] Dynamic subtest gt_pm: SUCCESS (6.914s)
[473.409598] Starting dynamic subtest: gt_heartbeat
[477.835690] Dynamic subtest gt_heartbeat: SUCCESS (4.433s)
[477.846033] Starting dynamic subtest: gt_tlb
[487.328764] Dynamic subtest gt_tlb: SUCCESS (9.490s)
[487.339084] Starting dynamic subtest: requests
[500.962146] Dynamic subtest requests: SUCCESS (13.628s)
[500.971840] Starting dynamic subtest: migrate
[509.050715] Dynamic subtest migrate: SUCCESS (8.085s)
[509.061000] Starting dynamic subtest: active
[513.539582] Dynamic subtest active: SUCCESS (4.486s)
[513.549787] Starting dynamic subtest: objects
[518.362545] Dynamic subtest objects: SUCCESS (4.820s)
[518.372056] Starting dynamic subtest: mman
[523.288384] Dynamic subtest mman: SUCCESS (4.924s)
[523.297517] Starting dynamic subtest: dmabuf
[527.826667] Dynamic subtest dmabuf: SUCCESS (4.537s)
[527.836872] Starting dynamic subtest: vma
[532.323518] Dynamic subtest vma: SUCCESS (4.496s)
[532.333845] Starting dynamic subtest: coherency
[537.553373] Dynamic subtest coherency: SUCCESS (5.227s)
[537.569123] Starting dynamic subtest: gtt
[549.859354] Dynamic subtest gtt: SUCCESS (12.306s)
[549.869517] Starting dynamic subtest: gem
[557.463893] Dynamic subtest gem: SUCCESS (7.602s)
[557.473944] Starting dynamic subtest: evict
[561.615555] Dynamic subtest evict: SUCCESS (4.149s)
[561.625428] Starting dynamic subtest: hugepages
[572.627745] Dynamic subtest hugepages: SUCCESS (11.010s)
[572.638584] Starting dynamic subtest: gem_contexts
[601.478217] Dynamic subtest gem_contexts: SUCCESS (28.846s)
[601.488175] Starting dynamic subtest: client
[605.909705] Dynamic subtest client: SUCCESS (4.431s)
[605.925139] Starting dynamic subtest: gem_migrate
[608.672232] Dynamic subtest gem_migrate: SUCCESS (2.760s)
[608.687601] Starting dynamic subtest: reset
[613.151914] Dynamic subtest reset: SUCCESS (4.477s)
[613.161423] Starting dynamic subtest: memory_region
[617.650359] Dynamic subtest memory_region: SUCCESS (4.496s)
[617.666386] Starting dynamic subtest: hangcheck
[631.071681] Dynamic subtest hangcheck: SUCCESS (13.417s)
[631.080803] Starting dynamic subtest: execlists
[635.525518] Dynamic subtest execlists: SUCCESS (4.452s)
[635.536041] Starting dynamic subtest: ring_submission
[639.958392] Dynamic subtest ring_submission: SUCCESS (4.430s)
[639.967490] Starting dynamic subtest: perf
[644.488592] Dynamic subtest perf: SUCCESS (4.528s)
[644.498393] Starting dynamic subtest: slpc
[658.778802] Dynamic subtest slpc: SUCCESS (14.285s)
[658.790393] Starting dynamic subtest: guc
[662.813658] Dynamic subtest guc: SUCCESS (4.033s)
[662.824199] Starting dynamic subtest: guc_multi_lrc
[667.325640] Dynamic subtest guc_multi_lrc: SUCCESS (4.509s)
[667.335734] Starting dynamic subtest: guc_hang
[672.427625] Dynamic subtest guc_hang: SUCCESS (5.100s)
[672.437955] Starting dynamic subtest: late_gt_pm
[676.891776] Dynamic subtest late_gt_pm: SUCCESS (4.462s)
[676.894566] Subtest live: SUCCESS (257.445s)
[676.922746] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[676.923470] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[676.926597] [099/131] (348s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[678.417717] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[678.421765] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[678.512072] [FACT kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[678.513316] [FACT kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)] new: kernel.kmod_is_loaded.i915: true
[678.518693] [100/131] (346s left) gem_exec_reloc (basic-concurrent0)
[678.587927] Subtest basic-concurrent0: SKIP (0.000s)
[678.687457] [101/131] (346s left) kms_flip (flip-vs-panning-vs-hang)
[678.790492] Starting subtest: flip-vs-panning-vs-hang
[678.792702] Starting dynamic subtest: A-eDP1
[730.012391] Dynamic subtest A-eDP1: SUCCESS (51.209s)
[730.024122] Starting dynamic subtest: D-eDP1
[779.994411] Dynamic subtest D-eDP1: SUCCESS (49.969s)
[779.996836] Subtest flip-vs-panning-vs-hang: SUCCESS (101.182s)
[781.145511] [102/131] (244s left) perf (sysctl-defaults)
[781.207504] Starting subtest: sysctl-defaults
[781.209881] Subtest sysctl-defaults: SUCCESS (0.000s)
[781.301831] [103/131] (243s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[781.410995] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[781.415468] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[781.517284] [104/131] (243s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[781.612100] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[781.616320] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[781.726892] [105/131] (243s left) kms_universal_plane (universal-plane-functional)
[781.820745] Starting subtest: universal-plane-functional
[781.823162] Starting dynamic subtest: pipe-A-eDP-1
[785.682378] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.857s)
[785.691743] Starting dynamic subtest: pipe-B-eDP-1
[790.156940] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.474s)
[790.167047] Starting dynamic subtest: pipe-C-eDP-1
[794.412442] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.253s)
[794.422617] Starting dynamic subtest: pipe-D-eDP-1
[798.695026] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.279s)
[798.697508] Subtest universal-plane-functional: SUCCESS (16.869s)
[799.571236] [106/131] (225s left) i915_drm_fdinfo (virtual-busy)
[799.615053] Starting subtest: virtual-busy
[799.619562] Subtest virtual-busy: SKIP (0.000s)
[799.689492] [107/131] (225s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-gtt)
[799.789660] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-gtt
[799.793959] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[799.897043] [108/131] (225s left) perf_pmu (init-busy)
[799.937072] Starting subtest: init-busy
[799.939357] Starting dynamic subtest: rcs0
[799.941663] Dynamic subtest rcs0: SUCCESS (0.001s)
[799.950694] Starting dynamic subtest: bcs0
[799.952548] Dynamic subtest bcs0: SUCCESS (0.000s)
[799.960902] Starting dynamic subtest: vcs0
[799.962770] Dynamic subtest vcs0: SUCCESS (0.001s)
[799.971014] Starting dynamic subtest: vcs1
[799.972828] Dynamic subtest vcs1: SUCCESS (0.001s)
[799.981029] Starting dynamic subtest: vecs0
[799.982935] Dynamic subtest vecs0: SUCCESS (0.001s)
[799.991024] Starting dynamic subtest: ccs0
[799.992851] Dynamic subtest ccs0: SUCCESS (0.000s)
[799.994959] Subtest init-busy: SUCCESS (0.007s)
[800.054008] [109/131] (225s left) core_hotunplug (unbind-rebind)
[800.140919] Starting subtest: unbind-rebind
[806.214012] Subtest unbind-rebind: SUCCESS (6.073s)
[806.253695] [110/131] (219s left) perf_pmu (busy)
[806.299159] Starting subtest: busy
[806.301709] Starting dynamic subtest: rcs0
[808.057057] Dynamic subtest rcs0: SUCCESS (1.758s)
[808.069286] Starting dynamic subtest: bcs0
[808.633783] Dynamic subtest bcs0: SUCCESS (0.575s)
[808.646076] Starting dynamic subtest: vcs0
[810.546651] Dynamic subtest vcs0: SUCCESS (1.909s)
[810.559682] Starting dynamic subtest: vcs1
[812.533785] Dynamic subtest vcs1: SUCCESS (1.984s)
[812.546003] Starting dynamic subtest: vecs0
[814.515698] Dynamic subtest vecs0: SUCCESS (1.979s)
[814.528132] Starting dynamic subtest: ccs0
[815.083088] Dynamic subtest ccs0: SUCCESS (0.567s)
[815.085625] Subtest busy: SUCCESS (8.783s)
[815.200486] [111/131] (210s left) kms_psr (psr2-no-drrs)
[815.310351] Starting subtest: psr2-no-drrs
[815.312852] Starting dynamic subtest: eDP-1
[816.956026] Dynamic subtest eDP-1: SUCCESS (1.648s)
[816.958378] Subtest psr2-no-drrs: SUCCESS (1.649s)
[817.744796] [112/131] (207s left) gem_exec_reloc (basic-cpu-wc-active)
[817.807817] Subtest basic-cpu-wc-active: SKIP (0.000s)
[817.872338] [113/131] (207s left) kms_content_protection (uevent)
[818.037949] Starting subtest: uevent
[821.375983] Subtest uevent: SKIP (3.335s)
[822.552681] [114/131] (203s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[822.606270] Starting subtest: yf-tiled-ccs-to-x-tiled
[822.611160] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[822.787593] [115/131] (202s left) gem_exec_fence (syncobj-invalid-wait)
[823.199521] Starting subtest: syncobj-invalid-wait
[823.202123] Subtest syncobj-invalid-wait: SUCCESS (0.001s)
[824.603959] [116/131] (201s left) i915_pm_rps (reset)
[824.668528] Starting subtest: reset
[824.752556] Subtest reset: FAIL (0.026s)
[824.828920] [117/131] (200s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[824.877828] Starting subtest: multi-wait-all-for-submit-signaled
[824.880334] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[824.974642] [118/131] (200s left) kms_chamelium_frames (hdmi-frame-dump)
[825.380487] Subtest hdmi-frame-dump: SKIP (0.000s)
[826.169174] [119/131] (199s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[826.275569] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[827.408677] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.134s)
[827.586456] [120/131] (198s left) gem_exec_nop (basic-parallel)
[827.659731] Starting subtest: basic-parallel
[843.509945] Subtest basic-parallel: SUCCESS (15.854s)
[843.741730] [121/131] (182s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[843.851642] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[843.853868] Starting dynamic subtest: pipe-A-eDP-1
[843.862821] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[843.873161] Starting dynamic subtest: pipe-B-eDP-1
[843.882705] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[843.894378] Starting dynamic subtest: pipe-C-eDP-1
[843.902835] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[843.912354] Starting dynamic subtest: pipe-D-eDP-1
[843.925948] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[843.930928] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[846.036954] [122/131] (179s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[846.147362] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[852.427489] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.282s)
[853.623222] [123/131] (172s left) kms_big_fb (linear-8bpp-rotate-90)
[853.730111] Starting subtest: linear-8bpp-rotate-90
[853.754729] Subtest linear-8bpp-rotate-90: SKIP (0.022s)
[853.887255] [124/131] (172s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[853.958942] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[853.963491] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[854.144500] [125/131] (171s left) kms_dsc (dsc-with-output-formats-with-bpc)
[854.242764] Starting subtest: dsc-with-output-formats-with-bpc
[854.302186] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s)
[854.345481] [126/131] (171s left) kms_vrr (lobf)
[854.439432] Starting subtest: lobf
[854.443606] Subtest lobf: SKIP (0.000s)
[854.511231] [127/131] (171s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[854.612695] Starting subtest: plane-primary-toggle-with-vblank-wait
[854.615034] Starting dynamic subtest: pipe-A-eDP-1
[854.797522] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.184s)
[855.113364] Starting dynamic subtest: pipe-B-eDP-1
[856.017354] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.913s)
[856.317564] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.701s)
[857.171380] [128/131] (169s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[857.233136] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[857.235135] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[857.350194] [129/131] (168s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[857.459803] Starting subtest: yf-tiled-32bpp-rotate-90
[857.463715] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[857.567737] [130/131] (168s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[857.678911] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[857.682979] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[857.797937] [131/131] (168s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[857.902818] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[864.846052] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (6.944s)
[864.964051] 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.