[57.736530] Initializing watchdogs
[57.736577]   /dev/watchdog0
[57.750232] [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]
[57.754587] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.757075] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.760507] [001/131] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[57.885696] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[57.890200] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[58.018902] [002/131] (960s left) api_intel_bb (render)
[58.074558] Starting subtest: render
[58.076895] Starting dynamic subtest: render-none-512
[58.179948] Dynamic subtest render-none-512: SUCCESS (0.105s)
[58.189195] Starting dynamic subtest: render-none-1024
[58.562065] Dynamic subtest render-none-1024: SUCCESS (0.380s)
[58.571966] Starting dynamic subtest: render-x-512
[58.652482] Dynamic subtest render-x-512: SUCCESS (0.091s)
[58.662057] Starting dynamic subtest: render-x-1024
[59.104863] Dynamic subtest render-x-1024: SUCCESS (0.451s)
[59.114061] Starting dynamic subtest: render-y-512
[59.189678] Dynamic subtest render-y-512: SUCCESS (0.086s)
[59.198944] Starting dynamic subtest: render-y-1024
[59.534725] Dynamic subtest render-y-1024: SUCCESS (0.344s)
[59.537503] Subtest render: SUCCESS (1.459s)
[59.674874] [003/131] (958s left) intel_hwmon (hwmon-read)
[59.728133] Subtest hwmon-read: SKIP (0.000s)
[59.784593] [004/131] (958s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[59.885104] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[64.483294] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.610s)
[65.636345] [005/131] (952s left) kms_psr (pr-sprite-render)
[65.728414] Starting subtest: pr-sprite-render
[65.732948] Subtest pr-sprite-render: SKIP (0.000s)
[65.821479] [006/131] (952s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[65.933975] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[65.938115] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[66.061163] [007/131] (952s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[66.190589] Starting subtest: cursorA-vs-flipA-atomic
[77.362355] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.173s)
[78.258341] [008/131] (940s left) fbdev (eof)
[78.297364] Starting subtest: eof
[78.299672] Subtest eof: SUCCESS (0.000s)
[78.394761] [009/131] (940s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[78.445599] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[78.447869] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[78.547371] [010/131] (940s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[78.645576] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[87.939048] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.296s)
[88.081765] [011/131] (930s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[88.180934] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[88.183475] Starting dynamic subtest: pipe-A-default-mode
[90.955366] Dynamic subtest pipe-A-default-mode: SUCCESS (2.775s)
[90.957779] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.776s)
[91.794215] [012/131] (926s left) gem_userptr_blits (huge-split)
[91.884851] Starting subtest: huge-split
[91.889468] Subtest huge-split: SUCCESS (0.007s)
[92.024333] [013/131] (926s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[92.139152] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[92.180521] [014/131] (926s left) kms_chamelium_frames (dp-crc-multiple)
[92.572804] Subtest dp-crc-multiple: SKIP (0.000s)
[93.375598] [015/131] (925s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[93.474869] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[93.477246] Starting dynamic subtest: pipe-A-eDP-1
[93.501041] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[93.510938] Starting dynamic subtest: pipe-B-eDP-1
[93.532703] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[93.540301] Starting dynamic subtest: pipe-C-eDP-1
[93.562616] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[93.571561] Starting dynamic subtest: pipe-D-eDP-1
[93.594600] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[93.598729] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[95.770996] [016/131] (923s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[95.881460] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[102.603077] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.724s)
[102.763919] [017/131] (916s left) gem_mmap_wc (bad-size)
[102.828079] Subtest bad-size: SKIP (0.000s)
[102.882221] [018/131] (916s left) kms_fence_pin_leak
[103.062383] [019/131] (915s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[103.148277] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[103.150599] Starting dynamic subtest: pipe-A
[103.497588] Dynamic subtest pipe-A: SUCCESS (0.352s)
[103.506043] Starting dynamic subtest: pipe-B
[104.916518] Dynamic subtest pipe-B: SUCCESS (1.419s)
[104.924995] Starting dynamic subtest: pipe-C
[106.320102] Dynamic subtest pipe-C: SUCCESS (1.403s)
[106.329136] Starting dynamic subtest: pipe-D
[107.755069] Dynamic subtest pipe-D: SUCCESS (1.434s)
[107.757399] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.610s)
[108.936812] [020/131] (910s left) kms_plane (plane-panning-bottom-right-suspend)
[109.035298] Starting subtest: plane-panning-bottom-right-suspend
[109.037515] Starting dynamic subtest: pipe-A
[126.878107] Dynamic subtest pipe-A: SUCCESS (6.580s)
[126.889030] Starting dynamic subtest: pipe-B
[145.830381] Dynamic subtest pipe-B: SUCCESS (3.458s)
[145.832825] Subtest plane-panning-bottom-right-suspend: SUCCESS (10.040s)
[146.679204] [021/131] (872s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[146.821322] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[146.825735] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[146.942924] [022/131] (872s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[147.079859] Starting subtest: short-busy-flip-before-cursor-toggle
[147.084316] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[147.246594] [023/131] (871s left) gem_spin_batch (resubmit-new-all)
[147.308848] Starting subtest: resubmit-new-all
[147.311152] Starting dynamic subtest: rcs0
[147.322945] Dynamic subtest rcs0: SUCCESS (0.014s)
[147.333027] Starting dynamic subtest: bcs0
[147.335338] Dynamic subtest bcs0: SUCCESS (0.010s)
[147.344310] Starting dynamic subtest: vcs0
[147.347000] Dynamic subtest vcs0: SUCCESS (0.009s)
[147.360685] Starting dynamic subtest: vcs1
[147.362631] Dynamic subtest vcs1: SUCCESS (0.008s)
[147.371910] Starting dynamic subtest: vecs0
[147.373805] Dynamic subtest vecs0: SUCCESS (0.008s)
[147.381198] Starting dynamic subtest: ccs0
[147.383155] Dynamic subtest ccs0: SUCCESS (0.007s)
[147.385100] Subtest resubmit-new-all: SUCCESS (0.059s)
[148.701083] [024/131] (870s left) kms_lease (cursor-implicit-plane)
[148.798346] Starting subtest: cursor-implicit-plane
[148.800677] Starting dynamic subtest: pipe-A-eDP-1
[149.260113] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.460s)
[149.274579] Starting dynamic subtest: pipe-B-eDP-1
[150.365921] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.105s)
[150.375783] Starting dynamic subtest: pipe-C-eDP-1
[151.508640] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.140s)
[151.516841] Starting dynamic subtest: pipe-D-eDP-1
[152.622168] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.112s)
[152.624574] Subtest cursor-implicit-plane: SUCCESS (3.822s)
[153.495850] [025/131] (865s left) gem_exec_whisper (basic-forked-all)
[153.572121] Starting subtest: basic-forked-all
[167.637434] Subtest basic-forked-all: SUCCESS (14.058s)
[167.843920] [026/131] (851s left) kms_flip (nonexisting-fb)
[167.930718] Starting subtest: nonexisting-fb
[167.933079] Starting dynamic subtest: A-eDP1
[169.070744] Dynamic subtest A-eDP1: SUCCESS (1.137s)
[169.083001] Starting dynamic subtest: B-eDP1
[170.202868] Dynamic subtest B-eDP1: SUCCESS (1.131s)
[170.211196] Starting dynamic subtest: C-eDP1
[171.340118] Dynamic subtest C-eDP1: SUCCESS (1.136s)
[171.348758] Starting dynamic subtest: D-eDP1
[172.483826] Dynamic subtest D-eDP1: SUCCESS (1.142s)
[172.489209] Subtest nonexisting-fb: SUCCESS (4.558s)
[173.753811] [027/131] (845s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[173.845275] Starting subtest: x-tiled-16bpp-rotate-180
[175.112889] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.267s)
[175.298711] [028/131] (843s left) i915_drm_fdinfo (virtual-idle)
[175.344864] Starting subtest: virtual-idle
[178.387431] Subtest virtual-idle: SUCCESS (3.037s)
[178.480805] [029/131] (840s left) gem_caching (reads)
[178.557043] Subtest reads: SKIP (0.000s)
[178.635137] [030/131] (840s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[178.698775] Starting subtest: wait-all-for-submit-delayed-submit
[178.800009] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.102s)
[178.906486] [031/131] (840s left) kms_hdmi_inject (inject-4k)
[179.248425] Starting subtest: inject-4k
[179.559703] Subtest inject-4k: SUCCESS (0.313s)
[180.118613] [032/131] (839s left) gem_lmem_swapping (parallel-random-engines)
[180.157765] Subtest parallel-random-engines: SKIP (0.000s)
[180.205003] [033/131] (839s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[180.312575] Starting subtest: yf-tiled-64bpp-rotate-270
[180.317125] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[180.460680] [034/131] (839s left) gem_exec_reloc (basic-write-read-noreloc)
[180.521160] Subtest basic-write-read-noreloc: SKIP (0.000s)
[180.609643] [035/131] (838s left) kms_cursor_crc (cursor-onscreen-64x21)
[180.808684] Starting subtest: cursor-onscreen-64x21
[180.856542] Subtest cursor-onscreen-64x21: SKIP (0.043s)
[181.095699] [036/131] (838s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[181.187743] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[181.189307] Starting dynamic subtest: pipe-A-eDP-1
[183.293184] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.104s)
[183.301488] Starting dynamic subtest: pipe-B-eDP-1
[185.536567] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.243s)
[185.544373] Starting dynamic subtest: pipe-C-eDP-1
[187.645075] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.107s)
[187.653458] Starting dynamic subtest: pipe-D-eDP-1
[189.691804] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.043s)
[189.694067] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.502s)
[190.901419] [037/131] (828s left) gem_exec_schedule (pi-shared-iova)
[191.081536] Starting subtest: pi-shared-iova
[191.084110] Starting dynamic subtest: rcs0
[191.152461] Dynamic subtest rcs0: SUCCESS (0.072s)
[191.163169] Starting dynamic subtest: vcs0
[191.223312] Dynamic subtest vcs0: SUCCESS (0.070s)
[191.231833] Starting dynamic subtest: vcs1
[191.271683] Dynamic subtest vcs1: SUCCESS (0.048s)
[191.279816] Starting dynamic subtest: vecs0
[191.330253] Dynamic subtest vecs0: SUCCESS (0.058s)
[191.340805] Starting dynamic subtest: ccs0
[191.395897] Dynamic subtest ccs0: SUCCESS (0.064s)
[191.400394] Subtest pi-shared-iova: SUCCESS (0.317s)
[192.736011] [038/131] (826s left) gem_exec_schedule (submit-late-slice)
[192.814736] Starting subtest: submit-late-slice
[192.816673] Starting dynamic subtest: rcs0
[192.837754] Dynamic subtest rcs0: SUCCESS (0.032s)
[192.848781] Starting dynamic subtest: bcs0
[192.863690] Dynamic subtest bcs0: SUCCESS (0.025s)
[192.871675] Starting dynamic subtest: vcs0
[192.893533] Dynamic subtest vcs0: SUCCESS (0.029s)
[192.901779] Starting dynamic subtest: vcs1
[192.920377] Dynamic subtest vcs1: SUCCESS (0.026s)
[192.929115] Starting dynamic subtest: vecs0
[192.946021] Dynamic subtest vecs0: SUCCESS (0.024s)
[192.956341] Starting dynamic subtest: ccs0
[192.974625] Dynamic subtest ccs0: SUCCESS (0.028s)
[192.976780] Subtest submit-late-slice: SUCCESS (0.169s)
[194.775049] [039/131] (824s left) kms_psr (psr-suspend)
[194.882085] Starting subtest: psr-suspend
[194.884412] Starting dynamic subtest: eDP-1
[212.896077] Dynamic subtest eDP-1: SUCCESS (2.980s)
[212.898471] Subtest psr-suspend: SUCCESS (2.982s)
[213.762465] [040/131] (805s left) kms_pipe_crc_basic (hang-read-crc)
[213.870916] Starting subtest: hang-read-crc
[213.873127] Starting dynamic subtest: pipe-A-eDP-1
[215.999573] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.128s)
[216.009256] Starting dynamic subtest: pipe-B-eDP-1
[218.795780] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.793s)
[218.804812] Starting dynamic subtest: pipe-C-eDP-1
[221.442096] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.646s)
[221.454533] Starting dynamic subtest: pipe-D-eDP-1
[224.048305] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.606s)
[224.050589] Subtest hang-read-crc: SUCCESS (10.179s)
[224.891441] [041/131] (794s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[225.108860] Starting subtest: cursor-rapid-movement-128x128
[225.113898] Starting dynamic subtest: pipe-A-eDP-1
[225.643158] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.531s)
[225.674383] Starting dynamic subtest: pipe-D-eDP-1
[226.823861] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.156s)
[226.826116] Subtest cursor-rapid-movement-128x128: SUCCESS (1.713s)
[227.662650] [042/131] (792s left) api_intel_allocator (open-vm)
[227.732538] Starting subtest: open-vm
[227.734529] Subtest open-vm: SUCCESS (0.003s)
[227.891305] [043/131] (791s left) kms_properties (plane-properties-atomic)
[227.991188] Starting subtest: plane-properties-atomic
[227.993455] Starting dynamic subtest: pipe-A-eDP-1
[228.539494] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.548s)
[228.548734] Starting dynamic subtest: pipe-B-eDP-1
[229.776132] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.236s)
[229.786446] Starting dynamic subtest: pipe-C-eDP-1
[231.075978] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.298s)
[231.085583] Starting dynamic subtest: pipe-D-eDP-1
[232.372503] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.293s)
[232.374376] Subtest plane-properties-atomic: SUCCESS (4.381s)
[233.264929] [044/131] (786s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[233.330685] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[233.418698] [045/131] (786s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[233.533392] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[240.136397] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.605s)
[240.302532] [046/131] (779s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[240.418318] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[244.674782] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.259s)
[245.880133] [047/131] (774s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[246.457108] Starting subtest: syncobj-stationary-timeline-chain-engines
[246.579129] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.126s)
[247.842961] [FACT gem_exec_fence (syncobj-stationary-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true
[247.846389] [048/131] (772s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[247.939916] Starting subtest: fbc-psr2-cursor-plane-onoff
[247.942170] Starting dynamic subtest: eDP-1
[247.946389] Dynamic subtest eDP-1: SKIP (0.000s)
[247.950359] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.002s)
[248.040928] [049/131] (772s left) perf (polling)
[248.169655] Starting subtest: polling
[248.172007] Starting dynamic subtest: 0-rcs0
[258.193203] Dynamic subtest 0-rcs0: SUCCESS (10.022s)
[258.202068] Starting dynamic subtest: 1-vcs1
[268.215181] Dynamic subtest 1-vcs1: SUCCESS (10.020s)
[268.217938] Subtest polling: SUCCESS (20.046s)
[268.264075] [050/131] (751s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[268.331328] Starting subtest: y-tiled-to-vebox-y-tiled
[268.335484] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[268.541729] [051/131] (751s left) kms_frontbuffer_tracking (fbc-stridechange)
[268.655613] Starting subtest: fbc-stridechange
[271.907663] Subtest fbc-stridechange: SUCCESS (3.257s)
[273.073327] [052/131] (747s left) perf_pmu (idle-no-semaphores)
[273.113556] Starting subtest: idle-no-semaphores
[273.115526] Starting dynamic subtest: rcs0
[273.692372] Dynamic subtest rcs0: SUCCESS (0.577s)
[273.705161] Starting dynamic subtest: bcs0
[274.222467] Dynamic subtest bcs0: SUCCESS (0.527s)
[274.235694] Starting dynamic subtest: vcs0
[274.750365] Dynamic subtest vcs0: SUCCESS (0.525s)
[274.763233] Starting dynamic subtest: vcs1
[275.282506] Dynamic subtest vcs1: SUCCESS (0.529s)
[275.293091] Starting dynamic subtest: vecs0
[275.812567] Dynamic subtest vecs0: SUCCESS (0.527s)
[275.825703] Starting dynamic subtest: ccs0
[276.346389] Dynamic subtest ccs0: SUCCESS (0.530s)
[276.349018] Subtest idle-no-semaphores: SUCCESS (3.234s)
[276.494260] [053/131] (743s left) gen9_exec_parse (shadow-peek)
[276.555405] Subtest shadow-peek: SKIP (0.000s)
[276.649740] [054/131] (743s left) gem_exec_balancer (nohangcheck)
[276.911284] Starting subtest: nohangcheck
[277.801664] Subtest nohangcheck: SUCCESS (0.890s)
[277.967889] [055/131] (742s left) gem_exec_flush (basic-wb-prw-default)
[278.034434] Starting subtest: basic-wb-prw-default
[283.506509] Subtest basic-wb-prw-default: SUCCESS (5.471s)
[283.720306] [056/131] (736s left) gem_readwrite (write-bad-handle)
[283.777803] Subtest write-bad-handle: SKIP (0.000s)
[283.842895] [057/131] (736s left) kms_pm_rpm (modeset-non-lpsp-stress)
[285.865458] Starting subtest: modeset-non-lpsp-stress
[287.024215] Subtest modeset-non-lpsp-stress: SKIP (1.156s)
[287.418993] [058/131] (733s left) gem_mmap_offset (blt-coherency)
[287.490838] Starting subtest: blt-coherency
[287.495831] Subtest blt-coherency: SUCCESS (0.007s)
[287.658749] [059/131] (732s left) gem_exec_reloc (basic-write-cpu-noreloc)
[287.714433] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[287.805817] [060/131] (732s left) gem_ctx_engines (independent)
[287.857443] Starting subtest: independent
[287.859840] Starting dynamic subtest: rcs0
[287.999529] Dynamic subtest rcs0: SUCCESS (0.140s)
[288.011921] Starting dynamic subtest: bcs0
[288.136686] Dynamic subtest bcs0: SUCCESS (0.137s)
[288.148123] Starting dynamic subtest: vcs0
[288.279012] Dynamic subtest vcs0: SUCCESS (0.141s)
[288.288429] Starting dynamic subtest: vcs1
[288.425839] Dynamic subtest vcs1: SUCCESS (0.147s)
[288.438024] Starting dynamic subtest: vecs0
[288.601301] Dynamic subtest vecs0: SUCCESS (0.173s)
[288.613119] Starting dynamic subtest: ccs0
[288.771502] Dynamic subtest ccs0: SUCCESS (0.169s)
[288.783202] Starting dynamic subtest: all-engines
[289.472347] Dynamic subtest all-engines: SUCCESS (0.700s)
[289.474815] Subtest independent: SUCCESS (1.614s)
[289.881522] [061/131] (730s left) kms_pm_dc (dc5-dpms-negative)
[290.993992] Starting subtest: dc5-dpms-negative
[290.998364] Subtest dc5-dpms-negative: SKIP (0.000s)
[291.090235] [062/131] (729s left) perf_pmu (render-node-busy-idle)
[291.183314] Starting subtest: render-node-busy-idle
[291.186119] Starting dynamic subtest: rcs0
[291.887850] Dynamic subtest rcs0: SUCCESS (0.704s)
[291.900330] Starting dynamic subtest: bcs0
[292.549735] Dynamic subtest bcs0: SUCCESS (0.660s)
[292.562636] Starting dynamic subtest: vcs0
[293.715823] Dynamic subtest vcs0: SUCCESS (1.162s)
[293.728024] Starting dynamic subtest: vcs1
[295.699905] Dynamic subtest vcs1: SUCCESS (1.981s)
[295.712270] Starting dynamic subtest: vecs0
[297.683308] Dynamic subtest vecs0: SUCCESS (1.980s)
[297.695823] Starting dynamic subtest: ccs0
[298.352503] Dynamic subtest ccs0: SUCCESS (0.668s)
[298.355171] Subtest render-node-busy-idle: SUCCESS (7.169s)
[298.454143] [063/131] (722s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[298.565373] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[298.569682] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[298.706133] [064/131] (722s left) gem_exercise_blt (fast-copy-emit)
[298.778577] Starting subtest: fast-copy-emit
[298.780878] Starting dynamic subtest: linear-smem-smem-emit
[298.801866] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.023s)
[298.813381] Starting dynamic subtest: xmajor-smem-smem-emit
[298.818863] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.016s)
[298.827886] Starting dynamic subtest: tile4-smem-smem-emit
[298.835483] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.016s)
[298.844349] Starting dynamic subtest: tile64-smem-smem-emit
[298.852300] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.016s)
[298.854590] Subtest fast-copy-emit: SUCCESS (0.074s)
[299.029076] [065/131] (721s left) sw_sync (timeline_closed)
[299.058906] Starting subtest: timeline_closed
[299.061206] Subtest timeline_closed: SUCCESS (0.000s)
[299.135471] [066/131] (721s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[299.273396] Starting subtest: basic-flip-after-cursor-atomic
[300.197243] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.923s)
[301.068824] [067/131] (719s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[301.186647] Starting subtest: y-tiled-8bpp-rotate-180
[301.191121] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[301.312162] [068/131] (719s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[301.423274] Starting subtest: flip-vs-dpms-on-nop-interruptible
[301.425716] Starting dynamic subtest: A-eDP1
[303.296819] Dynamic subtest A-eDP1: SUCCESS (1.877s)
[303.308098] Starting dynamic subtest: B-eDP1
[305.109194] Dynamic subtest B-eDP1: SUCCESS (1.811s)
[305.120036] Starting dynamic subtest: C-eDP1
[306.901947] Dynamic subtest C-eDP1: SUCCESS (1.791s)
[306.914127] Starting dynamic subtest: D-eDP1
[308.692750] Dynamic subtest D-eDP1: SUCCESS (1.788s)
[308.697870] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.279s)
[309.968957] [069/131] (710s left) kms_psr2_su (page_flip-xrgb8888)
[310.036332] Subtest page_flip-XRGB8888: SKIP (0.000s)
[310.114906] [070/131] (710s left) kms_vrr (max-min)
[310.222277] Starting subtest: max-min
[310.228334] Subtest max-min: SKIP (0.000s)
[310.315212] [071/131] (710s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[310.431660] Starting subtest: flip-vs-cursor-atomic
[317.545766] Subtest flip-vs-cursor-atomic: SUCCESS (7.114s)
[318.363045] [072/131] (702s left) gem_exec_reloc (basic-gtt)
[318.439846] Subtest basic-gtt: SKIP (0.000s)
[318.528258] [073/131] (702s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[318.625231] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[318.627420] Starting dynamic subtest: pipe-A-eDP-1
[318.649838] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[318.660592] Starting dynamic subtest: pipe-B-eDP-1
[318.681651] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[318.690189] Starting dynamic subtest: pipe-C-eDP-1
[318.711488] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[318.720009] Starting dynamic subtest: pipe-D-eDP-1
[318.742799] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[318.747228] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[320.866608] [074/131] (700s left) gen9_exec_parse (bb-secure)
[320.917205] Subtest bb-secure: SKIP (0.000s)
[320.997173] [075/131] (700s left) kms_content_protection (type1)
[321.134982] Starting subtest: type1
[321.139174] Subtest type1: SKIP (0.000s)
[321.297710] [076/131] (699s left) vgem_basic (sysfs)
[321.338846] Starting subtest: sysfs
[321.341000] Subtest sysfs: SUCCESS (0.000s)
[321.417071] [077/131] (699s left) syncobj_eventfd (binary-wait)
[321.476545] Starting subtest: binary-wait
[321.485341] Subtest binary-wait: SUCCESS (0.010s)
[321.619043] [078/131] (699s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[322.016447] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[322.825653] [079/131] (698s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[322.921610] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[322.926201] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[323.061524] [080/131] (698s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[323.153834] Starting subtest: plane-ctm3x4-lut1d
[323.166651] Starting dynamic subtest: pipe-A-eDP-1
[323.860492] Dynamic subtest pipe-A-eDP-1: FAIL (0.323s)
[324.589395] Starting dynamic subtest: pipe-B-eDP-1
[325.413266] Dynamic subtest pipe-B-eDP-1: FAIL (0.290s)
[325.991136] Starting dynamic subtest: pipe-C-eDP-1
[326.812780] Dynamic subtest pipe-C-eDP-1: FAIL (0.235s)
[327.291945] Starting dynamic subtest: pipe-D-eDP-1
[328.127857] Dynamic subtest pipe-D-eDP-1: FAIL (0.257s)
[328.129798] Subtest plane-ctm3x4-lut1d: FAIL (4.678s)
[328.661965] [081/131] (692s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[328.766946] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[328.769251] Starting dynamic subtest: A-eDP1
[337.648317] Dynamic subtest A-eDP1: SUCCESS (8.880s)
[337.657456] Starting dynamic subtest: B-eDP1
[346.557931] Dynamic subtest B-eDP1: SUCCESS (8.907s)
[346.568956] Starting dynamic subtest: C-eDP1
[355.443658] Dynamic subtest C-eDP1: SUCCESS (8.882s)
[355.456324] Starting dynamic subtest: D-eDP1
[364.340439] Dynamic subtest D-eDP1: SUCCESS (8.895s)
[364.345038] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.575s)
[365.576717] [082/131] (655s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[365.673430] Starting subtest: psr-2p-primscrn-spr-indfb-move
[365.677833] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[365.806595] [083/131] (655s left) kms_cursor_edge_walk (256x256-top-bottom)
[365.913893] Starting subtest: 256x256-top-bottom
[365.916110] Starting dynamic subtest: pipe-A-eDP-1
[369.368319] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.454s)
[369.377930] Starting dynamic subtest: pipe-D-eDP-1
[372.561439] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.191s)
[372.563828] Subtest 256x256-top-bottom: SUCCESS (6.648s)
[373.379228] [084/131] (648s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[373.516368] Starting subtest: 2x-long-cursor-vs-flip-legacy
[373.520675] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.001s)
[373.686677] [085/131] (647s left) kms_flip (flip-vs-modeset-vs-hang)
[373.778389] Starting subtest: flip-vs-modeset-vs-hang
[373.780741] Starting dynamic subtest: A-eDP1
[425.133566] Dynamic subtest A-eDP1: SUCCESS (51.344s)
[425.144536] Starting dynamic subtest: D-eDP1
[475.180713] Dynamic subtest D-eDP1: SUCCESS (50.046s)
[475.183057] Subtest flip-vs-modeset-vs-hang: SUCCESS (101.396s)
[475.601149] [086/131] (546s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[475.990606] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[476.813617] [087/131] (544s left) gem_pxp (reject-modify-context-protection-off-3)
[476.939840] Starting subtest: reject-modify-context-protection-off-3
[476.942264] Subtest reject-modify-context-protection-off-3: SUCCESS (0.001s)
[477.108384] [088/131] (544s left) kms_big_fb (linear-16bpp-rotate-0)
[477.211412] Starting subtest: linear-16bpp-rotate-0
[478.535281] Subtest linear-16bpp-rotate-0: SUCCESS (1.323s)
[478.716717] [089/131] (543s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[478.827738] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[487.337492] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.510s)
[487.475639] [090/131] (534s left) gem_exec_reloc (basic-active)
[487.540186] Subtest basic-active: SKIP (0.000s)
[487.632178] [091/131] (534s left) syncobj_timeline (reset-unsignaled)
[487.692846] Starting subtest: reset-unsignaled
[487.695181] Subtest reset-unsignaled: SUCCESS (0.000s)
[487.831911] [092/131] (534s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[487.940231] Starting subtest: fbcpsr-shrfb-scaledprimary
[493.630945] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.693s)
[493.858972] [093/131] (528s left) syncobj_timeline (invalid-wait-bad-flags)
[493.930815] Starting subtest: invalid-wait-bad-flags
[493.933133] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[494.057579] [094/131] (527s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[494.154139] Starting subtest: fbc-rgb101010-draw-render
[498.701614] Subtest fbc-rgb101010-draw-render: SUCCESS (4.550s)
[499.866694] [095/131] (522s left) kms_hdr (bpc-switch)
[499.963487] Starting subtest: bpc-switch
[501.080033] Starting dynamic subtest: pipe-A-eDP-1
[504.474397] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.394s)
[504.476754] Subtest bpc-switch: SUCCESS (4.512s)
[504.636037] [096/131] (517s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[504.730452] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[509.139421] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.412s)
[510.369468] [097/131] (511s left) gem_exec_balancer (parallel-keep-submit-fence)
[510.627142] Starting subtest: parallel-keep-submit-fence
[511.823387] Subtest parallel-keep-submit-fence: SUCCESS (1.196s)
[511.963904] [098/131] (510s left) i915_pm_rc6_residency (rc6-idle)
[512.017181] Starting subtest: rc6-idle
[512.053955] Starting dynamic subtest: gt0-rcs0
[536.396278] Dynamic subtest gt0-rcs0: SUCCESS (24.341s)
[536.405751] Starting dynamic subtest: gt0-bcs0
[560.735984] Dynamic subtest gt0-bcs0: SUCCESS (24.336s)
[560.745149] Starting dynamic subtest: gt0-ccs0
[584.946194] Dynamic subtest gt0-ccs0: SUCCESS (24.206s)
[584.957553] Starting dynamic subtest: gt1-vcs0
[591.121324] Dynamic subtest gt1-vcs0: SUCCESS (6.169s)
[591.133815] Starting dynamic subtest: gt1-vecs0
[597.292878] Dynamic subtest gt1-vecs0: SUCCESS (6.168s)
[597.295832] Subtest rc6-idle: SUCCESS (85.271s)
[597.398866] [099/131] (424s left) prime_mmap (test_map_unmap)
[597.465781] Starting subtest: test_map_unmap
[597.468013] Starting dynamic subtest: test_map_unmap-smem
[597.494892] Dynamic subtest test_map_unmap-smem: SUCCESS (0.031s)
[597.497245] Subtest test_map_unmap: SUCCESS (0.032s)
[597.628437] [100/131] (424s left) kms_addfb_basic (invalid-set-prop-any)
[597.689456] Starting subtest: invalid-set-prop-any
[597.691379] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[597.870562] [101/131] (424s left) kms_setmode (basic)
[597.928294] Starting subtest: basic
[598.248111] Starting dynamic subtest: pipe-A-eDP-1
[600.321135] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.068s)
[600.671449] Starting dynamic subtest: pipe-B-eDP-1
[602.721972] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.054s)
[603.026962] Subtest basic: SUCCESS (5.097s)
[603.854432] [102/131] (418s left) kms_properties (colorop-properties-atomic)
[603.956303] Starting subtest: colorop-properties-atomic
[603.958488] Starting dynamic subtest: pipe-A-eDP-1
[604.292674] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.337s)
[604.302805] Starting dynamic subtest: pipe-B-eDP-1
[605.353567] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.057s)
[605.363822] Starting dynamic subtest: pipe-C-eDP-1
[606.469281] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.116s)
[606.479568] Starting dynamic subtest: pipe-D-eDP-1
[607.556432] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.085s)
[607.558867] Subtest colorop-properties-atomic: SUCCESS (3.602s)
[608.457656] [103/131] (413s left) gem_mmap_wc (read-write)
[608.514251] Subtest read-write: SKIP (0.000s)
[608.582076] [104/131] (413s left) gem_eio (kms)
[608.862683] Starting subtest: kms
[630.276127] Subtest kms: SUCCESS (21.410s)
[630.444892] [105/131] (392s left) drm_read (short-buffer-block)
[630.621609] Starting subtest: short-buffer-block
[630.623838] Subtest short-buffer-block: SUCCESS (0.000s)
[630.784188] [106/131] (391s left) gem_workarounds (reset-fd)
[630.864758] Starting subtest: reset-fd
[631.059523] Subtest reset-fd: SUCCESS (0.194s)
[631.217681] [107/131] (391s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[631.312104] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[631.315911] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[631.453345] [108/131] (391s left) kms_psr (fbc-psr-sprite-blt)
[631.545985] Starting subtest: fbc-psr-sprite-blt
[631.547819] Starting dynamic subtest: eDP-1
[631.551116] Dynamic subtest eDP-1: SKIP (0.000s)
[631.554324] Subtest fbc-psr-sprite-blt: SKIP (0.001s)
[631.648280] [109/131] (391s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[631.754549] Starting subtest: 4-tiled-16bpp-rotate-0
[633.001780] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.246s)
[633.176082] [110/131] (389s left) syncobj_timeline (invalid-signal-illegal-point)
[633.243243] Starting subtest: invalid-signal-illegal-point
[633.244832] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[633.365122] [111/131] (389s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[633.462119] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[633.463948] Starting dynamic subtest: pipe-A-eDP-1
[633.485177] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[633.496006] Starting dynamic subtest: pipe-B-eDP-1
[633.515554] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[633.525098] Starting dynamic subtest: pipe-C-eDP-1
[633.545310] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[633.555357] Starting dynamic subtest: pipe-D-eDP-1
[633.575263] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[633.578882] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[635.756116] [112/131] (387s left) kms_dsc (dsc-with-output-formats)
[635.852303] Starting subtest: dsc-with-output-formats
[635.874298] Subtest dsc-with-output-formats: SKIP (0.001s)
[635.950669] [113/131] (386s left) kms_properties (get_properties-sanity-atomic)
[636.052094] Starting subtest: get_properties-sanity-atomic
[636.054330] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[636.170969] [114/131] (386s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[636.273128] Starting subtest: 4-tiled-32bpp-rotate-90
[636.295437] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.019s)
[636.453029] [115/131] (386s left) core_setmaster (master-drop-set-root)
[636.533291] Starting subtest: master-drop-set-root
[636.545764] Subtest master-drop-set-root: SUCCESS (0.013s)
[636.595206] [116/131] (386s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[636.694823] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[636.698431] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[636.808794] [117/131] (386s left) gem_sync (basic-all)
[636.888169] Starting subtest: basic-all
[640.724659] Subtest basic-all: SUCCESS (3.842s)
[640.936984] [118/131] (382s left) gem_ctx_persistence (heartbeat-close)
[640.999550] Starting subtest: heartbeat-close
[641.004223] Subtest heartbeat-close: SKIP (0.000s)
[641.133060] [119/131] (381s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[646.216137] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[646.220510] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.002s)
[647.059099] [120/131] (376s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[647.151397] Starting subtest: primary-x-tiled-reflect-x-0
[654.206686] Subtest primary-x-tiled-reflect-x-0: SUCCESS (7.055s)
[655.457217] [121/131] (367s left) gem_eio (in-flight-external)
[655.704569] Starting subtest: in-flight-external
[656.739707] Subtest in-flight-external: SUCCESS (1.033s)
[656.909846] [122/131] (366s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[657.001131] Starting subtest: compare-crc-sanitycheck-xr24
[657.003401] Starting dynamic subtest: pipe-A-eDP-1
[657.666644] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.664s)
[657.676568] Starting dynamic subtest: pipe-B-eDP-1
[659.006691] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.340s)
[659.017258] Starting dynamic subtest: pipe-C-eDP-1
[660.213500] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.205s)
[660.223217] Starting dynamic subtest: pipe-D-eDP-1
[661.454646] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.238s)
[661.456930] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.455s)
[662.276309] [123/131] (361s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[662.335223] Subtest writes-after-reads-uncached: SKIP (0.000s)
[662.423908] [124/131] (360s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[662.523656] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[662.527795] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[662.669780] [125/131] (360s left) gem_mmap_gtt (big-bo-tiledy)
[662.733134] Subtest big-bo-tiledY: SKIP (0.000s)
[662.800346] [126/131] (360s left) i915_query (engine-info)
[662.862348] Starting subtest: engine-info
[662.864438] Subtest engine-info: SUCCESS (0.005s)
[663.025687] [127/131] (360s left) gem_ctx_persistence (engines-mixed-process)
[663.081216] Starting subtest: engines-mixed-process
[663.083593] Starting dynamic subtest: rcs0
[664.769109] Dynamic subtest rcs0: SUCCESS (1.687s)
[664.781540] Starting dynamic subtest: bcs0
[666.730542] Dynamic subtest bcs0: SUCCESS (1.959s)
[666.742819] Starting dynamic subtest: vcs0
[668.675900] Dynamic subtest vcs0: SUCCESS (1.940s)
[668.686132] Starting dynamic subtest: vcs1
[670.709997] Dynamic subtest vcs1: SUCCESS (2.035s)
[670.721813] Starting dynamic subtest: vecs0
[672.742237] Dynamic subtest vecs0: SUCCESS (2.030s)
[672.753929] Starting dynamic subtest: ccs0
[674.712083] Dynamic subtest ccs0: SUCCESS (1.968s)
[674.714508] Subtest engines-mixed-process: SUCCESS (11.630s)
[674.816087] [128/131] (348s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[674.885505] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[674.992394] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.106s)
[675.098881] [129/131] (348s left) sysfs_heartbeat_interval (precise)
[675.168738] Starting subtest: precise
[675.171210] Starting dynamic subtest: vecs0
[682.726684] Dynamic subtest vecs0: SUCCESS (7.553s)
[682.738154] Starting dynamic subtest: ccs0
[683.875336] Dynamic subtest ccs0: SUCCESS (1.148s)
[683.887267] Starting dynamic subtest: vcs0
[691.695019] Dynamic subtest vcs0: SUCCESS (7.814s)
[691.707003] Starting dynamic subtest: bcs0
[694.752047] Dynamic subtest bcs0: SUCCESS (3.057s)
[694.764758] Starting dynamic subtest: rcs0
[695.866539] Dynamic subtest rcs0: SUCCESS (1.112s)
[695.878376] Starting dynamic subtest: vcs1
[703.728604] Dynamic subtest vcs1: SUCCESS (7.859s)
[703.731241] Subtest precise: SUCCESS (28.557s)
[703.826452] [130/131] (319s left) kms_psr (fbc-pr-cursor-render)
[703.933209] Starting subtest: fbc-pr-cursor-render
[703.937718] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[704.030690] [131/131] (319s left) kms_psr (psr2-sprite-render)
[704.141098] Starting subtest: psr2-sprite-render
[704.143346] Starting dynamic subtest: eDP-1
[705.896790] Dynamic subtest eDP-1: SUCCESS (1.754s)
[705.899104] Subtest psr2-sprite-render: SUCCESS (1.755s)
[706.742819] 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.