[58.330803] Initializing watchdogs
[58.330860]   /dev/watchdog0
[58.344285] [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.348514] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.350857] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.354434] [001/131] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[58.479445] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[58.483541] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[58.613159] [002/131] (960s left) api_intel_bb (render)
[58.658608] Starting subtest: render
[58.660922] Starting dynamic subtest: render-none-512
[58.764634] Dynamic subtest render-none-512: SUCCESS (0.108s)
[58.774430] Starting dynamic subtest: render-none-1024
[59.136909] Dynamic subtest render-none-1024: SUCCESS (0.373s)
[59.143771] Starting dynamic subtest: render-x-512
[59.220209] Dynamic subtest render-x-512: SUCCESS (0.084s)
[59.228066] Starting dynamic subtest: render-x-1024
[59.551494] Dynamic subtest render-x-1024: SUCCESS (0.332s)
[59.560701] Starting dynamic subtest: render-y-512
[59.636182] Dynamic subtest render-y-512: SUCCESS (0.085s)
[59.645537] Starting dynamic subtest: render-y-1024
[59.968959] Dynamic subtest render-y-1024: SUCCESS (0.333s)
[59.971810] Subtest render: SUCCESS (1.319s)
[60.105510] [003/131] (958s left) intel_hwmon (hwmon-read)
[60.155971] Subtest hwmon-read: SKIP (0.000s)
[60.216845] [004/131] (958s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[60.308958] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[64.808468] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.519s)
[66.015992] [005/131] (952s left) kms_psr (pr-sprite-render)
[66.116219] Starting subtest: pr-sprite-render
[66.120741] Subtest pr-sprite-render: SKIP (0.000s)
[66.209572] [006/131] (952s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[66.309624] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[66.313762] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[66.437709] [007/131] (952s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[66.562494] Starting subtest: cursorA-vs-flipA-atomic
[77.706079] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.155s)
[78.515713] [008/131] (940s left) fbdev (eof)
[78.569932] Starting subtest: eof
[78.572193] Subtest eof: SUCCESS (0.000s)
[78.659613] [009/131] (940s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[78.710053] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[78.712055] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[78.823870] [010/131] (940s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[78.920632] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[88.287762] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.367s)
[88.455322] [011/131] (930s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[88.563397] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[88.565817] Starting dynamic subtest: pipe-A-default-mode
[91.282554] Dynamic subtest pipe-A-default-mode: SUCCESS (2.721s)
[91.284479] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.722s)
[92.149768] [012/131] (927s left) gem_userptr_blits (huge-split)
[92.227797] Starting subtest: huge-split
[92.235428] Subtest huge-split: SUCCESS (0.007s)
[92.402752] [013/131] (926s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[92.530739] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[92.572159] [014/131] (926s left) kms_chamelium_frames (dp-crc-multiple)
[92.970497] Subtest dp-crc-multiple: SKIP (0.000s)
[93.731175] [015/131] (925s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[93.824786] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[93.827041] Starting dynamic subtest: pipe-A-eDP-1
[93.849467] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[93.859079] Starting dynamic subtest: pipe-B-eDP-1
[93.880538] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[93.887508] Starting dynamic subtest: pipe-C-eDP-1
[93.908768] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[93.915550] Starting dynamic subtest: pipe-D-eDP-1
[93.936712] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[93.940572] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[96.045316] [016/131] (923s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[96.151750] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[102.844100] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.695s)
[103.013800] [017/131] (916s left) gem_mmap_wc (bad-size)
[103.072371] Subtest bad-size: SKIP (0.000s)
[103.137030] [018/131] (916s left) kms_fence_pin_leak
[103.301776] [019/131] (916s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[103.393308] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[103.395986] Starting dynamic subtest: pipe-A
[103.732191] Dynamic subtest pipe-A: SUCCESS (0.342s)
[103.740456] Starting dynamic subtest: pipe-B
[105.155315] Dynamic subtest pipe-B: SUCCESS (1.422s)
[105.162769] Starting dynamic subtest: pipe-C
[106.614156] Dynamic subtest pipe-C: SUCCESS (1.457s)
[106.625626] Starting dynamic subtest: pipe-D
[108.012507] Dynamic subtest pipe-D: SUCCESS (1.398s)
[108.015070] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.622s)
[109.205105] [020/131] (910s left) kms_plane (plane-panning-bottom-right-suspend)
[109.299258] Starting subtest: plane-panning-bottom-right-suspend
[109.301611] Starting dynamic subtest: pipe-A
[127.279581] Dynamic subtest pipe-A: SUCCESS (7.269s)
[127.288750] Starting dynamic subtest: pipe-B
[145.256433] Dynamic subtest pipe-B: SUCCESS (3.451s)
[145.258782] Subtest plane-panning-bottom-right-suspend: SUCCESS (10.722s)
[146.120970] [021/131] (873s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[146.239474] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[146.243847] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[146.374640] [022/131] (873s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[146.488418] Starting subtest: short-busy-flip-before-cursor-toggle
[146.492826] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[146.651241] [023/131] (873s left) gem_spin_batch (resubmit-new-all)
[146.726117] Starting subtest: resubmit-new-all
[146.728470] Starting dynamic subtest: rcs0
[146.739135] Dynamic subtest rcs0: SUCCESS (0.013s)
[146.748947] Starting dynamic subtest: bcs0
[146.751140] Dynamic subtest bcs0: SUCCESS (0.010s)
[146.758574] Starting dynamic subtest: vcs0
[146.760706] Dynamic subtest vcs0: SUCCESS (0.009s)
[146.767976] Starting dynamic subtest: vcs1
[146.769803] Dynamic subtest vcs1: SUCCESS (0.008s)
[146.776854] Starting dynamic subtest: vecs0
[146.779102] Dynamic subtest vecs0: SUCCESS (0.012s)
[146.786171] Starting dynamic subtest: ccs0
[146.788511] Dynamic subtest ccs0: SUCCESS (0.008s)
[146.790328] Subtest resubmit-new-all: SUCCESS (0.062s)
[148.297103] [024/131] (871s left) kms_lease (cursor-implicit-plane)
[148.399388] Starting subtest: cursor-implicit-plane
[148.401718] Starting dynamic subtest: pipe-A-eDP-1
[148.842833] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.455s)
[148.852418] Starting dynamic subtest: pipe-B-eDP-1
[149.914067] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.089s)
[149.923145] Starting dynamic subtest: pipe-C-eDP-1
[151.020754] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.127s)
[151.030749] Starting dynamic subtest: pipe-D-eDP-1
[152.130884] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.125s)
[152.133183] Subtest cursor-implicit-plane: SUCCESS (3.800s)
[153.000020] [025/131] (866s left) gem_exec_whisper (basic-forked-all)
[153.075876] Starting subtest: basic-forked-all
[165.895484] Subtest basic-forked-all: SUCCESS (12.897s)
[166.104238] [026/131] (853s left) kms_flip (nonexisting-fb)
[166.206970] Starting subtest: nonexisting-fb
[166.209213] Starting dynamic subtest: A-eDP1
[167.390488] Dynamic subtest A-eDP1: SUCCESS (1.186s)
[167.400244] Starting dynamic subtest: B-eDP1
[168.525602] Dynamic subtest B-eDP1: SUCCESS (1.137s)
[168.533806] Starting dynamic subtest: C-eDP1
[169.653260] Dynamic subtest C-eDP1: SUCCESS (1.129s)
[169.662244] Starting dynamic subtest: D-eDP1
[170.787887] Dynamic subtest D-eDP1: SUCCESS (1.135s)
[170.792910] Subtest nonexisting-fb: SUCCESS (4.595s)
[171.981225] [027/131] (847s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[172.082538] Starting subtest: x-tiled-16bpp-rotate-180
[173.425537] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.344s)
[173.589373] [028/131] (846s left) i915_drm_fdinfo (virtual-idle)
[173.631529] Starting subtest: virtual-idle
[176.712634] Subtest virtual-idle: SUCCESS (3.081s)
[176.809736] [029/131] (843s left) gem_caching (reads)
[176.871704] Subtest reads: SKIP (0.000s)
[176.947088] [030/131] (843s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[176.997085] Starting subtest: wait-all-for-submit-delayed-submit
[177.101055] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[177.208297] [031/131] (842s left) kms_hdmi_inject (inject-4k)
[177.543674] Starting subtest: inject-4k
[177.855020] Subtest inject-4k: SUCCESS (0.312s)
[178.438591] [032/131] (841s left) gem_lmem_swapping (parallel-random-engines)
[178.477487] Subtest parallel-random-engines: SKIP (0.000s)
[178.520724] [033/131] (841s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[178.620856] Starting subtest: yf-tiled-64bpp-rotate-270
[178.625227] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[178.751814] [034/131] (841s left) gem_exec_reloc (basic-write-read-noreloc)
[178.813068] Subtest basic-write-read-noreloc: SKIP (0.000s)
[178.872043] [035/131] (841s left) kms_cursor_crc (cursor-onscreen-64x21)
[179.073187] Starting subtest: cursor-onscreen-64x21
[179.125482] Subtest cursor-onscreen-64x21: SKIP (0.048s)
[179.363298] [036/131] (840s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[179.462961] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[179.464569] Starting dynamic subtest: pipe-A-eDP-1
[181.640261] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.174s)
[181.648505] Starting dynamic subtest: pipe-B-eDP-1
[183.779752] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.139s)
[183.787912] Starting dynamic subtest: pipe-C-eDP-1
[185.879753] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.094s)
[185.887600] Starting dynamic subtest: pipe-D-eDP-1
[187.949675] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.069s)
[187.951593] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.482s)
[189.216216] [037/131] (831s left) gem_exec_schedule (pi-shared-iova)
[189.400812] Starting subtest: pi-shared-iova
[189.402923] Starting dynamic subtest: rcs0
[189.474333] Dynamic subtest rcs0: SUCCESS (0.075s)
[189.486689] Starting dynamic subtest: vcs0
[189.538448] Dynamic subtest vcs0: SUCCESS (0.064s)
[189.547139] Starting dynamic subtest: vcs1
[189.590374] Dynamic subtest vcs1: SUCCESS (0.051s)
[189.601478] Starting dynamic subtest: vecs0
[189.642342] Dynamic subtest vecs0: SUCCESS (0.051s)
[189.653893] Starting dynamic subtest: ccs0
[189.692694] Dynamic subtest ccs0: SUCCESS (0.050s)
[189.695097] Subtest pi-shared-iova: SUCCESS (0.294s)
[191.382683] [038/131] (828s left) gem_exec_schedule (submit-late-slice)
[191.450922] Starting subtest: submit-late-slice
[191.452807] Starting dynamic subtest: rcs0
[191.476136] Dynamic subtest rcs0: SUCCESS (0.033s)
[191.487827] Starting dynamic subtest: bcs0
[191.502736] Dynamic subtest bcs0: SUCCESS (0.026s)
[191.511118] Starting dynamic subtest: vcs0
[191.534359] Dynamic subtest vcs0: SUCCESS (0.031s)
[191.543480] Starting dynamic subtest: vcs1
[191.560212] Dynamic subtest vcs1: SUCCESS (0.025s)
[191.568917] Starting dynamic subtest: vecs0
[191.594138] Dynamic subtest vecs0: SUCCESS (0.032s)
[191.607251] Starting dynamic subtest: ccs0
[191.622233] Dynamic subtest ccs0: SUCCESS (0.028s)
[191.624525] Subtest submit-late-slice: SUCCESS (0.180s)
[193.357790] [039/131] (826s left) kms_psr (psr-suspend)
[193.467087] Starting subtest: psr-suspend
[193.469208] Starting dynamic subtest: eDP-1
[211.385362] Dynamic subtest eDP-1: SUCCESS (3.022s)
[211.387781] Subtest psr-suspend: SUCCESS (3.024s)
[212.259957] [040/131] (808s left) kms_pipe_crc_basic (hang-read-crc)
[212.369516] Starting subtest: hang-read-crc
[212.371733] Starting dynamic subtest: pipe-A-eDP-1
[214.406295] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.091s)
[214.415762] Starting dynamic subtest: pipe-B-eDP-1
[217.149308] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.798s)
[217.158427] Starting dynamic subtest: pipe-C-eDP-1
[219.765102] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.654s)
[219.775923] Starting dynamic subtest: pipe-D-eDP-1
[222.344623] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.602s)
[222.346976] Subtest hang-read-crc: SUCCESS (10.152s)
[223.167473] [041/131] (797s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[223.377988] Starting subtest: cursor-rapid-movement-128x128
[223.383727] Starting dynamic subtest: pipe-A-eDP-1
[223.928623] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.551s)
[223.959961] Starting dynamic subtest: pipe-D-eDP-1
[225.104426] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.162s)
[225.106937] Subtest cursor-rapid-movement-128x128: SUCCESS (1.737s)
[225.954903] [042/131] (794s left) api_intel_allocator (open-vm)
[226.012882] Starting subtest: open-vm
[226.016289] Subtest open-vm: SUCCESS (0.006s)
[226.158122] [043/131] (794s left) kms_properties (plane-properties-atomic)
[226.251453] Starting subtest: plane-properties-atomic
[226.253579] Starting dynamic subtest: pipe-A-eDP-1
[226.803315] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.556s)
[226.812530] Starting dynamic subtest: pipe-B-eDP-1
[228.069701] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.268s)
[228.079410] Starting dynamic subtest: pipe-C-eDP-1
[229.349777] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.284s)
[229.358881] Starting dynamic subtest: pipe-D-eDP-1
[230.637539] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.291s)
[230.639901] Subtest plane-properties-atomic: SUCCESS (4.405s)
[231.530664] [044/131] (788s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[231.616298] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[231.709287] [045/131] (788s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[231.821349] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[238.389284] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.585s)
[238.533979] [046/131] (782s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[238.648423] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[242.899312] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.259s)
[244.112029] [047/131] (776s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[244.694173] Starting subtest: syncobj-stationary-timeline-chain-engines
[244.805993] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.115s)
[246.282469] [FACT gem_exec_fence (syncobj-stationary-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true
[246.285992] [048/131] (774s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[246.381761] Starting subtest: fbc-psr2-cursor-plane-onoff
[246.384007] Starting dynamic subtest: eDP-1
[246.388567] Dynamic subtest eDP-1: SKIP (0.000s)
[246.392955] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s)
[246.474025] [049/131] (774s left) perf (polling)
[246.607468] Starting subtest: polling
[246.609417] Starting dynamic subtest: 0-rcs0
[256.636147] Dynamic subtest 0-rcs0: SUCCESS (10.025s)
[256.645520] Starting dynamic subtest: 1-vcs1
[266.657802] Dynamic subtest 1-vcs1: SUCCESS (10.021s)
[266.660447] Subtest polling: SUCCESS (20.048s)
[266.706296] [050/131] (754s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[266.777301] Starting subtest: y-tiled-to-vebox-y-tiled
[266.782063] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[266.988201] [051/131] (753s left) kms_frontbuffer_tracking (fbc-stridechange)
[267.093422] Starting subtest: fbc-stridechange
[270.370687] Subtest fbc-stridechange: SUCCESS (3.280s)
[271.518169] [052/131] (749s left) perf_pmu (idle-no-semaphores)
[271.559402] Starting subtest: idle-no-semaphores
[271.561699] Starting dynamic subtest: rcs0
[272.131400] Dynamic subtest rcs0: SUCCESS (0.570s)
[272.143680] Starting dynamic subtest: bcs0
[272.654386] Dynamic subtest bcs0: SUCCESS (0.517s)
[272.664258] Starting dynamic subtest: vcs0
[273.173363] Dynamic subtest vcs0: SUCCESS (0.519s)
[273.184467] Starting dynamic subtest: vcs1
[273.697783] Dynamic subtest vcs1: SUCCESS (0.521s)
[273.709044] Starting dynamic subtest: vecs0
[274.224314] Dynamic subtest vecs0: SUCCESS (0.524s)
[274.236430] Starting dynamic subtest: ccs0
[274.751793] Dynamic subtest ccs0: SUCCESS (0.524s)
[274.754555] Subtest idle-no-semaphores: SUCCESS (3.193s)
[274.888545] [053/131] (745s left) gen9_exec_parse (shadow-peek)
[274.949987] Subtest shadow-peek: SKIP (0.000s)
[275.037730] [054/131] (745s left) gem_exec_balancer (nohangcheck)
[275.287531] Starting subtest: nohangcheck
[276.151037] Subtest nohangcheck: SUCCESS (0.863s)
[276.323678] [055/131] (744s left) gem_exec_flush (basic-wb-prw-default)
[276.395251] Starting subtest: basic-wb-prw-default
[281.882451] Subtest basic-wb-prw-default: SUCCESS (5.488s)
[282.089981] [056/131] (738s left) gem_readwrite (write-bad-handle)
[282.150124] Subtest write-bad-handle: SKIP (0.000s)
[282.216842] [057/131] (738s left) kms_pm_rpm (modeset-non-lpsp-stress)
[284.351163] Starting subtest: modeset-non-lpsp-stress
[285.500249] Subtest modeset-non-lpsp-stress: SKIP (1.151s)
[285.887258] [058/131] (735s left) gem_mmap_offset (blt-coherency)
[285.949163] Starting subtest: blt-coherency
[285.955179] Subtest blt-coherency: SUCCESS (0.007s)
[286.097171] [059/131] (734s left) gem_exec_reloc (basic-write-cpu-noreloc)
[286.154943] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[286.244720] [060/131] (734s left) gem_ctx_engines (independent)
[286.311025] Starting subtest: independent
[286.313289] Starting dynamic subtest: rcs0
[286.452403] Dynamic subtest rcs0: SUCCESS (0.139s)
[286.463765] Starting dynamic subtest: bcs0
[286.587753] Dynamic subtest bcs0: SUCCESS (0.134s)
[286.599877] Starting dynamic subtest: vcs0
[286.733026] Dynamic subtest vcs0: SUCCESS (0.144s)
[286.745303] Starting dynamic subtest: vcs1
[286.906699] Dynamic subtest vcs1: SUCCESS (0.174s)
[286.918938] Starting dynamic subtest: vecs0
[287.069143] Dynamic subtest vecs0: SUCCESS (0.160s)
[287.080442] Starting dynamic subtest: ccs0
[287.242240] Dynamic subtest ccs0: SUCCESS (0.172s)
[287.253855] Starting dynamic subtest: all-engines
[287.948079] Dynamic subtest all-engines: SUCCESS (0.706s)
[287.950468] Subtest independent: SUCCESS (1.637s)
[288.350639] [061/131] (732s left) kms_pm_dc (dc5-dpms-negative)
[289.455520] Starting subtest: dc5-dpms-negative
[289.459711] Subtest dc5-dpms-negative: SKIP (0.000s)
[289.555738] [062/131] (731s left) perf_pmu (render-node-busy-idle)
[289.662880] Starting subtest: render-node-busy-idle
[289.665181] Starting dynamic subtest: rcs0
[290.374292] Dynamic subtest rcs0: SUCCESS (0.713s)
[290.386595] Starting dynamic subtest: bcs0
[291.043838] Dynamic subtest bcs0: SUCCESS (0.667s)
[291.056440] Starting dynamic subtest: vcs0
[293.117635] Dynamic subtest vcs0: SUCCESS (2.070s)
[293.130254] Starting dynamic subtest: vcs1
[295.166185] Dynamic subtest vcs1: SUCCESS (2.045s)
[295.178410] Starting dynamic subtest: vecs0
[297.150658] Dynamic subtest vecs0: SUCCESS (1.981s)
[297.162543] Starting dynamic subtest: ccs0
[297.827420] Dynamic subtest ccs0: SUCCESS (0.675s)
[297.830324] Subtest render-node-busy-idle: SUCCESS (8.168s)
[297.927036] [063/131] (723s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[298.047649] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[298.051926] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[298.164040] [064/131] (723s left) gem_exercise_blt (fast-copy-emit)
[298.235247] Starting subtest: fast-copy-emit
[298.237250] Starting dynamic subtest: linear-smem-smem-emit
[298.255787] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.023s)
[298.265857] Starting dynamic subtest: xmajor-smem-smem-emit
[298.272102] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.016s)
[298.280585] Starting dynamic subtest: tile4-smem-smem-emit
[298.288546] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.016s)
[298.297040] Starting dynamic subtest: tile64-smem-smem-emit
[298.305173] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.016s)
[298.307446] Subtest fast-copy-emit: SUCCESS (0.073s)
[298.468453] [065/131] (722s left) sw_sync (timeline_closed)
[298.506756] Starting subtest: timeline_closed
[298.508898] Subtest timeline_closed: SUCCESS (0.000s)
[298.588526] [066/131] (722s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[298.704665] Starting subtest: basic-flip-after-cursor-atomic
[299.626450] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.921s)
[300.510792] [067/131] (720s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[300.618823] Starting subtest: y-tiled-8bpp-rotate-180
[300.623350] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[300.754998] [068/131] (720s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[300.859632] Starting subtest: flip-vs-dpms-on-nop-interruptible
[300.861924] Starting dynamic subtest: A-eDP1
[302.746954] Dynamic subtest A-eDP1: SUCCESS (1.886s)
[302.759341] Starting dynamic subtest: B-eDP1
[304.645673] Dynamic subtest B-eDP1: SUCCESS (1.896s)
[304.659200] Starting dynamic subtest: C-eDP1
[306.449105] Dynamic subtest C-eDP1: SUCCESS (1.802s)
[306.458200] Starting dynamic subtest: D-eDP1
[308.240050] Dynamic subtest D-eDP1: SUCCESS (1.790s)
[308.242525] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.384s)
[309.505364] [069/131] (712s left) kms_psr2_su (page_flip-xrgb8888)
[309.557682] Subtest page_flip-XRGB8888: SKIP (0.000s)
[309.626630] [070/131] (711s left) kms_vrr (max-min)
[309.721393] Starting subtest: max-min
[309.727507] Subtest max-min: SKIP (0.000s)
[309.817212] [071/131] (711s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[309.945942] Starting subtest: flip-vs-cursor-atomic
[316.913445] Subtest flip-vs-cursor-atomic: SUCCESS (6.966s)
[317.805150] [072/131] (703s left) gem_exec_reloc (basic-gtt)
[317.884811] Subtest basic-gtt: SKIP (0.000s)
[317.973726] [073/131] (703s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[318.063461] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[318.065685] Starting dynamic subtest: pipe-A-eDP-1
[318.088796] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[318.098707] Starting dynamic subtest: pipe-B-eDP-1
[318.120548] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[318.129092] Starting dynamic subtest: pipe-C-eDP-1
[318.150889] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[318.159856] Starting dynamic subtest: pipe-D-eDP-1
[318.183033] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[318.187171] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[320.293794] [074/131] (701s left) gen9_exec_parse (bb-secure)
[320.364921] Subtest bb-secure: SKIP (0.000s)
[320.447156] [075/131] (701s left) kms_content_protection (type1)
[320.591361] Starting subtest: type1
[320.596433] Subtest type1: SKIP (0.000s)
[320.777522] [076/131] (701s left) vgem_basic (sysfs)
[320.830985] Starting subtest: sysfs
[320.832910] Subtest sysfs: SUCCESS (0.000s)
[320.913008] [077/131] (700s left) syncobj_eventfd (binary-wait)
[320.966531] Starting subtest: binary-wait
[320.974573] Subtest binary-wait: SUCCESS (0.010s)
[321.113016] [078/131] (700s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[321.512137] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[322.350730] [079/131] (699s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[322.460048] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[322.464028] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[322.605084] [080/131] (699s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[322.710194] Starting subtest: plane-ctm3x4-lut1d
[322.723366] Starting dynamic subtest: pipe-A-eDP-1
[323.420712] Dynamic subtest pipe-A-eDP-1: FAIL (0.335s)
[324.120954] Starting dynamic subtest: pipe-B-eDP-1
[324.918049] Dynamic subtest pipe-B-eDP-1: FAIL (0.279s)
[325.435851] Starting dynamic subtest: pipe-C-eDP-1
[326.259439] Dynamic subtest pipe-C-eDP-1: FAIL (0.235s)
[326.725963] Starting dynamic subtest: pipe-D-eDP-1
[327.541259] Dynamic subtest pipe-D-eDP-1: FAIL (0.235s)
[327.543348] Subtest plane-ctm3x4-lut1d: FAIL (4.519s)
[328.090996] [081/131] (693s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[328.183612] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[328.185947] Starting dynamic subtest: A-eDP1
[337.091990] Dynamic subtest A-eDP1: SUCCESS (8.909s)
[337.103025] Starting dynamic subtest: B-eDP1
[345.985498] Dynamic subtest B-eDP1: SUCCESS (8.894s)
[345.996746] Starting dynamic subtest: C-eDP1
[354.871576] Dynamic subtest C-eDP1: SUCCESS (8.887s)
[354.890400] Starting dynamic subtest: D-eDP1
[363.768211] Dynamic subtest D-eDP1: SUCCESS (8.896s)
[363.773239] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.599s)
[364.985612] [082/131] (657s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[365.086658] Starting subtest: psr-2p-primscrn-spr-indfb-move
[365.090614] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[365.222781] [083/131] (656s left) kms_cursor_edge_walk (256x256-top-bottom)
[365.332469] Starting subtest: 256x256-top-bottom
[365.334591] Starting dynamic subtest: pipe-A-eDP-1
[368.783887] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.453s)
[368.793857] Starting dynamic subtest: pipe-D-eDP-1
[371.987408] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.201s)
[371.989405] Subtest 256x256-top-bottom: SUCCESS (6.656s)
[372.880736] [084/131] (649s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[373.017693] Starting subtest: 2x-long-cursor-vs-flip-legacy
[373.022031] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.001s)
[373.185856] [085/131] (648s left) kms_flip (flip-vs-modeset-vs-hang)
[373.294210] Starting subtest: flip-vs-modeset-vs-hang
[373.296696] Starting dynamic subtest: A-eDP1
[425.673684] Dynamic subtest A-eDP1: SUCCESS (52.381s)
[425.685572] Starting dynamic subtest: D-eDP1
[475.606394] Dynamic subtest D-eDP1: SUCCESS (49.924s)
[475.608610] Subtest flip-vs-modeset-vs-hang: SUCCESS (102.310s)
[475.991332] [086/131] (546s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[476.387795] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[477.226545] [087/131] (545s left) gem_pxp (reject-modify-context-protection-off-3)
[477.339210] Starting subtest: reject-modify-context-protection-off-3
[477.341883] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[477.466022] [088/131] (544s left) kms_big_fb (linear-16bpp-rotate-0)
[477.560915] Starting subtest: linear-16bpp-rotate-0
[478.996322] Subtest linear-16bpp-rotate-0: SUCCESS (1.434s)
[479.154320] [089/131] (543s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[479.260819] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[487.676357] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.416s)
[487.805164] [090/131] (534s left) gem_exec_reloc (basic-active)
[487.879212] Subtest basic-active: SKIP (0.000s)
[487.949493] [091/131] (534s left) syncobj_timeline (reset-unsignaled)
[488.001257] Starting subtest: reset-unsignaled
[488.003501] Subtest reset-unsignaled: SUCCESS (0.000s)
[488.144861] [092/131] (534s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[488.247956] Starting subtest: fbcpsr-shrfb-scaledprimary
[493.903116] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.657s)
[494.061775] [093/131] (528s left) syncobj_timeline (invalid-wait-bad-flags)
[494.119045] Starting subtest: invalid-wait-bad-flags
[494.121472] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[494.253752] [094/131] (528s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[494.351059] Starting subtest: fbc-rgb101010-draw-render
[498.932575] Subtest fbc-rgb101010-draw-render: SUCCESS (4.586s)
[500.080875] [095/131] (522s left) kms_hdr (bpc-switch)
[500.181182] Starting subtest: bpc-switch
[501.288946] Starting dynamic subtest: pipe-A-eDP-1
[504.682981] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.397s)
[504.685101] Subtest bpc-switch: SUCCESS (4.505s)
[504.829792] [096/131] (517s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[504.934451] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[509.364413] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.434s)
[510.573875] [097/131] (512s left) gem_exec_balancer (parallel-keep-submit-fence)
[510.834454] Starting subtest: parallel-keep-submit-fence
[512.029426] Subtest parallel-keep-submit-fence: SUCCESS (1.195s)
[512.165847] [098/131] (510s left) i915_pm_rc6_residency (rc6-idle)
[512.228993] Starting subtest: rc6-idle
[512.259092] Starting dynamic subtest: gt0-rcs0
[536.524214] Dynamic subtest gt0-rcs0: SUCCESS (24.268s)
[536.535529] Starting dynamic subtest: gt0-bcs0
[560.801463] Dynamic subtest gt0-bcs0: SUCCESS (24.279s)
[560.810907] Starting dynamic subtest: gt0-ccs0
[585.069331] Dynamic subtest gt0-ccs0: SUCCESS (24.271s)
[585.083481] Starting dynamic subtest: gt1-vcs0
[591.244316] Dynamic subtest gt1-vcs0: SUCCESS (6.170s)
[591.255921] Starting dynamic subtest: gt1-vecs0
[597.411987] Dynamic subtest gt1-vecs0: SUCCESS (6.169s)
[597.414504] Subtest rc6-idle: SUCCESS (85.201s)
[597.519644] [099/131] (425s left) prime_mmap (test_map_unmap)
[597.579083] Starting subtest: test_map_unmap
[597.581431] Starting dynamic subtest: test_map_unmap-smem
[597.605356] Dynamic subtest test_map_unmap-smem: SUCCESS (0.029s)
[597.607702] Subtest test_map_unmap: SUCCESS (0.030s)
[597.749193] [100/131] (425s left) kms_addfb_basic (invalid-set-prop-any)
[597.813046] Starting subtest: invalid-set-prop-any
[597.815393] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[597.998267] [101/131] (424s left) kms_setmode (basic)
[598.062193] Starting subtest: basic
[598.380236] Starting dynamic subtest: pipe-A-eDP-1
[600.502927] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.119s)
[600.858136] Starting dynamic subtest: pipe-B-eDP-1
[602.905201] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.051s)
[603.220037] Subtest basic: SUCCESS (5.157s)
[604.033247] [102/131] (418s left) kms_properties (colorop-properties-atomic)
[604.129586] Starting subtest: colorop-properties-atomic
[604.131917] Starting dynamic subtest: pipe-A-eDP-1
[604.463445] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.335s)
[604.473978] Starting dynamic subtest: pipe-B-eDP-1
[605.588846] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.123s)
[605.598579] Starting dynamic subtest: pipe-C-eDP-1
[606.683966] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.093s)
[606.696084] Starting dynamic subtest: pipe-D-eDP-1
[607.769927] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.082s)
[607.772240] Subtest colorop-properties-atomic: SUCCESS (3.643s)
[608.639167] [103/131] (414s left) gem_mmap_wc (read-write)
[608.709083] Subtest read-write: SKIP (0.000s)
[608.770142] [104/131] (414s left) gem_eio (kms)
[609.047505] Starting subtest: kms
[630.462425] Subtest kms: SUCCESS (21.418s)
[631.736661] [105/131] (391s left) drm_read (short-buffer-block)
[631.896511] Starting subtest: short-buffer-block
[631.898709] Subtest short-buffer-block: SUCCESS (0.000s)
[632.070524] [106/131] (390s left) gem_workarounds (reset-fd)
[632.140631] Starting subtest: reset-fd
[632.329099] Subtest reset-fd: SUCCESS (0.189s)
[632.489720] [107/131] (390s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[632.605065] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[632.609268] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[632.738686] [108/131] (390s left) kms_psr (fbc-psr-sprite-blt)
[632.830073] Starting subtest: fbc-psr-sprite-blt
[632.831878] Starting dynamic subtest: eDP-1
[632.835117] Dynamic subtest eDP-1: SKIP (0.000s)
[632.838437] Subtest fbc-psr-sprite-blt: SKIP (0.001s)
[632.926211] [109/131] (390s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[633.034036] Starting subtest: 4-tiled-16bpp-rotate-0
[634.303731] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.267s)
[634.479499] [110/131] (388s left) syncobj_timeline (invalid-signal-illegal-point)
[634.537460] Starting subtest: invalid-signal-illegal-point
[634.539338] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[634.664665] [111/131] (388s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[634.748795] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[634.750571] Starting dynamic subtest: pipe-A-eDP-1
[634.770807] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[634.786279] Starting dynamic subtest: pipe-B-eDP-1
[634.804951] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[634.813255] Starting dynamic subtest: pipe-C-eDP-1
[634.831953] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[634.840260] Starting dynamic subtest: pipe-D-eDP-1
[634.859203] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[634.862532] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[637.026277] [112/131] (386s left) kms_dsc (dsc-with-output-formats)
[637.123469] Starting subtest: dsc-with-output-formats
[637.145051] Subtest dsc-with-output-formats: SKIP (0.001s)
[637.220606] [113/131] (386s left) kms_properties (get_properties-sanity-atomic)
[637.331187] Starting subtest: get_properties-sanity-atomic
[637.337104] Subtest get_properties-sanity-atomic: SUCCESS (0.006s)
[637.436831] [114/131] (385s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[637.549356] Starting subtest: 4-tiled-32bpp-rotate-90
[637.569851] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.020s)
[637.731841] [115/131] (385s left) core_setmaster (master-drop-set-root)
[637.814053] Starting subtest: master-drop-set-root
[637.822774] Subtest master-drop-set-root: SUCCESS (0.013s)
[637.871421] [116/131] (385s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[637.966620] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[637.970046] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[638.082237] [117/131] (385s left) gem_sync (basic-all)
[638.157284] Starting subtest: basic-all
[642.110416] Subtest basic-all: SUCCESS (3.960s)
[642.318616] [118/131] (381s left) gem_ctx_persistence (heartbeat-close)
[642.383776] Starting subtest: heartbeat-close
[642.388315] Subtest heartbeat-close: SKIP (0.000s)
[642.530513] [119/131] (381s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[647.588587] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[647.593432] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.002s)
[648.427118] [120/131] (375s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[648.523405] Starting subtest: primary-x-tiled-reflect-x-0
[655.651086] Subtest primary-x-tiled-reflect-x-0: SUCCESS (7.129s)
[656.918093] [121/131] (366s left) gem_eio (in-flight-external)
[657.162978] Starting subtest: in-flight-external
[658.246443] Subtest in-flight-external: SUCCESS (1.082s)
[658.435449] [122/131] (365s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[658.535536] Starting subtest: compare-crc-sanitycheck-xr24
[658.537837] Starting dynamic subtest: pipe-A-eDP-1
[659.127295] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.593s)
[659.136585] Starting dynamic subtest: pipe-B-eDP-1
[660.457334] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.329s)
[660.471242] Starting dynamic subtest: pipe-C-eDP-1
[661.673757] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.212s)
[661.684858] Starting dynamic subtest: pipe-D-eDP-1
[662.879150] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.202s)
[662.881465] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.342s)
[663.727749] [123/131] (360s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[663.802518] Subtest writes-after-reads-uncached: SKIP (0.000s)
[663.878491] [124/131] (359s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[663.984634] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[663.988483] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[664.133818] [125/131] (359s left) gem_mmap_gtt (big-bo-tiledy)
[664.201642] Subtest big-bo-tiledY: SKIP (0.000s)
[664.275759] [126/131] (359s left) i915_query (engine-info)
[664.334559] Starting subtest: engine-info
[664.336683] Subtest engine-info: SUCCESS (0.005s)
[664.488185] [127/131] (359s left) gem_ctx_persistence (engines-mixed-process)
[664.552322] Starting subtest: engines-mixed-process
[664.554532] Starting dynamic subtest: rcs0
[666.144593] Dynamic subtest rcs0: SUCCESS (1.590s)
[666.156981] Starting dynamic subtest: bcs0
[668.178145] Dynamic subtest bcs0: SUCCESS (2.030s)
[668.189413] Starting dynamic subtest: vcs0
[670.101208] Dynamic subtest vcs0: SUCCESS (1.920s)
[670.113413] Starting dynamic subtest: vcs1
[672.160427] Dynamic subtest vcs1: SUCCESS (2.055s)
[672.172459] Starting dynamic subtest: vecs0
[674.146767] Dynamic subtest vecs0: SUCCESS (1.982s)
[674.159148] Starting dynamic subtest: ccs0
[676.181036] Dynamic subtest ccs0: SUCCESS (2.031s)
[676.183424] Subtest engines-mixed-process: SUCCESS (11.620s)
[676.294439] [128/131] (347s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[676.359076] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[676.466293] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.107s)
[676.569602] [129/131] (347s left) sysfs_heartbeat_interval (precise)
[676.632752] Starting subtest: precise
[676.635024] Starting dynamic subtest: vecs0
[684.179936] Dynamic subtest vecs0: SUCCESS (7.541s)
[684.192194] Starting dynamic subtest: ccs0
[685.353656] Dynamic subtest ccs0: SUCCESS (1.170s)
[685.366732] Starting dynamic subtest: vcs0
[693.144720] Dynamic subtest vcs0: SUCCESS (7.785s)
[693.157293] Starting dynamic subtest: bcs0
[694.357332] Dynamic subtest bcs0: SUCCESS (1.209s)
[694.370435] Starting dynamic subtest: rcs0
[695.478640] Dynamic subtest rcs0: SUCCESS (1.118s)
[695.490925] Starting dynamic subtest: vcs1
[703.193208] Dynamic subtest vcs1: SUCCESS (7.707s)
[703.195815] Subtest precise: SUCCESS (26.543s)
[703.298991] [130/131] (320s left) kms_psr (fbc-pr-cursor-render)
[703.411460] Starting subtest: fbc-pr-cursor-render
[703.415837] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[703.514048] [131/131] (320s left) kms_psr (psr2-sprite-render)
[703.615191] Starting subtest: psr2-sprite-render
[703.617393] Starting dynamic subtest: eDP-1
[705.383275] Dynamic subtest eDP-1: SUCCESS (1.765s)
[705.385525] Subtest psr2-sprite-render: SUCCESS (1.766s)
[706.254888] 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.