[56.741871] Initializing watchdogs
[56.741948]   /dev/watchdog0
[56.761473] [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]
[56.765636] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.767848] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.770951] [001/131] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[56.896210] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[56.900386] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[57.007476] [002/131] (960s left) api_intel_bb (render)
[57.066785] Starting subtest: render
[57.069108] Starting dynamic subtest: render-none-512
[57.170883] Dynamic subtest render-none-512: SUCCESS (0.104s)
[57.177318] Starting dynamic subtest: render-none-1024
[57.549938] Dynamic subtest render-none-1024: SUCCESS (0.375s)
[57.557041] Starting dynamic subtest: render-x-512
[57.634115] Dynamic subtest render-x-512: SUCCESS (0.084s)
[57.642756] Starting dynamic subtest: render-x-1024
[57.995333] Dynamic subtest render-x-1024: SUCCESS (0.359s)
[58.004941] Starting dynamic subtest: render-y-512
[58.081229] Dynamic subtest render-y-512: SUCCESS (0.084s)
[58.090737] Starting dynamic subtest: render-y-1024
[58.417447] Dynamic subtest render-y-1024: SUCCESS (0.333s)
[58.420667] Subtest render: SUCCESS (1.342s)
[58.552844] [003/131] (958s left) intel_hwmon (hwmon-read)
[58.613034] Subtest hwmon-read: SKIP (0.000s)
[58.667727] [004/131] (958s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[58.771546] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[63.249249] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.466s)
[64.458779] [005/131] (952s left) kms_psr (pr-sprite-render)
[64.573070] Starting subtest: pr-sprite-render
[64.577048] Subtest pr-sprite-render: SKIP (0.000s)
[64.664027] [006/131] (952s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[64.753288] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[64.757811] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[64.879165] [007/131] (952s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[64.987218] Starting subtest: cursorA-vs-flipA-atomic
[76.175486] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.177s)
[76.987033] [008/131] (940s left) fbdev (eof)
[77.034859] Starting subtest: eof
[77.037329] Subtest eof: SUCCESS (0.000s)
[77.132559] [009/131] (940s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[77.185059] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[77.187476] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[77.320404] [010/131] (940s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[77.427422] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[86.632344] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.207s)
[86.793078] [011/131] (930s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[86.900443] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[86.902787] Starting dynamic subtest: pipe-A-default-mode
[89.651702] Dynamic subtest pipe-A-default-mode: SUCCESS (2.752s)
[89.654081] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.753s)
[90.504174] [012/131] (927s left) gem_userptr_blits (huge-split)
[90.594766] Starting subtest: huge-split
[90.600583] Subtest huge-split: SUCCESS (0.006s)
[90.772677] [013/131] (926s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[90.896149] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[90.940751] [014/131] (926s left) kms_chamelium_frames (dp-crc-multiple)
[91.312980] Subtest dp-crc-multiple: SKIP (0.000s)
[92.090234] [015/131] (925s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[92.190449] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[92.192926] Starting dynamic subtest: pipe-A-eDP-1
[92.215821] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[92.225832] Starting dynamic subtest: pipe-B-eDP-1
[92.249385] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[92.257259] Starting dynamic subtest: pipe-C-eDP-1
[92.278092] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[92.285430] Starting dynamic subtest: pipe-D-eDP-1
[92.307231] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[92.311592] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[94.389896] [016/131] (923s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[94.491711] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[101.207032] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.717s)
[101.386737] [017/131] (916s left) gem_mmap_wc (bad-size)
[101.461611] Subtest bad-size: SKIP (0.000s)
[101.529416] [018/131] (916s left) kms_fence_pin_leak
[101.721476] [019/131] (916s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[101.819909] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[101.822281] Starting dynamic subtest: pipe-A
[102.169693] Dynamic subtest pipe-A: SUCCESS (0.353s)
[102.176266] Starting dynamic subtest: pipe-B
[103.603348] Dynamic subtest pipe-B: SUCCESS (1.433s)
[103.611304] Starting dynamic subtest: pipe-C
[105.006558] Dynamic subtest pipe-C: SUCCESS (1.402s)
[105.014823] Starting dynamic subtest: pipe-D
[106.455308] Dynamic subtest pipe-D: SUCCESS (1.448s)
[106.457649] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.638s)
[107.624300] [020/131] (910s left) kms_plane (plane-panning-bottom-right-suspend)
[107.729546] Starting subtest: plane-panning-bottom-right-suspend
[107.731936] Starting dynamic subtest: pipe-A
[125.327907] Dynamic subtest pipe-A: SUCCESS (6.575s)
[125.336824] Starting dynamic subtest: pipe-B
[144.346603] Dynamic subtest pipe-B: SUCCESS (3.577s)
[144.348821] Subtest plane-panning-bottom-right-suspend: SUCCESS (10.154s)
[145.173822] [021/131] (872s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[145.291777] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[145.295965] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[145.421457] [022/131] (872s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[145.540704] Starting subtest: short-busy-flip-before-cursor-toggle
[145.545315] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[145.712826] [023/131] (872s left) gem_spin_batch (resubmit-new-all)
[145.774131] Starting subtest: resubmit-new-all
[145.776638] Starting dynamic subtest: rcs0
[145.789056] Dynamic subtest rcs0: SUCCESS (0.014s)
[145.799426] Starting dynamic subtest: bcs0
[145.801830] Dynamic subtest bcs0: SUCCESS (0.010s)
[145.809110] Starting dynamic subtest: vcs0
[145.811461] Dynamic subtest vcs0: SUCCESS (0.009s)
[145.818860] Starting dynamic subtest: vcs1
[145.821078] Dynamic subtest vcs1: SUCCESS (0.008s)
[145.828446] Starting dynamic subtest: vecs0
[145.830400] Dynamic subtest vecs0: SUCCESS (0.008s)
[145.838137] Starting dynamic subtest: ccs0
[145.840047] Dynamic subtest ccs0: SUCCESS (0.008s)
[145.841972] Subtest resubmit-new-all: SUCCESS (0.060s)
[147.368399] [024/131] (870s left) kms_lease (cursor-implicit-plane)
[147.471745] Starting subtest: cursor-implicit-plane
[147.474079] Starting dynamic subtest: pipe-A-eDP-1
[147.937597] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.459s)
[147.946627] Starting dynamic subtest: pipe-B-eDP-1
[149.030589] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.076s)
[149.038766] Starting dynamic subtest: pipe-C-eDP-1
[150.161043] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.114s)
[150.170352] Starting dynamic subtest: pipe-D-eDP-1
[151.296682] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.123s)
[151.298722] Subtest cursor-implicit-plane: SUCCESS (3.777s)
[152.194625] [025/131] (866s left) gem_exec_whisper (basic-forked-all)
[152.270163] Starting subtest: basic-forked-all
[166.318015] Subtest basic-forked-all: SUCCESS (13.985s)
[166.522022] [026/131] (851s left) kms_flip (nonexisting-fb)
[166.626829] Starting subtest: nonexisting-fb
[166.629118] Starting dynamic subtest: A-eDP1
[167.822526] Dynamic subtest A-eDP1: SUCCESS (1.196s)
[167.833438] Starting dynamic subtest: B-eDP1
[168.955833] Dynamic subtest B-eDP1: SUCCESS (1.130s)
[168.969516] Starting dynamic subtest: C-eDP1
[170.085435] Dynamic subtest C-eDP1: SUCCESS (1.126s)
[170.094573] Starting dynamic subtest: D-eDP1
[171.210148] Dynamic subtest D-eDP1: SUCCESS (1.122s)
[171.212565] Subtest nonexisting-fb: SUCCESS (4.583s)
[172.416489] [027/131] (845s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[172.545082] Starting subtest: x-tiled-16bpp-rotate-180
[173.793541] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.245s)
[173.945714] [028/131] (844s left) i915_drm_fdinfo (virtual-idle)
[173.984721] Starting subtest: virtual-idle
[177.068777] Subtest virtual-idle: SUCCESS (3.083s)
[177.170171] [029/131] (841s left) gem_caching (reads)
[177.242803] Subtest reads: SKIP (0.000s)
[177.316198] [030/131] (841s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[177.362027] Starting subtest: wait-all-for-submit-delayed-submit
[177.466719] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[177.572609] [031/131] (840s left) kms_hdmi_inject (inject-4k)
[177.927927] Starting subtest: inject-4k
[178.239722] Subtest inject-4k: SUCCESS (0.312s)
[178.790749] [032/131] (839s left) gem_lmem_swapping (parallel-random-engines)
[178.828826] Subtest parallel-random-engines: SKIP (0.000s)
[178.867414] [033/131] (839s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[178.975924] Starting subtest: yf-tiled-64bpp-rotate-270
[178.979950] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[179.101123] [034/131] (839s left) gem_exec_reloc (basic-write-read-noreloc)
[179.161567] Subtest basic-write-read-noreloc: SKIP (0.000s)
[179.234443] [035/131] (839s left) kms_cursor_crc (cursor-onscreen-64x21)
[179.420510] Starting subtest: cursor-onscreen-64x21
[179.465714] Subtest cursor-onscreen-64x21: SKIP (0.040s)
[179.743676] [036/131] (838s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[179.850940] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[179.852817] Starting dynamic subtest: pipe-A-eDP-1
[181.838991] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.990s)
[181.848892] Starting dynamic subtest: pipe-B-eDP-1
[184.081086] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.240s)
[184.090863] Starting dynamic subtest: pipe-C-eDP-1
[186.119136] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.036s)
[186.129529] Starting dynamic subtest: pipe-D-eDP-1
[188.104159] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.986s)
[188.106482] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.257s)
[189.344445] [037/131] (829s left) gem_exec_schedule (pi-shared-iova)
[189.532484] Starting subtest: pi-shared-iova
[189.534777] Starting dynamic subtest: rcs0
[189.602129] Dynamic subtest rcs0: SUCCESS (0.073s)
[189.611772] Starting dynamic subtest: vcs0
[189.658649] Dynamic subtest vcs0: SUCCESS (0.054s)
[189.668990] Starting dynamic subtest: vcs1
[189.710245] Dynamic subtest vcs1: SUCCESS (0.051s)
[189.722042] Starting dynamic subtest: vecs0
[189.763096] Dynamic subtest vecs0: SUCCESS (0.052s)
[189.772350] Starting dynamic subtest: ccs0
[189.820694] Dynamic subtest ccs0: SUCCESS (0.057s)
[189.823269] Subtest pi-shared-iova: SUCCESS (0.292s)
[191.402920] [038/131] (827s left) gem_exec_schedule (submit-late-slice)
[191.479982] Starting subtest: submit-late-slice
[191.481890] Starting dynamic subtest: rcs0
[191.511711] Dynamic subtest rcs0: SUCCESS (0.035s)
[191.522986] Starting dynamic subtest: bcs0
[191.544330] Dynamic subtest bcs0: SUCCESS (0.032s)
[191.553892] Starting dynamic subtest: vcs0
[191.572937] Dynamic subtest vcs0: SUCCESS (0.028s)
[191.583691] Starting dynamic subtest: vcs1
[191.599259] Dynamic subtest vcs1: SUCCESS (0.026s)
[191.607660] Starting dynamic subtest: vecs0
[191.629118] Dynamic subtest vecs0: SUCCESS (0.029s)
[191.637393] Starting dynamic subtest: ccs0
[191.660236] Dynamic subtest ccs0: SUCCESS (0.031s)
[191.662586] Subtest submit-late-slice: SUCCESS (0.185s)
[193.448945] [039/131] (825s left) kms_psr (psr-suspend)
[193.556276] Starting subtest: psr-suspend
[193.558548] Starting dynamic subtest: eDP-1
[211.353010] Dynamic subtest eDP-1: SUCCESS (2.950s)
[211.355478] Subtest psr-suspend: SUCCESS (2.952s)
[212.266865] [040/131] (806s left) kms_pipe_crc_basic (hang-read-crc)
[212.367434] Starting subtest: hang-read-crc
[212.369714] Starting dynamic subtest: pipe-A-eDP-1
[214.440746] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.033s)
[214.450507] Starting dynamic subtest: pipe-B-eDP-1
[217.301780] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.823s)
[217.311410] Starting dynamic subtest: pipe-C-eDP-1
[219.954621] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.623s)
[219.963859] Starting dynamic subtest: pipe-D-eDP-1
[222.557205] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.585s)
[222.559742] Subtest hang-read-crc: SUCCESS (10.069s)
[223.399062] [041/131] (795s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[223.611743] Starting subtest: cursor-rapid-movement-128x128
[223.617488] Starting dynamic subtest: pipe-A-eDP-1
[224.152187] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.531s)
[224.176437] Starting dynamic subtest: pipe-D-eDP-1
[225.364979] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.190s)
[225.367440] Subtest cursor-rapid-movement-128x128: SUCCESS (1.745s)
[226.215520] [042/131] (792s left) api_intel_allocator (open-vm)
[226.283005] Starting subtest: open-vm
[226.285433] Subtest open-vm: SUCCESS (0.003s)
[226.437797] [043/131] (792s left) kms_properties (plane-properties-atomic)
[226.543594] Starting subtest: plane-properties-atomic
[226.545859] Starting dynamic subtest: pipe-A-eDP-1
[227.097007] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.551s)
[227.106605] Starting dynamic subtest: pipe-B-eDP-1
[228.332390] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.231s)
[228.341465] Starting dynamic subtest: pipe-C-eDP-1
[229.623183] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.285s)
[229.631670] Starting dynamic subtest: pipe-D-eDP-1
[230.931179] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.304s)
[230.933962] Subtest plane-properties-atomic: SUCCESS (4.377s)
[231.824657] [044/131] (787s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[231.894970] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[231.961676] [045/131] (787s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[232.057511] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[238.698897] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.636s)
[238.835287] [046/131] (780s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[238.943182] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[243.150665] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.209s)
[244.352188] [047/131] (774s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[244.921139] Starting subtest: syncobj-stationary-timeline-chain-engines
[245.049127] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.128s)
[246.249150] [FACT gem_exec_fence (syncobj-stationary-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true
[246.252399] [048/131] (772s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[246.346205] Starting subtest: fbc-psr2-cursor-plane-onoff
[246.348440] Starting dynamic subtest: eDP-1
[246.352505] Dynamic subtest eDP-1: SKIP (0.000s)
[246.356721] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s)
[246.443611] [049/131] (772s left) perf (polling)
[246.585278] Starting subtest: polling
[246.587548] Starting dynamic subtest: 0-rcs0
[256.618226] Dynamic subtest 0-rcs0: SUCCESS (10.030s)
[256.628165] Starting dynamic subtest: 1-vcs0
[266.643811] Dynamic subtest 1-vcs0: SUCCESS (10.022s)
[266.646645] Subtest polling: SUCCESS (20.055s)
[266.693735] [050/131] (752s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[266.761305] Starting subtest: y-tiled-to-vebox-y-tiled
[266.765891] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[266.974043] [051/131] (752s left) kms_frontbuffer_tracking (fbc-stridechange)
[267.082200] Starting subtest: fbc-stridechange
[270.420039] Subtest fbc-stridechange: SUCCESS (3.340s)
[271.563784] [052/131] (747s left) perf_pmu (idle-no-semaphores)
[271.603246] Starting subtest: idle-no-semaphores
[271.606002] Starting dynamic subtest: rcs0
[272.170588] Dynamic subtest rcs0: SUCCESS (0.567s)
[272.183056] Starting dynamic subtest: bcs0
[272.701817] Dynamic subtest bcs0: SUCCESS (0.527s)
[272.712664] Starting dynamic subtest: vcs0
[273.235933] Dynamic subtest vcs0: SUCCESS (0.532s)
[273.246819] Starting dynamic subtest: vcs1
[273.761802] Dynamic subtest vcs1: SUCCESS (0.523s)
[273.772632] Starting dynamic subtest: vecs0
[274.289679] Dynamic subtest vecs0: SUCCESS (0.525s)
[274.300131] Starting dynamic subtest: ccs0
[274.818889] Dynamic subtest ccs0: SUCCESS (0.526s)
[274.821867] Subtest idle-no-semaphores: SUCCESS (3.217s)
[274.964789] [053/131] (744s left) gen9_exec_parse (shadow-peek)
[275.031728] Subtest shadow-peek: SKIP (0.000s)
[275.119384] [054/131] (744s left) gem_exec_balancer (nohangcheck)
[275.372209] Starting subtest: nohangcheck
[276.265312] Subtest nohangcheck: SUCCESS (0.893s)
[276.401463] [055/131] (742s left) gem_exec_flush (basic-wb-prw-default)
[276.479810] Starting subtest: basic-wb-prw-default
[281.978530] Subtest basic-wb-prw-default: SUCCESS (5.499s)
[282.187782] [056/131] (737s left) gem_readwrite (write-bad-handle)
[282.247538] Subtest write-bad-handle: SKIP (0.000s)
[282.318055] [057/131] (737s left) kms_pm_rpm (modeset-non-lpsp-stress)
[284.337033] Starting subtest: modeset-non-lpsp-stress
[285.495998] Subtest modeset-non-lpsp-stress: SKIP (1.157s)
[285.887283] [058/131] (733s left) gem_mmap_offset (blt-coherency)
[285.934386] Starting subtest: blt-coherency
[285.943781] Subtest blt-coherency: SUCCESS (0.011s)
[286.101477] [059/131] (733s left) gem_exec_reloc (basic-write-cpu-noreloc)
[286.160096] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[286.252100] [060/131] (733s left) gem_ctx_engines (independent)
[286.318130] Starting subtest: independent
[286.320260] Starting dynamic subtest: rcs0
[286.455999] Dynamic subtest rcs0: SUCCESS (0.136s)
[286.464891] Starting dynamic subtest: bcs0
[286.594107] Dynamic subtest bcs0: SUCCESS (0.137s)
[286.604811] Starting dynamic subtest: vcs0
[286.746675] Dynamic subtest vcs0: SUCCESS (0.151s)
[286.755629] Starting dynamic subtest: vcs1
[286.912218] Dynamic subtest vcs1: SUCCESS (0.166s)
[286.920967] Starting dynamic subtest: vecs0
[287.076217] Dynamic subtest vecs0: SUCCESS (0.162s)
[287.085473] Starting dynamic subtest: ccs0
[287.257079] Dynamic subtest ccs0: SUCCESS (0.180s)
[287.266220] Starting dynamic subtest: all-engines
[288.059639] Dynamic subtest all-engines: SUCCESS (0.802s)
[288.061993] Subtest independent: SUCCESS (1.742s)
[288.366685] [061/131] (731s left) kms_pm_dc (dc5-dpms-negative)
[289.479623] Starting subtest: dc5-dpms-negative
[289.484254] Subtest dc5-dpms-negative: SKIP (0.000s)
[289.575779] [062/131] (730s left) perf_pmu (render-node-busy-idle)
[289.666694] Starting subtest: render-node-busy-idle
[289.669247] Starting dynamic subtest: rcs0
[290.386024] Dynamic subtest rcs0: SUCCESS (0.722s)
[290.397224] Starting dynamic subtest: bcs0
[291.057536] Dynamic subtest bcs0: SUCCESS (0.669s)
[291.068407] Starting dynamic subtest: vcs0
[293.160622] Dynamic subtest vcs0: SUCCESS (2.099s)
[293.173231] Starting dynamic subtest: vcs1
[295.143871] Dynamic subtest vcs1: SUCCESS (1.980s)
[295.155016] Starting dynamic subtest: vecs0
[297.127592] Dynamic subtest vecs0: SUCCESS (1.981s)
[297.138872] Starting dynamic subtest: ccs0
[297.806287] Dynamic subtest ccs0: SUCCESS (0.678s)
[297.808833] Subtest render-node-busy-idle: SUCCESS (8.142s)
[297.908056] [063/131] (721s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[298.012942] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[298.017553] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[298.156455] [064/131] (721s left) gem_exercise_blt (fast-copy-emit)
[298.221381] Starting subtest: fast-copy-emit
[298.223563] Starting dynamic subtest: linear-smem-smem-emit
[298.245208] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.023s)
[298.254148] Starting dynamic subtest: xmajor-smem-smem-emit
[298.261357] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.016s)
[298.269923] Starting dynamic subtest: tile4-smem-smem-emit
[298.277430] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.015s)
[298.285812] Starting dynamic subtest: tile64-smem-smem-emit
[298.294890] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.017s)
[298.297069] Subtest fast-copy-emit: SUCCESS (0.074s)
[298.442027] [065/131] (721s left) sw_sync (timeline_closed)
[298.480878] Starting subtest: timeline_closed
[298.482779] Subtest timeline_closed: SUCCESS (0.000s)
[298.560462] [066/131] (721s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[298.686245] Starting subtest: basic-flip-after-cursor-atomic
[299.607930] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.920s)
[300.445201] [067/131] (719s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[300.550743] Starting subtest: y-tiled-8bpp-rotate-180
[300.555088] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[300.687673] [068/131] (719s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[300.783665] Starting subtest: flip-vs-dpms-on-nop-interruptible
[300.786009] Starting dynamic subtest: A-eDP1
[302.591136] Dynamic subtest A-eDP1: SUCCESS (1.806s)
[302.602481] Starting dynamic subtest: B-eDP1
[304.383282] Dynamic subtest B-eDP1: SUCCESS (1.790s)
[304.398109] Starting dynamic subtest: C-eDP1
[306.166964] Dynamic subtest C-eDP1: SUCCESS (1.781s)
[306.176363] Starting dynamic subtest: D-eDP1
[307.973113] Dynamic subtest D-eDP1: SUCCESS (1.804s)
[307.979868] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.192s)
[309.248296] [069/131] (710s left) kms_psr2_su (page_flip-xrgb8888)
[309.300411] Subtest page_flip-XRGB8888: SKIP (0.000s)
[309.366837] [070/131] (710s left) kms_vrr (max-min)
[309.457491] Starting subtest: max-min
[309.464105] Subtest max-min: SKIP (0.000s)
[309.556731] [071/131] (710s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[309.680590] Starting subtest: flip-vs-cursor-atomic
[316.628070] Subtest flip-vs-cursor-atomic: SUCCESS (6.945s)
[317.449098] [072/131] (702s left) gem_exec_reloc (basic-gtt)
[317.527071] Subtest basic-gtt: SKIP (0.000s)
[317.638290] [073/131] (702s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[317.730637] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[317.732994] Starting dynamic subtest: pipe-A-eDP-1
[317.756485] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[317.775988] Starting dynamic subtest: pipe-B-eDP-1
[317.797924] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[317.816598] Starting dynamic subtest: pipe-C-eDP-1
[317.838540] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[317.857666] Starting dynamic subtest: pipe-D-eDP-1
[317.881006] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[317.885410] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[319.950972] [074/131] (700s left) gen9_exec_parse (bb-secure)
[320.020304] Subtest bb-secure: SKIP (0.000s)
[320.095660] [075/131] (700s left) kms_content_protection (type1)
[320.247336] Starting subtest: type1
[320.251957] Subtest type1: SKIP (0.000s)
[320.417306] [076/131] (699s left) vgem_basic (sysfs)
[320.465609] Starting subtest: sysfs
[320.467433] Subtest sysfs: SUCCESS (0.000s)
[320.547662] [077/131] (699s left) syncobj_eventfd (binary-wait)
[320.603531] Starting subtest: binary-wait
[320.611562] Subtest binary-wait: SUCCESS (0.010s)
[320.738101] [078/131] (699s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[321.122672] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[321.911506] [079/131] (698s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[322.014304] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[322.018671] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[322.138921] [080/131] (698s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[322.240538] Starting subtest: plane-ctm3x4-lut1d
[322.252554] Starting dynamic subtest: pipe-A-eDP-1
[322.928170] Dynamic subtest pipe-A-eDP-1: FAIL (0.312s)
[323.670114] Starting dynamic subtest: pipe-B-eDP-1
[324.461990] Dynamic subtest pipe-B-eDP-1: FAIL (0.280s)
[325.068642] Starting dynamic subtest: pipe-C-eDP-1
[325.885154] Dynamic subtest pipe-C-eDP-1: FAIL (0.235s)
[326.371947] Starting dynamic subtest: pipe-D-eDP-1
[327.205557] Dynamic subtest pipe-D-eDP-1: FAIL (0.258s)
[327.207915] Subtest plane-ctm3x4-lut1d: FAIL (4.681s)
[327.748962] [081/131] (692s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[327.849107] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[327.851407] Starting dynamic subtest: A-eDP1
[336.742817] Dynamic subtest A-eDP1: SUCCESS (8.890s)
[336.753248] Starting dynamic subtest: B-eDP1
[345.647395] Dynamic subtest B-eDP1: SUCCESS (8.900s)
[345.657988] Starting dynamic subtest: C-eDP1
[354.541311] Dynamic subtest C-eDP1: SUCCESS (8.888s)
[354.552804] Starting dynamic subtest: D-eDP1
[363.438853] Dynamic subtest D-eDP1: SUCCESS (8.893s)
[363.441276] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.579s)
[364.658319] [082/131] (655s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[364.764115] Starting subtest: psr-2p-primscrn-spr-indfb-move
[364.768412] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[364.879282] [083/131] (655s left) kms_cursor_edge_walk (256x256-top-bottom)
[364.973128] Starting subtest: 256x256-top-bottom
[364.975340] Starting dynamic subtest: pipe-A-eDP-1
[368.466478] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.489s)
[368.477134] Starting dynamic subtest: pipe-D-eDP-1
[371.663198] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.195s)
[371.665404] Subtest 256x256-top-bottom: SUCCESS (6.687s)
[372.564106] [084/131] (648s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[372.693815] Starting subtest: 2x-long-cursor-vs-flip-legacy
[372.698439] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.001s)
[372.863330] [085/131] (647s left) kms_flip (flip-vs-modeset-vs-hang)
[372.961699] Starting subtest: flip-vs-modeset-vs-hang
[372.963892] Starting dynamic subtest: A-eDP1
[412.601591] Dynamic subtest A-eDP1: SUCCESS (39.638s)
[412.614093] Starting dynamic subtest: D-eDP1
[462.590492] Dynamic subtest D-eDP1: SUCCESS (50.006s)
[462.592553] Subtest flip-vs-modeset-vs-hang: SUCCESS (89.650s)
[463.010357] [086/131] (557s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[463.411609] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[464.190230] [087/131] (556s left) gem_pxp (reject-modify-context-protection-off-3)
[464.322053] Starting subtest: reject-modify-context-protection-off-3
[464.324737] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[464.458740] [088/131] (556s left) kms_big_fb (linear-16bpp-rotate-0)
[464.567048] Starting subtest: linear-16bpp-rotate-0
[465.869221] Subtest linear-16bpp-rotate-0: SUCCESS (1.301s)
[466.037237] [089/131] (554s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[466.138540] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[474.601649] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.466s)
[474.731434] [090/131] (546s left) gem_exec_reloc (basic-active)
[474.793213] Subtest basic-active: SKIP (0.000s)
[474.865531] [091/131] (546s left) syncobj_timeline (reset-unsignaled)
[474.923381] Starting subtest: reset-unsignaled
[474.925632] Subtest reset-unsignaled: SUCCESS (0.000s)
[475.048880] [092/131] (545s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[475.154549] Starting subtest: fbcpsr-shrfb-scaledprimary
[480.906393] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.754s)
[481.056556] [093/131] (539s left) syncobj_timeline (invalid-wait-bad-flags)
[481.117750] Starting subtest: invalid-wait-bad-flags
[481.120047] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[481.242597] [094/131] (539s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[481.338754] Starting subtest: fbc-rgb101010-draw-render
[485.878555] Subtest fbc-rgb101010-draw-render: SUCCESS (4.542s)
[487.048012] [095/131] (533s left) kms_hdr (bpc-switch)
[487.148982] Starting subtest: bpc-switch
[488.242140] Starting dynamic subtest: pipe-A-eDP-1
[491.645242] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.404s)
[491.647527] Subtest bpc-switch: SUCCESS (4.499s)
[491.783280] [096/131] (529s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[491.909093] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[496.340670] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.437s)
[497.542517] [097/131] (523s left) gem_exec_balancer (parallel-keep-submit-fence)
[497.800071] Starting subtest: parallel-keep-submit-fence
[498.964556] Subtest parallel-keep-submit-fence: SUCCESS (1.164s)
[499.112353] [098/131] (522s left) i915_pm_rc6_residency (rc6-idle)
[499.174837] Starting subtest: rc6-idle
[499.195952] Starting dynamic subtest: gt0-rcs0
[523.540634] Dynamic subtest gt0-rcs0: SUCCESS (24.341s)
[523.552270] Starting dynamic subtest: gt0-bcs0
[547.750444] Dynamic subtest gt0-bcs0: SUCCESS (24.209s)
[547.759405] Starting dynamic subtest: gt0-ccs0
[571.958496] Dynamic subtest gt0-ccs0: SUCCESS (24.207s)
[571.967600] Starting dynamic subtest: gt1-vcs0
[578.133426] Dynamic subtest gt1-vcs0: SUCCESS (6.169s)
[578.144385] Starting dynamic subtest: gt1-vecs0
[584.305394] Dynamic subtest gt1-vecs0: SUCCESS (6.169s)
[584.308454] Subtest rc6-idle: SUCCESS (85.131s)
[584.410862] [099/131] (436s left) prime_mmap (test_map_unmap)
[584.476975] Starting subtest: test_map_unmap
[584.478952] Starting dynamic subtest: test_map_unmap-smem
[584.505801] Dynamic subtest test_map_unmap-smem: SUCCESS (0.029s)
[584.508275] Subtest test_map_unmap: SUCCESS (0.030s)
[584.650786] [100/131] (436s left) kms_addfb_basic (invalid-set-prop-any)
[584.709170] Starting subtest: invalid-set-prop-any
[584.711480] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[584.873218] [101/131] (436s left) kms_setmode (basic)
[584.932376] Starting subtest: basic
[585.251143] Starting dynamic subtest: pipe-A-eDP-1
[587.386754] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.131s)
[587.728906] Starting dynamic subtest: pipe-B-eDP-1
[589.785338] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.060s)
[590.091546] Subtest basic: SUCCESS (5.157s)
[590.915473] [102/131] (430s left) kms_properties (colorop-properties-atomic)
[591.022437] Starting subtest: colorop-properties-atomic
[591.024386] Starting dynamic subtest: pipe-A-eDP-1
[591.383855] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.359s)
[591.394183] Starting dynamic subtest: pipe-B-eDP-1
[592.438607] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.054s)
[592.448731] Starting dynamic subtest: pipe-C-eDP-1
[593.534004] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.095s)
[593.544456] Starting dynamic subtest: pipe-D-eDP-1
[594.623424] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.088s)
[594.625728] Subtest colorop-properties-atomic: SUCCESS (3.602s)
[595.517779] [103/131] (425s left) gem_mmap_wc (read-write)
[595.591211] Subtest read-write: SKIP (0.000s)
[595.657877] [104/131] (425s left) gem_eio (kms)
[595.940159] Starting subtest: kms
[615.064992] Subtest kms: SUCCESS (19.125s)
[616.316831] [105/131] (405s left) drm_read (short-buffer-block)
[616.468179] Starting subtest: short-buffer-block
[616.470636] Subtest short-buffer-block: SUCCESS (0.000s)
[616.627533] [106/131] (404s left) gem_workarounds (reset-fd)
[616.711900] Starting subtest: reset-fd
[616.902427] Subtest reset-fd: SUCCESS (0.191s)
[617.053256] [107/131] (404s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[617.148169] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[617.152463] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[617.275593] [108/131] (404s left) kms_psr (fbc-psr-sprite-blt)
[617.375065] Starting subtest: fbc-psr-sprite-blt
[617.376965] Starting dynamic subtest: eDP-1
[617.380388] Dynamic subtest eDP-1: SKIP (0.000s)
[617.383832] Subtest fbc-psr-sprite-blt: SKIP (0.001s)
[617.477637] [109/131] (404s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[617.579988] Starting subtest: 4-tiled-16bpp-rotate-0
[618.946957] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.367s)
[619.113496] [110/131] (402s left) syncobj_timeline (invalid-signal-illegal-point)
[619.174744] Starting subtest: invalid-signal-illegal-point
[619.176814] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[619.288554] [111/131] (402s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[619.383498] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[619.385277] Starting dynamic subtest: pipe-A-eDP-1
[619.405329] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[619.414887] Starting dynamic subtest: pipe-B-eDP-1
[619.433718] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[619.442374] Starting dynamic subtest: pipe-C-eDP-1
[619.461816] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[619.471071] Starting dynamic subtest: pipe-D-eDP-1
[619.490779] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[619.494422] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[621.614442] [112/131] (400s left) kms_dsc (dsc-with-output-formats)
[621.703389] Starting subtest: dsc-with-output-formats
[621.724925] Subtest dsc-with-output-formats: SKIP (0.001s)
[621.802199] [113/131] (399s left) kms_properties (get_properties-sanity-atomic)
[621.905432] Starting subtest: get_properties-sanity-atomic
[621.907717] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[622.003071] [114/131] (399s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[622.108161] Starting subtest: 4-tiled-32bpp-rotate-90
[622.127085] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.019s)
[622.287450] [115/131] (399s left) core_setmaster (master-drop-set-root)
[622.380923] Starting subtest: master-drop-set-root
[622.391529] Subtest master-drop-set-root: SUCCESS (0.011s)
[622.439864] [116/131] (399s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[622.541777] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[622.545379] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[622.665886] [117/131] (399s left) gem_sync (basic-all)
[622.735131] Starting subtest: basic-all
[626.088467] Subtest basic-all: SUCCESS (3.359s)
[626.302436] [118/131] (395s left) gem_ctx_persistence (heartbeat-close)
[626.371667] Starting subtest: heartbeat-close
[626.376303] Subtest heartbeat-close: SKIP (0.000s)
[626.495022] [119/131] (395s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[631.576476] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[631.581083] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.002s)
[632.421939] [120/131] (389s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[632.515452] Starting subtest: primary-x-tiled-reflect-x-0
[639.727410] Subtest primary-x-tiled-reflect-x-0: SUCCESS (7.210s)
[641.016518] [121/131] (381s left) gem_eio (in-flight-external)
[641.256048] Starting subtest: in-flight-external
[643.187973] Subtest in-flight-external: SUCCESS (1.930s)
[643.351961] [122/131] (378s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[643.446438] Starting subtest: compare-crc-sanitycheck-xr24
[643.448711] Starting dynamic subtest: pipe-A-eDP-1
[644.055570] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.607s)
[644.066381] Starting dynamic subtest: pipe-B-eDP-1
[645.320041] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.265s)
[645.335814] Starting dynamic subtest: pipe-C-eDP-1
[646.591211] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.269s)
[646.607823] Starting dynamic subtest: pipe-D-eDP-1
[647.766536] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.172s)
[647.768816] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.320s)
[648.620356] [123/131] (373s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[648.697831] Subtest writes-after-reads-uncached: SKIP (0.000s)
[648.806334] [124/131] (373s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[648.898473] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[648.902401] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[649.020266] [125/131] (373s left) gem_mmap_gtt (big-bo-tiledy)
[649.085591] Subtest big-bo-tiledY: SKIP (0.000s)
[649.162806] [126/131] (373s left) i915_query (engine-info)
[649.228839] Starting subtest: engine-info
[649.234080] Subtest engine-info: SUCCESS (0.008s)
[649.389756] [127/131] (372s left) gem_ctx_persistence (engines-mixed-process)
[649.462755] Starting subtest: engines-mixed-process
[649.465047] Starting dynamic subtest: rcs0
[651.194109] Dynamic subtest rcs0: SUCCESS (1.731s)
[651.206018] Starting dynamic subtest: bcs0
[653.177408] Dynamic subtest bcs0: SUCCESS (1.981s)
[653.189595] Starting dynamic subtest: vcs0
[655.128009] Dynamic subtest vcs0: SUCCESS (1.945s)
[655.138324] Starting dynamic subtest: vcs1
[657.160398] Dynamic subtest vcs1: SUCCESS (2.034s)
[657.172430] Starting dynamic subtest: vecs0
[659.115032] Dynamic subtest vecs0: SUCCESS (1.953s)
[659.126416] Starting dynamic subtest: ccs0
[661.126311] Dynamic subtest ccs0: SUCCESS (2.009s)
[661.129168] Subtest engines-mixed-process: SUCCESS (11.663s)
[661.234172] [128/131] (361s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[661.299341] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[661.404202] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[661.512370] [129/131] (360s left) sysfs_heartbeat_interval (precise)
[661.573226] Starting subtest: precise
[661.575766] Starting dynamic subtest: vecs0
[669.156571] Dynamic subtest vecs0: SUCCESS (7.581s)
[669.168415] Starting dynamic subtest: ccs0
[670.414867] Dynamic subtest ccs0: SUCCESS (1.255s)
[670.427214] Starting dynamic subtest: vcs0
[678.136516] Dynamic subtest vcs0: SUCCESS (7.720s)
[678.149069] Starting dynamic subtest: bcs0
[679.370460] Dynamic subtest bcs0: SUCCESS (1.231s)
[679.384559] Starting dynamic subtest: rcs0
[680.562405] Dynamic subtest rcs0: SUCCESS (1.190s)
[680.572545] Starting dynamic subtest: vcs1
[688.184552] Dynamic subtest vcs1: SUCCESS (7.618s)
[688.187030] Subtest precise: SUCCESS (26.609s)
[688.284113] [130/131] (334s left) kms_psr (fbc-pr-cursor-render)
[688.389422] Starting subtest: fbc-pr-cursor-render
[688.393756] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[688.486575] [131/131] (334s left) kms_psr (psr2-sprite-render)
[688.602580] Starting subtest: psr2-sprite-render
[688.604787] Starting dynamic subtest: eDP-1
[690.357159] Dynamic subtest eDP-1: SUCCESS (1.754s)
[690.359612] Subtest psr2-sprite-render: SUCCESS (1.756s)
[691.219188] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: api_intel_bb
results: parsing output: 2/ for test: intel_hwmon
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_psr
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_cursor_legacy
results: parsing output: 7/ for test: fbdev
results: parsing output: 8/ for test: syncobj_wait
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_flip_scaled_crc
results: parsing output: 11/ for test: gem_userptr_blits
results: parsing output: 12/ for test: kms_tiled_display
results: parsing output: 13/ for test: kms_chamelium_frames
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: gem_mmap_wc
results: parsing output: 17/ for test: kms_fence_pin_leak
results: parsing output: 18/ for test: kms_plane_scaling
results: parsing output: 19/ for test: kms_plane
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: kms_cursor_legacy
results: parsing output: 22/ for test: gem_spin_batch
results: parsing output: 23/ for test: kms_lease
results: parsing output: 24/ for test: gem_exec_whisper
results: parsing output: 25/ for test: kms_flip
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: i915_drm_fdinfo
results: parsing output: 28/ for test: gem_caching
results: parsing output: 29/ for test: syncobj_wait
results: parsing output: 30/ for test: kms_hdmi_inject
results: parsing output: 31/ for test: gem_lmem_swapping
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: gem_exec_reloc
results: parsing output: 34/ for test: kms_cursor_crc
results: parsing output: 35/ for test: kms_ccs
results: parsing output: 36/ for test: gem_exec_schedule
results: parsing output: 37/ for test: gem_exec_schedule
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: kms_pipe_crc_basic
results: parsing output: 40/ for test: kms_cursor_crc
results: parsing output: 41/ for test: api_intel_allocator
results: parsing output: 42/ for test: kms_properties
results: parsing output: 43/ for test: gem_exec_reloc
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_exec_fence
results: parsing output: 47/ for test: kms_psr
results: parsing output: 48/ for test: perf
results: parsing output: 49/ for test: gem_render_copy
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: perf_pmu
results: parsing output: 52/ for test: gen9_exec_parse
results: parsing output: 53/ for test: gem_exec_balancer
results: parsing output: 54/ for test: gem_exec_flush
results: parsing output: 55/ for test: gem_readwrite
results: parsing output: 56/ for test: kms_pm_rpm
results: parsing output: 57/ for test: gem_mmap_offset
results: parsing output: 58/ for test: gem_exec_reloc
results: parsing output: 59/ for test: gem_ctx_engines
results: parsing output: 60/ for test: kms_pm_dc
results: parsing output: 61/ for test: perf_pmu
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_exercise_blt
results: parsing output: 64/ for test: sw_sync
results: parsing output: 65/ for test: kms_cursor_legacy
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: kms_flip
results: parsing output: 68/ for test: kms_psr2_su
results: parsing output: 69/ for test: kms_vrr
results: parsing output: 70/ for test: kms_cursor_legacy
results: parsing output: 71/ for test: gem_exec_reloc
results: parsing output: 72/ for test: kms_ccs
results: parsing output: 73/ for test: gen9_exec_parse
results: parsing output: 74/ for test: kms_content_protection
results: parsing output: 75/ for test: vgem_basic
results: parsing output: 76/ for test: syncobj_eventfd
results: parsing output: 77/ for test: kms_chamelium_hpd
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_color_pipeline
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_cursor_edge_walk
results: parsing output: 83/ for test: kms_cursor_legacy
results: parsing output: 84/ for test: kms_flip
results: parsing output: 85/ for test: kms_chamelium_edid
results: parsing output: 86/ for test: gem_pxp
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: gem_exec_reloc
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: syncobj_timeline
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_hdr
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_exec_balancer
results: parsing output: 97/ for test: i915_pm_rc6_residency
results: parsing output: 98/ for test: prime_mmap
results: parsing output: 99/ for test: kms_addfb_basic
results: parsing output: 100/ for test: kms_setmode
results: parsing output: 101/ for test: kms_properties
results: parsing output: 102/ for test: gem_mmap_wc
results: parsing output: 103/ for test: gem_eio
results: parsing output: 104/ for test: drm_read
results: parsing output: 105/ for test: gem_workarounds
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: syncobj_timeline
results: parsing output: 110/ for test: kms_ccs
results: parsing output: 111/ for test: kms_dsc
results: parsing output: 112/ for test: kms_properties
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: core_setmaster
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: gem_sync
results: parsing output: 117/ for test: gem_ctx_persistence
results: parsing output: 118/ for test: kms_psr2_sf
results: parsing output: 119/ for test: kms_rotation_crc
results: parsing output: 120/ for test: gem_eio
results: parsing output: 121/ for test: kms_pipe_crc_basic
results: parsing output: 122/ for test: gem_partial_pwrite_pread
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_mmap_gtt
results: parsing output: 125/ for test: i915_query
results: parsing output: 126/ for test: gem_ctx_persistence
results: parsing output: 127/ for test: syncobj_timeline
results: parsing output: 128/ for test: sysfs_heartbeat_interval
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: kms_psr
Done.