[58.495058] Initializing watchdogs
[58.495107]   /dev/watchdog0
[58.552716] [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]
[58.557223] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.559883] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.563743] [001/133] (960s left) gem_exec_balancer (sliced)
[58.668269] Starting subtest: sliced
[58.672844] Subtest sliced: SKIP (0.000s)
[58.967894] [002/133] (960s left) gem_softpin (evict-prime)
[59.028673] Starting subtest: evict-prime
[59.031030] Starting dynamic subtest: rcs0
[60.174954] Dynamic subtest rcs0: SUCCESS (1.146s)
[60.183925] Starting dynamic subtest: bcs0
[61.286893] Dynamic subtest bcs0: SUCCESS (1.111s)
[61.294979] Starting dynamic subtest: vcs0
[62.931735] Dynamic subtest vcs0: SUCCESS (1.642s)
[62.942270] Starting dynamic subtest: vcs1
[64.857266] Dynamic subtest vcs1: SUCCESS (1.923s)
[64.867544] Starting dynamic subtest: vecs0
[66.879065] Dynamic subtest vecs0: SUCCESS (2.021s)
[66.889031] Starting dynamic subtest: ccs0
[68.093519] Dynamic subtest ccs0: SUCCESS (1.215s)
[68.104508] Starting dynamic subtest: all
[69.849033] Dynamic subtest all: SUCCESS (1.754s)
[69.852404] Subtest evict-prime: SUCCESS (10.819s)
[69.937372] [003/133] (949s left) kms_cursor_crc (cursor-offscreen-64x64)
[70.116737] Starting subtest: cursor-offscreen-64x64
[70.131645] Starting dynamic subtest: pipe-A-eDP-1
[72.108537] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.976s)
[72.138804] Starting dynamic subtest: pipe-D-eDP-1
[74.723716] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.591s)
[74.726202] Subtest cursor-offscreen-64x64: SUCCESS (4.608s)
[75.584108] [004/133] (943s left) gem_ctx_exec (basic)
[75.654668] Starting subtest: basic
[75.659239] Subtest basic: SUCCESS (0.007s)
[75.768426] [005/133] (943s left) gem_exec_schedule (u-semaphore-noskip)
[75.838605] Starting subtest: u-semaphore-noskip
[76.237067] Subtest u-semaphore-noskip: SUCCESS (0.404s)
[76.576924] [006/133] (942s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[76.667987] Starting subtest: pr-overlay-plane-update-continuous-sf
[76.672283] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[76.748319] [007/133] (942s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[76.863647] Starting subtest: cursorA-vs-flipB-atomic
[76.868061] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[77.001864] [008/133] (942s left) gem_eio (wait-wedge-immediate)
[77.234804] Starting subtest: wait-wedge-immediate
[79.009804] Subtest wait-wedge-immediate: SUCCESS (1.775s)
[79.168199] [009/133] (940s left) kms_psr (psr2-cursor-blt)
[79.256924] Starting subtest: psr2-cursor-blt
[79.259302] Starting dynamic subtest: eDP-1
[80.963624] Dynamic subtest eDP-1: SUCCESS (1.705s)
[80.965726] Subtest psr2-cursor-blt: SUCCESS (1.706s)
[81.756320] [010/133] (937s left) i915_drm_fdinfo (memory-info-shared)
[81.801644] Starting subtest: memory-info-shared
[81.804050] Starting dynamic subtest: smem0
[81.860364] Dynamic subtest smem0: SUCCESS (0.058s)
[81.863210] Subtest memory-info-shared: SUCCESS (0.059s)
[81.939308] [011/133] (937s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[82.026057] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[82.030629] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[83.192922] [012/133] (936s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[83.285074] Starting subtest: psr-rgb565-draw-blt
[90.322887] Subtest psr-rgb565-draw-blt: SUCCESS (7.040s)
[90.444171] [013/133] (929s left) gem_ctx_persistence (saturated-hostile)
[90.497875] Starting subtest: saturated-hostile
[90.500253] Starting dynamic subtest: rcs0
[91.318370] Dynamic subtest rcs0: SUCCESS (0.819s)
[91.330594] Starting dynamic subtest: bcs0
[92.107372] Dynamic subtest bcs0: SUCCESS (0.787s)
[92.117976] Starting dynamic subtest: vcs0
[92.897495] Dynamic subtest vcs0: SUCCESS (0.789s)
[92.908348] Starting dynamic subtest: vcs1
[93.692250] Dynamic subtest vcs1: SUCCESS (0.794s)
[93.701752] Starting dynamic subtest: vecs0
[94.482711] Dynamic subtest vecs0: SUCCESS (0.790s)
[94.492223] Starting dynamic subtest: ccs0
[95.317571] Dynamic subtest ccs0: SUCCESS (0.834s)
[95.320322] Subtest saturated-hostile: SUCCESS (4.820s)
[95.430976] [014/133] (924s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[95.527547] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[102.365031] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.839s)
[102.521932] [015/133] (917s left) gem_basic (bad-close)
[102.579078] Starting subtest: bad-close
[102.583298] Subtest bad-close: SUCCESS (0.000s)
[102.669040] [016/133] (917s left) gem_partial_pwrite_pread (reads-display)
[102.721933] Subtest reads-display: SKIP (0.000s)
[102.792977] [017/133] (916s left) api_intel_bb (intel-bb-blit-y)
[102.846066] Starting subtest: intel-bb-blit-y
[106.714858] Subtest intel-bb-blit-y: SUCCESS (3.869s)
[106.826910] [018/133] (912s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[107.226223] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[108.059599] [019/133] (911s left) gem_exec_fence (syncobj-timeline-repeat)
[108.672574] Starting subtest: syncobj-timeline-repeat
[108.914621] Subtest syncobj-timeline-repeat: SUCCESS (0.241s)
[109.989375] [FACT gem_exec_fence (syncobj-timeline-repeat)] new: kernel.kmod_is_loaded.vgem: true
[109.992401] [020/133] (909s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[110.083041] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[110.085397] Starting dynamic subtest: pipe-A-eDP-1
[110.094310] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[110.104598] Starting dynamic subtest: pipe-B-eDP-1
[110.113691] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[110.121810] Starting dynamic subtest: pipe-C-eDP-1
[110.130194] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[110.137794] Starting dynamic subtest: pipe-D-eDP-1
[110.146125] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[110.150067] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.003s)
[112.338442] [021/133] (907s left) gem_lmem_swapping (parallel-multi)
[112.386154] Subtest parallel-multi: SKIP (0.000s)
[112.438070] [022/133] (907s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[112.525064] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[112.527164] Starting dynamic subtest: pipe-A-eDP-1
[114.706456] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.182s)
[114.715627] Starting dynamic subtest: pipe-B-eDP-1
[117.010688] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.303s)
[117.019508] Starting dynamic subtest: pipe-C-eDP-1
[119.124884] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.114s)
[119.134080] Starting dynamic subtest: pipe-D-eDP-1
[121.312041] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.187s)
[121.313982] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.789s)
[122.566635] [023/133] (897s left) kms_cursor_crc (cursor-sliding-32x10)
[122.742456] Starting subtest: cursor-sliding-32x10
[122.797250] Subtest cursor-sliding-32x10: SKIP (0.049s)
[123.062488] [024/133] (896s left) kms_atomic (crtc-invalid-params)
[123.154676] Starting subtest: crtc-invalid-params
[123.156966] Starting dynamic subtest: pipe-A-eDP-1
[123.510042] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.355s)
[123.511873] Subtest crtc-invalid-params: SUCCESS (0.356s)
[124.415512] [025/133] (895s left) gem_exec_schedule (in-order)
[124.491592] Starting subtest: in-order
[124.493592] Starting dynamic subtest: rcs0
[124.587700] Dynamic subtest rcs0: SUCCESS (0.103s)
[124.598150] Starting dynamic subtest: vcs0
[124.677216] Dynamic subtest vcs0: SUCCESS (0.087s)
[124.687950] Starting dynamic subtest: vcs1
[124.766471] Dynamic subtest vcs1: SUCCESS (0.088s)
[124.777434] Starting dynamic subtest: vecs0
[124.847494] Dynamic subtest vecs0: SUCCESS (0.080s)
[124.857787] Starting dynamic subtest: ccs0
[124.946033] Dynamic subtest ccs0: SUCCESS (0.098s)
[124.948693] Subtest in-order: SUCCESS (0.462s)
[125.955936] [026/133] (894s left) kms_properties (connector-properties-atomic)
[126.038289] Starting subtest: connector-properties-atomic
[126.040182] Starting dynamic subtest: pipe-A-eDP-1
[134.032328] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.991s)
[134.041486] Starting dynamic subtest: pipe-None-DP-1
[134.045640] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[134.053401] Starting dynamic subtest: pipe-None-HDMI-A-1
[134.057367] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[134.065309] Starting dynamic subtest: pipe-None-DP-2
[134.069588] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[134.077570] Starting dynamic subtest: pipe-None-HDMI-A-2
[134.081875] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[134.089854] Starting dynamic subtest: pipe-None-DP-3
[134.094241] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[134.102102] Starting dynamic subtest: pipe-None-DP-4
[134.106510] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[134.108367] Subtest connector-properties-atomic: SUCCESS (8.002s)
[134.920655] [027/133] (885s left) kms_dsc (dsc-with-bpc-formats)
[135.026937] Starting subtest: dsc-with-bpc-formats
[135.136596] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[135.182491] [028/133] (885s left) perf (per-context-mode-unprivileged)
[135.319461] Starting subtest: per-context-mode-unprivileged
[135.323849] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[135.363889] [029/133] (884s left) kms_flip (2x-flip-vs-panning-vs-hang)
[135.450193] Starting subtest: 2x-flip-vs-panning-vs-hang
[135.463396] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.012s)
[135.554549] [030/133] (884s left) kms_plane_scaling (planes-scaler-unity-scaling)
[135.648148] Starting subtest: planes-scaler-unity-scaling
[135.650465] Starting dynamic subtest: pipe-A
[135.710736] Dynamic subtest pipe-A: SUCCESS (0.064s)
[135.719246] Starting dynamic subtest: pipe-B
[136.826525] Dynamic subtest pipe-B: SUCCESS (1.115s)
[136.835184] Starting dynamic subtest: pipe-C
[137.938082] Dynamic subtest pipe-C: SUCCESS (1.110s)
[137.946501] Starting dynamic subtest: pipe-D
[139.068319] Dynamic subtest pipe-D: SUCCESS (1.130s)
[139.070567] Subtest planes-scaler-unity-scaling: SUCCESS (3.422s)
[140.235777] [031/133] (880s left) i915_hangman (detector)
[140.296152] Starting subtest: detector
[140.299760] Starting dynamic subtest: rcs0
[151.862325] Dynamic subtest rcs0: SUCCESS (11.565s)
[151.873273] Starting dynamic subtest: bcs0
[163.892560] Dynamic subtest bcs0: SUCCESS (12.027s)
[163.904126] Starting dynamic subtest: vcs0
[175.861269] Dynamic subtest vcs0: SUCCESS (11.965s)
[175.870588] Starting dynamic subtest: vcs1
[185.908272] Dynamic subtest vcs1: SUCCESS (10.044s)
[185.919758] Starting dynamic subtest: vecs0
[197.811242] Dynamic subtest vecs0: SUCCESS (11.901s)
[197.822479] Starting dynamic subtest: ccs0
[208.883939] Dynamic subtest ccs0: SUCCESS (11.069s)
[208.886787] Subtest detector: SUCCESS (68.586s)
[208.977901] [032/133] (811s left) syncobj_wait (single-wait-submitted)
[209.027529] Starting subtest: single-wait-submitted
[209.130060] Subtest single-wait-submitted: SUCCESS (0.101s)
[209.212449] [033/133] (811s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[209.305180] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[209.309580] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[209.432282] [034/133] (811s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[209.510717] Starting subtest: stress-mm-invalidate-close-overlap
[211.658634] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s)
[211.803173] [035/133] (808s left) gem_exec_nop (basic-sequential)
[211.882512] Starting subtest: basic-sequential
[228.053758] Subtest basic-sequential: SUCCESS (16.179s)
[228.298849] [036/133] (792s left) gem_ctx_shared (q-smoketest)
[228.361465] Starting subtest: Q-smoketest
[228.363518] Starting dynamic subtest: rcs0
[233.918510] Dynamic subtest rcs0: SUCCESS (5.507s)
[233.928267] Starting dynamic subtest: bcs0
[239.411328] Dynamic subtest bcs0: SUCCESS (5.494s)
[239.420948] Starting dynamic subtest: vcs0
[244.884263] Dynamic subtest vcs0: SUCCESS (5.474s)
[244.899014] Starting dynamic subtest: vcs1
[250.371325] Dynamic subtest vcs1: SUCCESS (5.484s)
[250.382210] Starting dynamic subtest: vecs0
[255.842814] Dynamic subtest vecs0: SUCCESS (5.472s)
[255.853265] Starting dynamic subtest: ccs0
[261.359492] Dynamic subtest ccs0: SUCCESS (5.513s)
[261.361735] Subtest Q-smoketest: SUCCESS (32.952s)
[261.500475] [037/133] (759s left) gem_exec_reloc (basic-write-cpu-noreloc)
[261.582035] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[261.647088] [038/133] (759s left) gem_mmap_gtt (zero-extend)
[261.695341] Subtest zero-extend: SKIP (0.000s)
[261.753418] [039/133] (758s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[261.844311] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[268.744412] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.904s)
[268.910854] [040/133] (751s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[268.964706] Starting subtest: etime-multi-wait-available-unsubmitted
[269.066708] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.101s)
[269.142170] [041/133] (751s left) gem_ctx_param (invalid-ctx-set)
[269.203528] Starting subtest: invalid-ctx-set
[269.205925] Subtest invalid-ctx-set: SUCCESS (0.001s)
[269.312444] [042/133] (751s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[269.410073] Starting subtest: addfb25-y-tiled-small-legacy
[269.414314] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[269.518561] [043/133] (751s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[269.625856] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[269.630172] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[269.730415] [044/133] (751s left) gem_exec_params (invalid-fence-in)
[269.783217] Starting subtest: invalid-fence-in
[269.784973] Subtest invalid-fence-in: SUCCESS (0.000s)
[269.903768] [045/133] (751s left) gem_exec_whisper (basic-fds-forked-all)
[269.965294] Starting subtest: basic-fds-forked-all
[292.305235] Subtest basic-fds-forked-all: SUCCESS (22.333s)
[292.487486] [046/133] (728s left) i915_pm_rpm (gem-execbuf-stress)
[294.009710] Starting subtest: gem-execbuf-stress
[294.012180] Starting dynamic subtest: smem0
[306.827121] Dynamic subtest smem0: SUCCESS (12.815s)
[306.837852] Starting dynamic subtest: extra-wait-smem0
[368.783996] Dynamic subtest extra-wait-smem0: SUCCESS (61.950s)
[368.786715] Subtest gem-execbuf-stress: SUCCESS (74.771s)
[369.172715] [047/133] (651s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[369.272517] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[369.276652] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[369.375221] [048/133] (651s left) i915_selftest (perf)
[371.203964] Starting subtest: perf
[371.206591] Starting dynamic subtest: engine_cs
[373.977821] Dynamic subtest engine_cs: SUCCESS (2.774s)
[373.984669] Starting dynamic subtest: request
[381.327308] Dynamic subtest request: SUCCESS (7.347s)
[381.336717] Starting dynamic subtest: migrate
[385.618457] Dynamic subtest migrate: SUCCESS (4.290s)
[385.627432] Starting dynamic subtest: region
[389.822480] Dynamic subtest region: SUCCESS (4.202s)
[389.824877] Subtest perf: SUCCESS (18.619s)
[389.852058] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[389.852784] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[389.855938] [049/133] (631s left) kms_properties (crtc-properties-legacy)
[391.403189] Starting subtest: crtc-properties-legacy
[391.406374] Starting dynamic subtest: pipe-A-eDP-1
[391.872076] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.468s)
[391.882729] Starting dynamic subtest: pipe-B-eDP-1
[392.996072] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.124s)
[393.004788] Starting dynamic subtest: pipe-C-eDP-1
[394.119905] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.123s)
[394.129625] Starting dynamic subtest: pipe-D-eDP-1
[395.244529] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.123s)
[395.246839] Subtest crtc-properties-legacy: SUCCESS (3.844s)
[396.089739] [FACT kms_properties (crtc-properties-legacy)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[396.091083] [FACT kms_properties (crtc-properties-legacy)] new: kernel.kmod_is_loaded.i915: true
[396.095287] [050/133] (625s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[396.204141] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[396.206305] Starting dynamic subtest: pipe-A-default-mode
[398.909814] Dynamic subtest pipe-A-default-mode: SUCCESS (2.706s)
[398.912245] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.707s)
[399.747965] [051/133] (621s left) sysfs_heartbeat_interval (idempotent)
[399.811442] Starting subtest: idempotent
[399.813775] Starting dynamic subtest: vecs0
[399.816162] Dynamic subtest vecs0: SUCCESS (0.001s)
[399.827283] Starting dynamic subtest: ccs0
[399.829126] Dynamic subtest ccs0: SUCCESS (0.001s)
[399.837118] Starting dynamic subtest: vcs0
[399.839265] Dynamic subtest vcs0: SUCCESS (0.000s)
[399.847251] Starting dynamic subtest: bcs0
[399.849155] Dynamic subtest bcs0: SUCCESS (0.001s)
[399.856698] Starting dynamic subtest: rcs0
[399.858600] Dynamic subtest rcs0: SUCCESS (0.001s)
[399.865923] Starting dynamic subtest: vcs1
[399.867844] Dynamic subtest vcs1: SUCCESS (0.000s)
[399.869748] Subtest idempotent: SUCCESS (0.008s)
[399.907816] [052/133] (621s left) kms_flip (nonexisting-fb)
[400.018229] Starting subtest: nonexisting-fb
[400.020516] Starting dynamic subtest: A-eDP1
[401.250482] Dynamic subtest A-eDP1: SUCCESS (1.232s)
[401.261091] Starting dynamic subtest: B-eDP1
[402.393174] Dynamic subtest B-eDP1: SUCCESS (1.141s)
[402.401595] Starting dynamic subtest: C-eDP1
[403.519423] Dynamic subtest C-eDP1: SUCCESS (1.125s)
[403.528211] Starting dynamic subtest: D-eDP1
[404.658487] Dynamic subtest D-eDP1: SUCCESS (1.138s)
[404.660724] Subtest nonexisting-fb: SUCCESS (4.644s)
[405.834432] [053/133] (615s left) kms_pm_rpm (modeset-lpsp-stress)
[408.074794] Starting subtest: modeset-lpsp-stress
[424.461268] Subtest modeset-lpsp-stress: SUCCESS (16.390s)
[424.549738] [054/133] (596s left) perf (invalid-oa-exponent)
[424.678421] Starting subtest: invalid-oa-exponent
[424.690760] Subtest invalid-oa-exponent: SUCCESS (0.015s)
[424.737583] [055/133] (596s left) gem_userptr_blits (nohangcheck)
[424.827591] Starting subtest: nohangcheck
[425.067178] Subtest nohangcheck: SUCCESS (0.236s)
[425.170296] [056/133] (596s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[425.263649] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[431.789355] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.528s)
[431.902555] [057/133] (589s left) gem_partial_pwrite_pread (write-snoop)
[431.960940] Subtest write-snoop: SKIP (0.000s)
[432.032991] [058/133] (589s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[432.124055] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[432.128386] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[432.195893] [059/133] (589s left) gem_mmap (short-mmap)
[432.257927] Subtest short-mmap: SKIP (0.000s)
[432.317051] [060/133] (589s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[432.415805] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[432.420074] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[432.515264] [061/133] (589s left) perf_pmu (faulting-read)
[432.559975] Starting subtest: faulting-read
[432.562304] Starting dynamic subtest: wb
[432.564628] Dynamic subtest wb: SUCCESS (0.001s)
[432.574999] Starting dynamic subtest: wc
[432.576835] Dynamic subtest wc: SUCCESS (0.000s)
[432.585521] Starting dynamic subtest: uc
[432.587323] Dynamic subtest uc: SUCCESS (0.000s)
[432.589155] Subtest faulting-read: SUCCESS (0.003s)
[432.679451] [062/133] (588s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[432.772021] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[432.775420] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[432.872435] [063/133] (588s left) gem_ctx_isolation (preservation-s3)
[432.940632] Starting subtest: preservation-S3
[432.942484] Starting dynamic subtest: rcs0
[449.794202] Dynamic subtest rcs0: SUCCESS (1.864s)
[449.806651] Starting dynamic subtest: bcs0
[466.782092] Dynamic subtest bcs0: SUCCESS (1.744s)
[466.792055] Starting dynamic subtest: vcs0
[483.789183] Dynamic subtest vcs0: SUCCESS (2.790s)
[483.801502] Starting dynamic subtest: vcs1
[501.800177] Dynamic subtest vcs1: SUCCESS (5.081s)
[501.810418] Starting dynamic subtest: vecs0
[519.775829] Dynamic subtest vecs0: SUCCESS (4.878s)
[519.788085] Starting dynamic subtest: ccs0
[537.789125] Dynamic subtest ccs0: SUCCESS (3.263s)
[537.791957] Subtest preservation-S3: SUCCESS (19.625s)
[548.041703] [064/133] (483s left) kms_vblank (wait-busy)
[548.159844] Starting subtest: wait-busy
[548.162614] Starting dynamic subtest: pipe-A-eDP-1
[550.044772] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.882s)
[550.061184] Starting dynamic subtest: pipe-D-eDP-1
[552.587634] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.538s)
[552.590350] Subtest wait-busy: SUCCESS (4.425s)
[553.390567] [065/133] (478s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[553.444162] Starting subtest: single-wait-all-for-submit-available-signaled
[553.446497] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[553.540650] [066/133] (478s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[553.637509] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[553.663758] Starting dynamic subtest: pipe-A-plane-0
[554.110519] Dynamic subtest pipe-A-plane-0: SUCCESS (0.444s)
[554.121599] Starting dynamic subtest: pipe-A-plane-3
[554.386202] Dynamic subtest pipe-A-plane-3: SUCCESS (0.277s)
[555.474196] Starting dynamic subtest: pipe-B-plane-0
[555.911701] Dynamic subtest pipe-B-plane-0: SUCCESS (0.444s)
[555.921671] Starting dynamic subtest: pipe-B-plane-3
[556.167662] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[556.475906] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.837s)
[557.355565] [067/133] (474s left) kms_atomic_interruptible (legacy-dpms)
[557.456428] Starting subtest: legacy-dpms
[557.458734] Starting dynamic subtest: pipe-A-eDP-1
[564.877904] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.417s)
[564.880383] Subtest legacy-dpms: SUCCESS (7.418s)
[565.734072] [068/133] (466s left) kms_legacy_colorkey (basic)
[565.821801] Starting subtest: basic
[565.824777] Starting dynamic subtest: pipe-A
[565.865938] Dynamic subtest pipe-A: SUCCESS (0.045s)
[565.878573] Starting dynamic subtest: pipe-B
[565.880873] Dynamic subtest pipe-B: SUCCESS (0.000s)
[565.890389] Starting dynamic subtest: pipe-C
[565.892825] Dynamic subtest pipe-C: SUCCESS (0.000s)
[565.902435] Starting dynamic subtest: pipe-D
[565.904939] Dynamic subtest pipe-D: SUCCESS (0.000s)
[565.907761] Subtest basic: SUCCESS (0.051s)
[565.947542] [069/133] (466s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[566.039862] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[566.042479] Starting dynamic subtest: pipe-A-eDP-1
[571.927937] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.892s)
[571.939101] Starting dynamic subtest: pipe-B-eDP-1
[578.575921] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.646s)
[578.578686] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.541s)
[579.450652] [070/133] (452s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[579.553912] Starting subtest: fbc-psr2-sprite-plane-onoff
[579.556764] Starting dynamic subtest: eDP-1
[579.561821] Dynamic subtest eDP-1: SKIP (0.000s)
[579.567360] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[579.638699] [071/133] (452s left) kms_vblank (invalid)
[579.744665] Starting subtest: invalid
[579.747179] Starting dynamic subtest: pipe-A-eDP-1
[580.141930] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.397s)
[580.144127] Subtest invalid: SUCCESS (0.398s)
[580.982367] [072/133] (451s left) prime_vgem (busy)
[581.048214] Starting subtest: busy
[581.051088] Starting dynamic subtest: rcs0
[581.104255] Dynamic subtest rcs0: SUCCESS (0.056s)
[581.114763] Starting dynamic subtest: bcs0
[581.153554] Dynamic subtest bcs0: SUCCESS (0.048s)
[581.163200] Starting dynamic subtest: vcs0
[581.203259] Dynamic subtest vcs0: SUCCESS (0.048s)
[581.212948] Starting dynamic subtest: vcs1
[581.251262] Dynamic subtest vcs1: SUCCESS (0.047s)
[581.260774] Starting dynamic subtest: vecs0
[581.296924] Dynamic subtest vecs0: SUCCESS (0.045s)
[581.306858] Starting dynamic subtest: ccs0
[581.344986] Dynamic subtest ccs0: SUCCESS (0.046s)
[581.347721] Subtest busy: SUCCESS (0.297s)
[581.455201] [073/133] (450s left) kms_color (ctm-signed)
[581.553726] Starting subtest: ctm-signed
[581.555922] Starting dynamic subtest: pipe-A-eDP-1
[583.653730] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.102s)
[583.664701] Starting dynamic subtest: pipe-B-eDP-1
[586.496901] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.842s)
[586.508183] Starting dynamic subtest: pipe-C-eDP-1
[589.125654] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.628s)
[589.135675] Starting dynamic subtest: pipe-D-eDP-1
[591.774349] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.648s)
[591.777144] Subtest ctm-signed: SUCCESS (10.224s)
[592.610215] [074/133] (439s left) api_intel_bb (add-remove-objects)
[592.665930] Starting subtest: add-remove-objects
[592.674395] Subtest add-remove-objects: SUCCESS (0.011s)
[592.795577] [075/133] (439s left) gem_workarounds (reset-fd)
[592.865857] Starting subtest: reset-fd
[593.041519] Subtest reset-fd: SUCCESS (0.175s)
[593.165355] [076/133] (439s left) kms_flip (2x-blocking-wf_vblank)
[593.268699] Starting subtest: 2x-blocking-wf_vblank
[593.280143] Subtest 2x-blocking-wf_vblank: SKIP (0.011s)
[593.361870] [077/133] (438s left) kms_content_protection (suspend-resume)
[593.509707] Starting subtest: suspend-resume
[593.515133] Subtest suspend-resume: SKIP (0.000s)
[593.630654] [078/133] (438s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[593.730713] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[593.734736] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[593.816471] [079/133] (438s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[593.919844] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[593.924775] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[594.020368] [080/133] (438s left) fbdev (info)
[594.062354] Starting subtest: info
[594.064712] Subtest info: SUCCESS (0.000s)
[594.131123] [081/133] (438s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[594.187707] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[594.255094] [082/133] (438s left) kms_chamelium_audio (dp-audio)
[594.636390] Subtest dp-audio: SKIP (0.000s)
[595.422184] [083/133] (437s left) kms_plane (plane-panning-bottom-right)
[595.515832] Starting subtest: plane-panning-bottom-right
[595.518230] Starting dynamic subtest: pipe-A
[597.212798] Dynamic subtest pipe-A: SUCCESS (1.697s)
[597.223928] Starting dynamic subtest: pipe-B
[599.664670] Dynamic subtest pipe-B: SUCCESS (2.448s)
[599.667630] Subtest plane-panning-bottom-right: SUCCESS (4.149s)
[600.478999] [084/133] (432s left) kms_cursor_legacy (single-move)
[600.605435] Starting subtest: single-move
[600.607658] Starting dynamic subtest: pipe-A
[605.988904] Dynamic subtest pipe-A: SUCCESS (5.381s)
[606.002569] Starting dynamic subtest: pipe-B
[611.372086] Dynamic subtest pipe-B: SUCCESS (5.380s)
[611.384414] Starting dynamic subtest: pipe-C
[616.755216] Dynamic subtest pipe-C: SUCCESS (5.379s)
[616.767865] Starting dynamic subtest: pipe-D
[622.138272] Dynamic subtest pipe-D: SUCCESS (5.379s)
[622.150865] Starting dynamic subtest: all-pipes
[627.527690] Dynamic subtest all-pipes: SUCCESS (5.386s)
[627.530700] Subtest single-move: SUCCESS (26.919s)
[627.691962] [085/133] (405s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[627.820126] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[631.781253] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (3.967s)
[632.985666] [086/133] (399s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[633.103609] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[633.109074] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[633.205696] [087/133] (399s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[633.316538] Starting subtest: fbc-rgb101010-draw-mmap-wc
[637.880917] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.567s)
[639.005162] [088/133] (393s left) gem_render_copy (yf-tiled-ccs-to-linear)
[639.056948] Starting subtest: yf-tiled-ccs-to-linear
[639.062699] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[639.257809] [089/133] (393s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[639.367533] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[639.372490] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[639.434440] [090/133] (393s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[639.552668] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[640.971995] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.419s)
[641.771719] [091/133] (391s left) syncobj_timeline (invalid-query-illegal-handle)
[641.834704] Starting subtest: invalid-query-illegal-handle
[641.837180] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[641.949263] [092/133] (391s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[642.054984] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[642.060506] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[642.139270] [093/133] (390s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[642.231672] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[646.503782] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.275s)
[647.662558] [094/133] (385s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[647.714588] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[647.773699] [095/133] (385s left) kms_invalid_mode (bad-vtotal)
[647.869032] Starting subtest: bad-vtotal
[647.871796] Starting dynamic subtest: pipe-A-eDP-1
[648.151562] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[648.163486] Starting dynamic subtest: pipe-B-eDP-1
[648.165834] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[648.175954] Starting dynamic subtest: pipe-C-eDP-1
[648.178721] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[648.188760] Starting dynamic subtest: pipe-D-eDP-1
[648.191651] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[648.194475] Subtest bad-vtotal: SUCCESS (0.289s)
[648.986349] [096/133] (384s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[649.085640] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[649.799784] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.715s)
[649.963509] [097/133] (383s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[650.059746] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[656.781977] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.727s)
[656.910483] [098/133] (376s left) gem_exec_params (invalid-fence-in-submit)
[656.967629] Starting subtest: invalid-fence-in-submit
[656.973750] Subtest invalid-fence-in-submit: SUCCESS (0.004s)
[657.095762] [099/133] (376s left) perf (gen12-invalid-class-instance)
[657.179833] Starting subtest: gen12-invalid-class-instance
[657.192850] Subtest gen12-invalid-class-instance: SUCCESS (0.012s)
[657.234297] [100/133] (376s left) gem_mmap_gtt (cpuset-big-copy-odd)
[657.284832] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[657.340214] [101/133] (376s left) gem_exec_params (rel-constants-invalid)
[657.399960] Starting subtest: rel-constants-invalid
[657.402767] Subtest rel-constants-invalid: SUCCESS (0.000s)
[657.508786] [102/133] (375s left) gem_fenced_exec_thrash (no-spare-fences)
[657.569163] Subtest no-spare-fences: SKIP (0.000s)
[657.632366] [103/133] (375s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[657.734351] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[661.687842] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (3.957s)
[662.819386] [104/133] (370s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[662.879901] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[662.986257] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.106s)
[663.064335] [105/133] (370s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[663.154672] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[663.845818] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.692s)
[664.010198] [106/133] (369s left) gem_render_copy (y-tiled-to-vebox-linear)
[664.066937] Starting subtest: y-tiled-to-vebox-linear
[664.072242] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[664.251206] [107/133] (369s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[664.353653] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[664.358718] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[664.452430] [108/133] (369s left) gem_exec_params (cliprects-invalid)
[664.507582] Starting subtest: cliprects-invalid
[664.510156] Subtest cliprects-invalid: SUCCESS (0.000s)
[664.603452] [109/133] (369s left) gem_mmap (bad-object)
[664.676698] Subtest bad-object: SKIP (0.000s)
[664.738255] [110/133] (369s left) dmabuf_sync_file (export-basic)
[664.778650] Starting subtest: export-basic
[664.780605] Subtest export-basic: SUCCESS (0.001s)
[664.835281] [111/133] (368s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[664.929423] Starting subtest: compare-crc-sanitycheck-xr24
[664.931691] Starting dynamic subtest: pipe-A-eDP-1
[665.616216] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.687s)
[665.627723] Starting dynamic subtest: pipe-B-eDP-1
[666.900910] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.282s)
[666.911664] Starting dynamic subtest: pipe-C-eDP-1
[668.175915] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.274s)
[668.187146] Starting dynamic subtest: pipe-D-eDP-1
[669.386728] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.212s)
[669.389518] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.461s)
[670.230159] [112/133] (363s left) kms_psr (psr-primary-page-flip)
[670.319931] Starting subtest: psr-primary-page-flip
[670.322659] Starting dynamic subtest: eDP-1
[672.119333] Dynamic subtest eDP-1: SUCCESS (1.800s)
[672.121806] Subtest psr-primary-page-flip: SUCCESS (1.801s)
[672.981346] [113/133] (360s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[673.080343] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[673.082720] Starting dynamic subtest: pipe-A-eDP-1
[673.103817] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[673.114206] Starting dynamic subtest: pipe-B-eDP-1
[673.135026] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[673.144713] Starting dynamic subtest: pipe-C-eDP-1
[673.165460] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[673.174690] Starting dynamic subtest: pipe-D-eDP-1
[673.195305] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[673.197693] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[675.258032] [114/133] (358s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[675.309089] Starting subtest: multi-wait-available-submitted-signaled
[675.311715] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s)
[675.393104] [115/133] (358s left) kms_psr (psr-cursor-blt)
[675.489629] Starting subtest: psr-cursor-blt
[675.492310] Starting dynamic subtest: eDP-1
[677.266458] Dynamic subtest eDP-1: SUCCESS (1.776s)
[677.268828] Subtest psr-cursor-blt: SUCCESS (1.777s)
[678.133669] [116/133] (355s left) kms_pm_rpm (drm-resources-equal)
[680.261522] Starting subtest: drm-resources-equal
[685.291744] Subtest drm-resources-equal: SUCCESS (5.034s)
[685.394140] [117/133] (348s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[685.496961] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[685.502450] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[685.594411] [118/133] (348s left) gem_exec_balancer (parallel)
[685.850858] Starting subtest: parallel
[686.792458] Subtest parallel: SUCCESS (0.942s)
[687.224657] [119/133] (346s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[687.330747] Starting subtest: sprite-rotation-90-pos-100-0
[687.335772] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[687.406623] [120/133] (346s left) kms_plane_multiple (tiling-none)
[687.498633] Starting subtest: tiling-none
[687.501076] Starting dynamic subtest: pipe-A-eDP-1
[691.242381] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.744s)
[691.253196] Starting dynamic subtest: pipe-B-eDP-1
[695.588923] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.345s)
[695.600522] Starting dynamic subtest: pipe-C-eDP-1
[699.929831] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.338s)
[699.940939] Starting dynamic subtest: pipe-D-eDP-1
[704.268703] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.339s)
[704.271405] Subtest tiling-none: SUCCESS (16.771s)
[705.075429] [121/133] (329s left) kms_psr (fbc-psr2-cursor-plane-move)
[705.179608] Starting subtest: fbc-psr2-cursor-plane-move
[705.182075] Starting dynamic subtest: eDP-1
[705.186812] Dynamic subtest eDP-1: SKIP (0.000s)
[705.191449] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s)
[705.255120] [122/133] (329s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[705.370499] Starting subtest: flip-vs-cursor-varying-size
[714.120802] Subtest flip-vs-cursor-varying-size: SUCCESS (8.748s)
[715.002288] [123/133] (319s left) kms_chamelium_color (degamma)
[715.096540] Subtest degamma: SKIP (0.000s)
[715.149084] [124/133] (319s left) gem_exec_schedule (smoketest-all)
[715.214278] Starting subtest: smoketest-all
[747.625898] Subtest smoketest-all: SUCCESS (32.351s)
[749.172361] [125/133] (285s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[749.269846] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[749.275202] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[749.360766] [126/133] (285s left) gen7_exec_parse (bitmasks)
[749.420766] Subtest bitmasks: SKIP (0.000s)
[749.490981] [127/133] (285s left) gem_userptr_blits (sync-unmap-after-close)
[749.554950] Starting subtest: sync-unmap-after-close
[749.565596] Subtest sync-unmap-after-close: SUCCESS (0.011s)
[749.681859] [128/133] (284s left) gem_ccs (suspend-resume)
[749.739932] Starting subtest: suspend-resume
[749.744778] Subtest suspend-resume: SKIP (0.000s)
[749.833467] [129/133] (284s left) kms_big_fb (linear-32bpp-rotate-180)
[749.943470] Starting subtest: linear-32bpp-rotate-180
[751.556575] Subtest linear-32bpp-rotate-180: SUCCESS (1.612s)
[751.683155] [130/133] (282s left) kms_cursor_crc (cursor-random-64x64)
[751.892701] Starting subtest: cursor-random-64x64
[751.894808] Starting dynamic subtest: pipe-A-eDP-1
[755.237492] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.343s)
[755.269024] Starting dynamic subtest: pipe-D-eDP-1
[759.286957] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.027s)
[759.289916] Subtest cursor-random-64x64: SUCCESS (7.395s)
[760.092407] [131/133] (274s left) gem_pxp (fail-invalid-protected-context)
[760.211669] Starting subtest: fail-invalid-protected-context
[760.214843] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[760.319114] [132/133] (274s left) gem_exec_params (invalid-bsd-ring)
[760.375097] Starting subtest: invalid-bsd-ring
[760.377960] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[760.477054] [133/133] (274s left) gem_render_copy_redux (flink)
[760.530478] Starting subtest: flink
[761.356217] Subtest flink: SUCCESS (0.827s)
[761.478532] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_balancer
results: parsing output: 1/ for test: gem_softpin
results: parsing output: 2/ for test: kms_cursor_crc
results: parsing output: 3/ for test: gem_ctx_exec
results: parsing output: 4/ for test: gem_exec_schedule
results: parsing output: 5/ for test: kms_psr2_sf
results: parsing output: 6/ for test: kms_cursor_legacy
results: parsing output: 7/ for test: gem_eio
results: parsing output: 8/ for test: kms_psr
results: parsing output: 9/ for test: i915_drm_fdinfo
results: parsing output: 10/ for test: kms_ccs
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_ctx_persistence
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_basic
results: parsing output: 15/ for test: gem_partial_pwrite_pread
results: parsing output: 16/ for test: api_intel_bb
results: parsing output: 17/ for test: kms_chamelium_hpd
results: parsing output: 18/ for test: gem_exec_fence
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: gem_lmem_swapping
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: kms_cursor_crc
results: parsing output: 23/ for test: kms_atomic
results: parsing output: 24/ for test: gem_exec_schedule
results: parsing output: 25/ for test: kms_properties
results: parsing output: 26/ for test: kms_dsc
results: parsing output: 27/ for test: perf
results: parsing output: 28/ for test: kms_flip
results: parsing output: 29/ for test: kms_plane_scaling
results: parsing output: 30/ for test: i915_hangman
results: parsing output: 31/ for test: syncobj_wait
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: gem_userptr_blits
results: parsing output: 34/ for test: gem_exec_nop
results: parsing output: 35/ for test: gem_ctx_shared
results: parsing output: 36/ for test: gem_exec_reloc
results: parsing output: 37/ for test: gem_mmap_gtt
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: syncobj_timeline
results: parsing output: 40/ for test: gem_ctx_param
results: parsing output: 41/ for test: kms_addfb_basic
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gem_exec_params
results: parsing output: 44/ for test: gem_exec_whisper
results: parsing output: 45/ for test: i915_pm_rpm
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: i915_selftest
results: parsing output: 48/ for test: kms_properties
results: parsing output: 49/ for test: kms_flip_scaled_crc
results: parsing output: 50/ for test: sysfs_heartbeat_interval
results: parsing output: 51/ for test: kms_flip
results: parsing output: 52/ for test: kms_pm_rpm
results: parsing output: 53/ for test: perf
results: parsing output: 54/ for test: gem_userptr_blits
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_partial_pwrite_pread
results: parsing output: 57/ for test: kms_flip_scaled_crc
results: parsing output: 58/ for test: gem_mmap
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: perf_pmu
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: gem_ctx_isolation
results: parsing output: 63/ for test: kms_vblank
results: parsing output: 64/ for test: syncobj_timeline
results: parsing output: 65/ for test: kms_plane
results: parsing output: 66/ for test: kms_atomic_interruptible
results: parsing output: 67/ for test: kms_legacy_colorkey
results: parsing output: 68/ for test: kms_psr2_sf
results: parsing output: 69/ for test: kms_psr
results: parsing output: 70/ for test: kms_vblank
results: parsing output: 71/ for test: prime_vgem
results: parsing output: 72/ for test: kms_color
results: parsing output: 73/ for test: api_intel_bb
results: parsing output: 74/ for test: gem_workarounds
results: parsing output: 75/ for test: kms_flip
results: parsing output: 76/ for test: kms_content_protection
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: fbdev
results: parsing output: 80/ for test: gem_exec_reloc
results: parsing output: 81/ for test: kms_chamelium_audio
results: parsing output: 82/ for test: kms_plane
results: parsing output: 83/ for test: kms_cursor_legacy
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_render_copy
results: parsing output: 88/ for test: kms_psr2_sf
results: parsing output: 89/ for test: kms_cursor_legacy
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_pipe_b_c_ivb
results: parsing output: 94/ for test: kms_invalid_mode
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gem_exec_params
results: parsing output: 98/ for test: perf
results: parsing output: 99/ for test: gem_mmap_gtt
results: parsing output: 100/ for test: gem_exec_params
results: parsing output: 101/ for test: gem_fenced_exec_thrash
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: syncobj_timeline
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: gem_render_copy
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_exec_params
results: parsing output: 108/ for test: gem_mmap
results: parsing output: 109/ for test: dmabuf_sync_file
results: parsing output: 110/ for test: kms_pipe_crc_basic
results: parsing output: 111/ for test: kms_psr
results: parsing output: 112/ for test: kms_ccs
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: kms_pm_rpm
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: gem_exec_balancer
results: parsing output: 118/ for test: kms_rotation_crc
results: parsing output: 119/ for test: kms_plane_multiple
results: parsing output: 120/ for test: kms_psr
results: parsing output: 121/ for test: kms_cursor_legacy
results: parsing output: 122/ for test: kms_chamelium_color
results: parsing output: 123/ for test: gem_exec_schedule
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: gen7_exec_parse
results: parsing output: 126/ for test: gem_userptr_blits
results: parsing output: 127/ for test: gem_ccs
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: kms_cursor_crc
results: parsing output: 130/ for test: gem_pxp
results: parsing output: 131/ for test: gem_exec_params
results: parsing output: 132/ for test: gem_render_copy_redux
Done.