[57.696301] Initializing watchdogs
[57.696348]   /dev/watchdog0
[57.710545] [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.715124] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.717400] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.720898] [001/131] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[57.851316] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[57.855566] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[57.986951] [002/131] (960s left) api_intel_bb (render)
[58.054049] Starting subtest: render
[58.056165] Starting dynamic subtest: render-none-512
[58.191623] Dynamic subtest render-none-512: SUCCESS (0.138s)
[58.200515] Starting dynamic subtest: render-none-1024
[58.579043] Dynamic subtest render-none-1024: SUCCESS (0.388s)
[58.586470] Starting dynamic subtest: render-x-512
[58.665350] Dynamic subtest render-x-512: SUCCESS (0.087s)
[58.673212] Starting dynamic subtest: render-x-1024
[59.008839] Dynamic subtest render-x-1024: SUCCESS (0.343s)
[59.018189] Starting dynamic subtest: render-y-512
[59.094360] Dynamic subtest render-y-512: SUCCESS (0.086s)
[59.104029] Starting dynamic subtest: render-y-1024
[59.442857] Dynamic subtest render-y-1024: SUCCESS (0.348s)
[59.445872] Subtest render: SUCCESS (1.394s)
[59.598258] [003/131] (958s left) intel_hwmon (hwmon-read)
[59.662930] Subtest hwmon-read: SKIP (0.000s)
[59.730161] [004/131] (958s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[59.842678] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[64.416695] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.587s)
[65.595758] [005/131] (952s left) kms_psr (pr-sprite-render)
[65.690102] Starting subtest: pr-sprite-render
[65.694643] Subtest pr-sprite-render: SKIP (0.000s)
[65.780619] [006/131] (952s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[65.886455] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[65.890278] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[66.008726] [007/131] (952s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[66.152319] Starting subtest: cursorA-vs-flipA-atomic
[77.316252] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.172s)
[78.200315] [008/131] (940s left) fbdev (eof)
[78.241233] Starting subtest: eof
[78.243550] Subtest eof: SUCCESS (0.000s)
[78.330987] [009/131] (940s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[78.384687] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[78.386948] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[78.492839] [010/131] (940s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[78.600767] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[88.349588] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.750s)
[88.521033] [011/131] (930s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[88.626938] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[88.629241] Starting dynamic subtest: pipe-A-default-mode
[91.345581] Dynamic subtest pipe-A-default-mode: SUCCESS (2.719s)
[91.347890] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.720s)
[92.237796] [012/131] (926s left) gem_userptr_blits (huge-split)
[92.321169] Starting subtest: huge-split
[92.327338] Subtest huge-split: SUCCESS (0.006s)
[92.496755] [013/131] (926s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[92.615882] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[92.662314] [014/131] (926s left) kms_chamelium_frames (dp-crc-multiple)
[93.047652] Subtest dp-crc-multiple: SKIP (0.000s)
[93.836384] [015/131] (924s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[93.934486] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[93.936905] Starting dynamic subtest: pipe-A-eDP-1
[93.960370] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[93.968029] Starting dynamic subtest: pipe-B-eDP-1
[93.990045] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[93.997656] Starting dynamic subtest: pipe-C-eDP-1
[94.019624] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[94.026538] Starting dynamic subtest: pipe-D-eDP-1
[94.048280] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[94.052305] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[96.232349] [016/131] (922s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[96.344677] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[103.024874] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.683s)
[103.193332] [017/131] (915s left) gem_mmap_wc (bad-size)
[103.260323] Subtest bad-size: SKIP (0.000s)
[103.333306] [018/131] (915s left) kms_fence_pin_leak
[103.530830] [019/131] (915s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[103.620157] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[103.622450] Starting dynamic subtest: pipe-A
[103.981392] Dynamic subtest pipe-A: SUCCESS (0.364s)
[103.988492] Starting dynamic subtest: pipe-B
[105.412853] Dynamic subtest pipe-B: SUCCESS (1.430s)
[105.420629] Starting dynamic subtest: pipe-C
[106.851379] Dynamic subtest pipe-C: SUCCESS (1.438s)
[106.859123] Starting dynamic subtest: pipe-D
[108.295334] Dynamic subtest pipe-D: SUCCESS (1.443s)
[108.297660] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.678s)
[109.460969] [020/131] (909s left) kms_plane (plane-panning-bottom-right-suspend)
[109.556186] Starting subtest: plane-panning-bottom-right-suspend
[109.558185] Starting dynamic subtest: pipe-A
[127.434850] Dynamic subtest pipe-A: SUCCESS (6.674s)
[127.443355] Starting dynamic subtest: pipe-B
[146.441860] Dynamic subtest pipe-B: SUCCESS (3.500s)
[146.444187] Subtest plane-panning-bottom-right-suspend: SUCCESS (10.177s)
[147.262123] [021/131] (871s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[147.376733] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[147.380831] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[147.509020] [022/131] (871s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[147.628611] Starting subtest: short-busy-flip-before-cursor-toggle
[147.633198] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[147.790425] [023/131] (871s left) gem_spin_batch (resubmit-new-all)
[147.862364] Starting subtest: resubmit-new-all
[147.864743] Starting dynamic subtest: rcs0
[147.876626] Dynamic subtest rcs0: SUCCESS (0.014s)
[147.885435] Starting dynamic subtest: bcs0
[147.889717] Dynamic subtest bcs0: SUCCESS (0.011s)
[147.900389] Starting dynamic subtest: vcs0
[147.902230] Dynamic subtest vcs0: SUCCESS (0.008s)
[147.910295] Starting dynamic subtest: vcs1
[147.912455] Dynamic subtest vcs1: SUCCESS (0.009s)
[147.920448] Starting dynamic subtest: vecs0
[147.922737] Dynamic subtest vecs0: SUCCESS (0.016s)
[147.930984] Starting dynamic subtest: ccs0
[147.938833] Dynamic subtest ccs0: SUCCESS (0.015s)
[147.941262] Subtest resubmit-new-all: SUCCESS (0.078s)
[149.735567] [024/131] (869s left) kms_lease (cursor-implicit-plane)
[149.826241] Starting subtest: cursor-implicit-plane
[149.828549] Starting dynamic subtest: pipe-A-eDP-1
[150.294006] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.473s)
[150.304697] Starting dynamic subtest: pipe-B-eDP-1
[151.425732] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.139s)
[151.436324] Starting dynamic subtest: pipe-C-eDP-1
[152.522360] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.107s)
[152.531430] Starting dynamic subtest: pipe-D-eDP-1
[153.647916] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.132s)
[153.650427] Subtest cursor-implicit-plane: SUCCESS (3.855s)
[154.532293] [025/131] (864s left) gem_exec_whisper (basic-forked-all)
[154.605306] Starting subtest: basic-forked-all
[167.373993] Subtest basic-forked-all: SUCCESS (12.805s)
[167.579995] [026/131] (851s left) kms_flip (nonexisting-fb)
[167.678417] Starting subtest: nonexisting-fb
[167.680728] Starting dynamic subtest: A-eDP1
[168.855520] Dynamic subtest A-eDP1: SUCCESS (1.181s)
[168.865522] Starting dynamic subtest: B-eDP1
[169.991983] Dynamic subtest B-eDP1: SUCCESS (1.137s)
[170.000863] Starting dynamic subtest: C-eDP1
[171.129245] Dynamic subtest C-eDP1: SUCCESS (1.138s)
[171.139086] Starting dynamic subtest: D-eDP1
[172.262726] Dynamic subtest D-eDP1: SUCCESS (1.134s)
[172.265101] Subtest nonexisting-fb: SUCCESS (4.596s)
[173.444146] [027/131] (845s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[173.547275] Starting subtest: x-tiled-16bpp-rotate-180
[174.880366] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.336s)
[175.025937] [028/131] (844s left) i915_drm_fdinfo (virtual-idle)
[175.068594] Starting subtest: virtual-idle
[178.160125] Subtest virtual-idle: SUCCESS (3.092s)
[178.263092] [029/131] (841s left) gem_caching (reads)
[178.335471] Subtest reads: SKIP (0.000s)
[178.425112] [030/131] (840s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[178.491214] Starting subtest: wait-all-for-submit-delayed-submit
[178.592209] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.102s)
[178.695404] [031/131] (840s left) kms_hdmi_inject (inject-4k)
[179.042590] Starting subtest: inject-4k
[179.355810] Subtest inject-4k: SUCCESS (0.314s)
[179.907382] [032/131] (839s left) gem_lmem_swapping (parallel-random-engines)
[179.954857] Subtest parallel-random-engines: SKIP (0.000s)
[179.998167] [033/131] (839s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[180.108323] Starting subtest: yf-tiled-64bpp-rotate-270
[180.112791] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[180.242983] [034/131] (839s left) gem_exec_reloc (basic-write-read-noreloc)
[180.306852] Subtest basic-write-read-noreloc: SKIP (0.000s)
[180.394046] [035/131] (839s left) kms_cursor_crc (cursor-onscreen-64x21)
[180.573286] Starting subtest: cursor-onscreen-64x21
[180.619974] Subtest cursor-onscreen-64x21: SKIP (0.041s)
[180.889515] [036/131] (838s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[180.992721] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[180.994365] Starting dynamic subtest: pipe-A-eDP-1
[183.109881] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.116s)
[183.118363] Starting dynamic subtest: pipe-B-eDP-1
[185.319488] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.209s)
[185.328070] Starting dynamic subtest: pipe-C-eDP-1
[187.409184] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.086s)
[187.418329] Starting dynamic subtest: pipe-D-eDP-1
[189.474234] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.062s)
[189.476531] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.478s)
[190.698602] [037/131] (828s left) gem_exec_schedule (pi-shared-iova)
[190.899577] Starting subtest: pi-shared-iova
[190.901623] Starting dynamic subtest: rcs0
[190.976851] Dynamic subtest rcs0: SUCCESS (0.080s)
[190.990677] Starting dynamic subtest: vcs0
[191.034078] Dynamic subtest vcs0: SUCCESS (0.056s)
[191.042770] Starting dynamic subtest: vcs1
[191.086223] Dynamic subtest vcs1: SUCCESS (0.051s)
[191.097344] Starting dynamic subtest: vecs0
[191.139729] Dynamic subtest vecs0: SUCCESS (0.053s)
[191.151709] Starting dynamic subtest: ccs0
[191.194902] Dynamic subtest ccs0: SUCCESS (0.055s)
[191.197338] Subtest pi-shared-iova: SUCCESS (0.299s)
[192.805658] [038/131] (826s left) gem_exec_schedule (submit-late-slice)
[192.885764] Starting subtest: submit-late-slice
[192.887753] Starting dynamic subtest: rcs0
[192.908856] Dynamic subtest rcs0: SUCCESS (0.031s)
[192.919452] Starting dynamic subtest: bcs0
[192.936558] Dynamic subtest bcs0: SUCCESS (0.027s)
[192.945336] Starting dynamic subtest: vcs0
[192.965893] Dynamic subtest vcs0: SUCCESS (0.028s)
[192.974574] Starting dynamic subtest: vcs1
[193.013597] Dynamic subtest vcs1: SUCCESS (0.046s)
[193.022272] Starting dynamic subtest: vecs0
[193.039813] Dynamic subtest vecs0: SUCCESS (0.026s)
[193.048334] Starting dynamic subtest: ccs0
[193.068262] Dynamic subtest ccs0: SUCCESS (0.028s)
[193.070519] Subtest submit-late-slice: SUCCESS (0.192s)
[194.785043] [039/131] (824s left) kms_psr (psr-suspend)
[194.889262] Starting subtest: psr-suspend
[194.891636] Starting dynamic subtest: eDP-1
[212.480861] Dynamic subtest eDP-1: SUCCESS (2.876s)
[212.483195] Subtest psr-suspend: SUCCESS (2.877s)
[213.351270] [040/131] (806s left) kms_pipe_crc_basic (hang-read-crc)
[213.445821] Starting subtest: hang-read-crc
[213.447749] Starting dynamic subtest: pipe-A-eDP-1
[215.483997] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.066s)
[215.493392] Starting dynamic subtest: pipe-B-eDP-1
[218.332424] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.873s)
[218.342335] Starting dynamic subtest: pipe-C-eDP-1
[221.015479] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.700s)
[221.026515] Starting dynamic subtest: pipe-D-eDP-1
[223.673747] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.672s)
[223.676121] Subtest hang-read-crc: SUCCESS (10.317s)
[224.511107] [041/131] (795s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[224.730211] Starting subtest: cursor-rapid-movement-128x128
[224.735066] Starting dynamic subtest: pipe-A-eDP-1
[225.263673] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.529s)
[225.290040] Starting dynamic subtest: pipe-D-eDP-1
[226.509130] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.229s)
[226.511231] Subtest cursor-rapid-movement-128x128: SUCCESS (1.783s)
[227.353313] [042/131] (792s left) api_intel_allocator (open-vm)
[227.414089] Starting subtest: open-vm
[227.416637] Subtest open-vm: SUCCESS (0.003s)
[227.576679] [043/131] (792s left) kms_properties (plane-properties-atomic)
[227.693293] Starting subtest: plane-properties-atomic
[227.695563] Starting dynamic subtest: pipe-A-eDP-1
[228.242922] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.550s)
[228.252696] Starting dynamic subtest: pipe-B-eDP-1
[229.489895] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.249s)
[229.498878] Starting dynamic subtest: pipe-C-eDP-1
[230.725337] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.237s)
[230.734293] Starting dynamic subtest: pipe-D-eDP-1
[231.966947] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.243s)
[231.969434] Subtest plane-properties-atomic: SUCCESS (4.285s)
[232.785602] [044/131] (787s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[232.850181] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[232.935018] [045/131] (787s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[233.036232] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[239.775683] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.752s)
[239.953726] [046/131] (780s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[240.063089] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[244.366068] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.311s)
[245.511509] [047/131] (774s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[246.089093] Starting subtest: syncobj-stationary-timeline-chain-engines
[246.212840] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.124s)
[247.558468] [FACT gem_exec_fence (syncobj-stationary-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true
[247.561964] [048/131] (772s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[247.648393] Starting subtest: fbc-psr2-cursor-plane-onoff
[247.650722] Starting dynamic subtest: eDP-1
[247.655144] Dynamic subtest eDP-1: SKIP (0.000s)
[247.659581] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s)
[247.745824] [049/131] (772s left) perf (polling)
[247.882521] Starting subtest: polling
[247.884643] Starting dynamic subtest: 0-rcs0
[257.948795] Dynamic subtest 0-rcs0: SUCCESS (10.008s)
[257.959934] Starting dynamic subtest: 1-vcs1
[267.968206] Dynamic subtest 1-vcs1: SUCCESS (10.021s)
[267.970772] Subtest polling: SUCCESS (20.031s)
[268.010570] [050/131] (752s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[268.063287] Starting subtest: y-tiled-to-vebox-y-tiled
[268.068066] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[268.276737] [051/131] (751s left) kms_frontbuffer_tracking (fbc-stridechange)
[268.373229] Starting subtest: fbc-stridechange
[271.732096] Subtest fbc-stridechange: SUCCESS (3.361s)
[272.905658] [052/131] (747s left) perf_pmu (idle-no-semaphores)
[272.947921] Starting subtest: idle-no-semaphores
[272.950041] Starting dynamic subtest: rcs0
[273.481323] Dynamic subtest rcs0: SUCCESS (0.533s)
[273.492174] Starting dynamic subtest: bcs0
[274.001855] Dynamic subtest bcs0: SUCCESS (0.517s)
[274.012347] Starting dynamic subtest: vcs0
[274.518392] Dynamic subtest vcs0: SUCCESS (0.513s)
[274.530272] Starting dynamic subtest: vcs1
[275.051765] Dynamic subtest vcs1: SUCCESS (0.530s)
[275.063739] Starting dynamic subtest: vecs0
[275.583458] Dynamic subtest vecs0: SUCCESS (0.528s)
[275.595919] Starting dynamic subtest: ccs0
[276.109416] Dynamic subtest ccs0: SUCCESS (0.523s)
[276.112024] Subtest idle-no-semaphores: SUCCESS (3.164s)
[276.258119] [053/131] (744s left) gen9_exec_parse (shadow-peek)
[276.331412] Subtest shadow-peek: SKIP (0.000s)
[276.399776] [054/131] (743s left) gem_exec_balancer (nohangcheck)
[276.668957] Starting subtest: nohangcheck
[277.569062] Subtest nohangcheck: SUCCESS (0.900s)
[277.736647] [055/131] (742s left) gem_exec_flush (basic-wb-prw-default)
[277.803024] Starting subtest: basic-wb-prw-default
[283.290927] Subtest basic-wb-prw-default: SUCCESS (5.463s)
[283.480217] [056/131] (736s left) gem_readwrite (write-bad-handle)
[283.544833] Subtest write-bad-handle: SKIP (0.000s)
[283.611291] [057/131] (736s left) kms_pm_rpm (modeset-non-lpsp-stress)
[285.539494] Starting subtest: modeset-non-lpsp-stress
[286.693644] Subtest modeset-non-lpsp-stress: SKIP (1.155s)
[287.092193] [058/131] (733s left) gem_mmap_offset (blt-coherency)
[287.154997] Starting subtest: blt-coherency
[287.165644] Subtest blt-coherency: SUCCESS (0.013s)
[287.322305] [059/131] (733s left) gem_exec_reloc (basic-write-cpu-noreloc)
[287.385875] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[287.451452] [060/131] (733s left) gem_ctx_engines (independent)
[287.513819] Starting subtest: independent
[287.516005] Starting dynamic subtest: rcs0
[287.657415] Dynamic subtest rcs0: SUCCESS (0.141s)
[287.667930] Starting dynamic subtest: bcs0
[287.800273] Dynamic subtest bcs0: SUCCESS (0.142s)
[287.810290] Starting dynamic subtest: vcs0
[287.945669] Dynamic subtest vcs0: SUCCESS (0.145s)
[287.955800] Starting dynamic subtest: vcs1
[288.111072] Dynamic subtest vcs1: SUCCESS (0.166s)
[288.121593] Starting dynamic subtest: vecs0
[288.256284] Dynamic subtest vecs0: SUCCESS (0.143s)
[288.266373] Starting dynamic subtest: ccs0
[288.426294] Dynamic subtest ccs0: SUCCESS (0.169s)
[288.436997] Starting dynamic subtest: all-engines
[289.173072] Dynamic subtest all-engines: SUCCESS (0.747s)
[289.175801] Subtest independent: SUCCESS (1.660s)
[289.595857] [061/131] (731s left) kms_pm_dc (dc5-dpms-negative)
[290.705276] Starting subtest: dc5-dpms-negative
[290.709839] Subtest dc5-dpms-negative: SKIP (0.000s)
[290.803884] [062/131] (729s left) perf_pmu (render-node-busy-idle)
[290.891195] Starting subtest: render-node-busy-idle
[290.893566] Starting dynamic subtest: rcs0
[291.581314] Dynamic subtest rcs0: SUCCESS (0.692s)
[291.593338] Starting dynamic subtest: bcs0
[292.247650] Dynamic subtest bcs0: SUCCESS (0.665s)
[292.259465] Starting dynamic subtest: vcs0
[293.401208] Dynamic subtest vcs0: SUCCESS (1.150s)
[293.411341] Starting dynamic subtest: vcs1
[295.386566] Dynamic subtest vcs1: SUCCESS (1.983s)
[295.398730] Starting dynamic subtest: vecs0
[297.370444] Dynamic subtest vecs0: SUCCESS (1.981s)
[297.382734] Starting dynamic subtest: ccs0
[298.047757] Dynamic subtest ccs0: SUCCESS (0.677s)
[298.050308] Subtest render-node-busy-idle: SUCCESS (7.163s)
[298.151888] [063/131] (722s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[298.259836] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[298.263829] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[298.382767] [064/131] (722s left) gem_exercise_blt (fast-copy-emit)
[298.435019] Starting subtest: fast-copy-emit
[298.437479] Starting dynamic subtest: linear-smem-smem-emit
[298.456787] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.021s)
[298.468119] Starting dynamic subtest: xmajor-smem-smem-emit
[298.474717] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.017s)
[298.483943] Starting dynamic subtest: tile4-smem-smem-emit
[298.492436] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.017s)
[298.503302] Starting dynamic subtest: tile64-smem-smem-emit
[298.509267] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.016s)
[298.511505] Subtest fast-copy-emit: SUCCESS (0.075s)
[298.656965] [065/131] (722s left) sw_sync (timeline_closed)
[298.698841] Starting subtest: timeline_closed
[298.700730] Subtest timeline_closed: SUCCESS (0.000s)
[298.775531] [066/131] (722s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[298.889010] Starting subtest: basic-flip-after-cursor-atomic
[299.828506] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.938s)
[300.718357] [067/131] (720s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[300.828755] Starting subtest: y-tiled-8bpp-rotate-180
[300.832954] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[300.949894] [068/131] (720s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[301.050544] Starting subtest: flip-vs-dpms-on-nop-interruptible
[301.052764] Starting dynamic subtest: A-eDP1
[302.893298] Dynamic subtest A-eDP1: SUCCESS (1.842s)
[302.905633] Starting dynamic subtest: B-eDP1
[304.726431] Dynamic subtest B-eDP1: SUCCESS (1.831s)
[304.737828] Starting dynamic subtest: C-eDP1
[306.546014] Dynamic subtest C-eDP1: SUCCESS (1.818s)
[306.558847] Starting dynamic subtest: D-eDP1
[308.372224] Dynamic subtest D-eDP1: SUCCESS (1.823s)
[308.379112] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.331s)
[309.579291] [069/131] (711s left) kms_psr2_su (page_flip-xrgb8888)
[309.643650] Subtest page_flip-XRGB8888: SKIP (0.000s)
[309.710890] [070/131] (711s left) kms_vrr (max-min)
[309.793098] Starting subtest: max-min
[309.799136] Subtest max-min: SKIP (0.000s)
[309.889693] [071/131] (711s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[310.004824] Starting subtest: flip-vs-cursor-atomic
[317.122614] Subtest flip-vs-cursor-atomic: SUCCESS (7.113s)
[318.004507] [072/131] (703s left) gem_exec_reloc (basic-gtt)
[318.070315] Subtest basic-gtt: SKIP (0.000s)
[318.155147] [073/131] (703s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[318.247778] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[318.249982] Starting dynamic subtest: pipe-A-eDP-1
[318.272043] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[318.283428] Starting dynamic subtest: pipe-B-eDP-1
[318.304671] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[318.313762] Starting dynamic subtest: pipe-C-eDP-1
[318.335086] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[318.344938] Starting dynamic subtest: pipe-D-eDP-1
[318.365998] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[318.369903] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[320.473337] [074/131] (700s left) gen9_exec_parse (bb-secure)
[320.543430] Subtest bb-secure: SKIP (0.000s)
[320.653542] [075/131] (700s left) kms_content_protection (type1)
[320.804691] Starting subtest: type1
[320.809215] Subtest type1: SKIP (0.000s)
[320.977098] [076/131] (700s left) vgem_basic (sysfs)
[321.026943] Starting subtest: sysfs
[321.028863] Subtest sysfs: SUCCESS (0.000s)
[321.117133] [077/131] (700s left) syncobj_eventfd (binary-wait)
[321.173834] Starting subtest: binary-wait
[321.182194] Subtest binary-wait: SUCCESS (0.010s)
[321.283670] [078/131] (700s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[321.658082] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[322.445502] [079/131] (699s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[322.569725] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[322.573891] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[322.698774] [080/131] (698s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[322.805598] Starting subtest: plane-ctm3x4-lut1d
[322.818202] Starting dynamic subtest: pipe-A-eDP-1
[323.510140] Dynamic subtest pipe-A-eDP-1: FAIL (0.317s)
[324.241297] Starting dynamic subtest: pipe-B-eDP-1
[325.059849] Dynamic subtest pipe-B-eDP-1: FAIL (0.302s)
[325.569740] Starting dynamic subtest: pipe-C-eDP-1
[326.390733] Dynamic subtest pipe-C-eDP-1: FAIL (0.234s)
[326.906689] Starting dynamic subtest: pipe-D-eDP-1
[327.790764] Dynamic subtest pipe-D-eDP-1: FAIL (0.302s)
[327.792901] Subtest plane-ctm3x4-lut1d: FAIL (4.685s)
[328.320470] [081/131] (693s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[328.413513] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[328.415691] Starting dynamic subtest: A-eDP1
[337.335174] Dynamic subtest A-eDP1: SUCCESS (8.919s)
[337.346191] Starting dynamic subtest: B-eDP1
[346.269086] Dynamic subtest B-eDP1: SUCCESS (8.933s)
[346.280560] Starting dynamic subtest: C-eDP1
[355.236868] Dynamic subtest C-eDP1: SUCCESS (8.919s)
[355.249105] Starting dynamic subtest: D-eDP1
[364.170232] Dynamic subtest D-eDP1: SUCCESS (8.932s)
[364.172671] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.712s)
[365.372678] [082/131] (656s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[365.476886] Starting subtest: psr-2p-primscrn-spr-indfb-move
[365.481331] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[365.622150] [083/131] (656s left) kms_cursor_edge_walk (256x256-top-bottom)
[365.718425] Starting subtest: 256x256-top-bottom
[365.720679] Starting dynamic subtest: pipe-A-eDP-1
[369.202372] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.484s)
[369.212203] Starting dynamic subtest: pipe-D-eDP-1
[372.345583] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.143s)
[372.347895] Subtest 256x256-top-bottom: SUCCESS (6.629s)
[373.176391] [084/131] (648s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[373.306714] Starting subtest: 2x-long-cursor-vs-flip-legacy
[373.311321] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.001s)
[373.500438] [085/131] (648s left) kms_flip (flip-vs-modeset-vs-hang)
[373.599841] Starting subtest: flip-vs-modeset-vs-hang
[373.602178] Starting dynamic subtest: A-eDP1
[424.815810] Dynamic subtest A-eDP1: SUCCESS (51.229s)
[424.825047] Starting dynamic subtest: D-eDP1
[474.879179] Dynamic subtest D-eDP1: SUCCESS (50.042s)
[474.881852] Subtest flip-vs-modeset-vs-hang: SUCCESS (101.278s)
[475.273711] [086/131] (546s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[475.678389] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[476.470480] [087/131] (545s left) gem_pxp (reject-modify-context-protection-off-3)
[476.605134] Starting subtest: reject-modify-context-protection-off-3
[476.607638] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[476.751798] [088/131] (545s left) kms_big_fb (linear-16bpp-rotate-0)
[476.863354] Starting subtest: linear-16bpp-rotate-0
[478.206570] Subtest linear-16bpp-rotate-0: SUCCESS (1.344s)
[478.380031] [089/131] (543s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[478.486105] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[487.241146] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.754s)
[487.384931] [090/131] (534s left) gem_exec_reloc (basic-active)
[487.458071] Subtest basic-active: SKIP (0.000s)
[487.558397] [091/131] (534s left) syncobj_timeline (reset-unsignaled)
[487.615741] Starting subtest: reset-unsignaled
[487.618141] Subtest reset-unsignaled: SUCCESS (0.000s)
[487.736838] [092/131] (534s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[487.833375] Starting subtest: fbcpsr-shrfb-scaledprimary
[493.614381] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.782s)
[493.785559] [093/131] (528s left) syncobj_timeline (invalid-wait-bad-flags)
[493.851552] Starting subtest: invalid-wait-bad-flags
[493.853498] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[493.983111] [094/131] (528s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[494.078142] Starting subtest: fbc-rgb101010-draw-render
[498.654620] Subtest fbc-rgb101010-draw-render: SUCCESS (4.572s)
[499.857427] [095/131] (522s left) kms_hdr (bpc-switch)
[499.948307] Starting subtest: bpc-switch
[500.998337] Starting dynamic subtest: pipe-A-eDP-1
[504.406534] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.410s)
[504.408829] Subtest bpc-switch: SUCCESS (4.461s)
[504.566593] [096/131] (517s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[504.680864] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[509.208086] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.530s)
[510.382106] [097/131] (511s left) gem_exec_balancer (parallel-keep-submit-fence)
[510.647078] Starting subtest: parallel-keep-submit-fence
[511.854498] Subtest parallel-keep-submit-fence: SUCCESS (1.207s)
[511.991385] [098/131] (510s left) i915_pm_rc6_residency (rc6-idle)
[512.044154] Starting subtest: rc6-idle
[512.066809] Starting dynamic subtest: gt0-rcs0
[536.400763] Dynamic subtest gt0-rcs0: SUCCESS (24.335s)
[536.411680] Starting dynamic subtest: gt0-bcs0
[560.610160] Dynamic subtest gt0-bcs0: SUCCESS (24.210s)
[560.619334] Starting dynamic subtest: gt0-ccs0
[584.902183] Dynamic subtest gt0-ccs0: SUCCESS (24.292s)
[584.911278] Starting dynamic subtest: gt1-vcs0
[591.126496] Dynamic subtest gt1-vcs0: SUCCESS (6.171s)
[591.138013] Starting dynamic subtest: gt1-vecs0
[597.299195] Dynamic subtest gt1-vecs0: SUCCESS (6.170s)
[597.301781] Subtest rc6-idle: SUCCESS (85.215s)
[597.353300] [099/131] (424s left) prime_mmap (test_map_unmap)
[597.417837] Starting subtest: test_map_unmap
[597.420167] Starting dynamic subtest: test_map_unmap-smem
[597.446761] Dynamic subtest test_map_unmap-smem: SUCCESS (0.031s)
[597.449159] Subtest test_map_unmap: SUCCESS (0.032s)
[597.574693] [100/131] (424s left) kms_addfb_basic (invalid-set-prop-any)
[597.626211] Starting subtest: invalid-set-prop-any
[597.628396] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[597.782499] [101/131] (424s left) kms_setmode (basic)
[597.842868] Starting subtest: basic
[598.177015] Starting dynamic subtest: pipe-A-eDP-1
[600.251225] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.070s)
[600.595551] Starting dynamic subtest: pipe-B-eDP-1
[602.692135] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.101s)
[602.996071] Subtest basic: SUCCESS (5.154s)
[603.876266] [102/131] (418s left) kms_properties (colorop-properties-atomic)
[603.974500] Starting subtest: colorop-properties-atomic
[603.976737] Starting dynamic subtest: pipe-A-eDP-1
[604.312636] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.338s)
[604.325814] Starting dynamic subtest: pipe-B-eDP-1
[605.398370] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.082s)
[605.408988] Starting dynamic subtest: pipe-C-eDP-1
[606.438895] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.042s)
[606.449177] Starting dynamic subtest: pipe-D-eDP-1
[607.464364] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.022s)
[607.466749] Subtest colorop-properties-atomic: SUCCESS (3.490s)
[608.287838] [103/131] (414s left) gem_mmap_wc (read-write)
[608.347521] Subtest read-write: SKIP (0.000s)
[608.426058] [104/131] (414s left) gem_eio (kms)
[608.717226] Starting subtest: kms
[630.491206] Subtest kms: SUCCESS (21.777s)
[631.686694] [105/131] (390s left) drm_read (short-buffer-block)
[631.838245] Starting subtest: short-buffer-block
[631.840632] Subtest short-buffer-block: SUCCESS (0.000s)
[632.010816] [106/131] (390s left) gem_workarounds (reset-fd)
[632.085762] Starting subtest: reset-fd
[632.278978] Subtest reset-fd: SUCCESS (0.194s)
[632.451614] [107/131] (390s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[632.553304] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[632.558020] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[632.671897] [108/131] (390s left) kms_psr (fbc-psr-sprite-blt)
[632.777735] Starting subtest: fbc-psr-sprite-blt
[632.779600] Starting dynamic subtest: eDP-1
[632.782972] Dynamic subtest eDP-1: SKIP (0.000s)
[632.786323] Subtest fbc-psr-sprite-blt: SKIP (0.001s)
[632.877463] [109/131] (389s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[632.986289] Starting subtest: 4-tiled-16bpp-rotate-0
[634.255540] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.268s)
[634.419371] [110/131] (388s left) syncobj_timeline (invalid-signal-illegal-point)
[634.487391] Starting subtest: invalid-signal-illegal-point
[634.489471] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[634.621387] [111/131] (388s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[634.719682] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[634.721557] Starting dynamic subtest: pipe-A-eDP-1
[634.742342] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[634.753130] Starting dynamic subtest: pipe-B-eDP-1
[634.772575] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[634.781294] Starting dynamic subtest: pipe-C-eDP-1
[634.800866] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[634.810161] Starting dynamic subtest: pipe-D-eDP-1
[634.830057] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[634.833719] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[637.054529] [112/131] (385s left) kms_dsc (dsc-with-output-formats)
[637.158607] Starting subtest: dsc-with-output-formats
[637.181639] Subtest dsc-with-output-formats: SKIP (0.001s)
[637.259985] [113/131] (385s left) kms_properties (get_properties-sanity-atomic)
[637.355552] Starting subtest: get_properties-sanity-atomic
[637.357858] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[637.455631] [114/131] (385s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[637.558203] Starting subtest: 4-tiled-32bpp-rotate-90
[637.576978] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.019s)
[637.725512] [115/131] (385s left) core_setmaster (master-drop-set-root)
[637.817714] Starting subtest: master-drop-set-root
[637.830351] Subtest master-drop-set-root: SUCCESS (0.013s)
[637.877622] [116/131] (385s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[637.982469] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[637.985604] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[638.099705] [117/131] (385s left) gem_sync (basic-all)
[638.177037] Starting subtest: basic-all
[641.369947] Subtest basic-all: SUCCESS (3.199s)
[641.581843] [118/131] (381s left) gem_ctx_persistence (heartbeat-close)
[641.639582] Starting subtest: heartbeat-close
[641.644231] Subtest heartbeat-close: SKIP (0.000s)
[641.787663] [119/131] (381s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[646.822296] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[646.826791] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.002s)
[647.688971] [120/131] (375s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[647.788083] Starting subtest: primary-x-tiled-reflect-x-0
[654.963093] Subtest primary-x-tiled-reflect-x-0: SUCCESS (7.177s)
[656.174558] [121/131] (367s left) gem_eio (in-flight-external)
[656.415930] Starting subtest: in-flight-external
[657.442737] Subtest in-flight-external: SUCCESS (1.026s)
[657.622092] [122/131] (365s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[657.724340] Starting subtest: compare-crc-sanitycheck-xr24
[657.726682] Starting dynamic subtest: pipe-A-eDP-1
[658.348319] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.624s)
[658.360694] Starting dynamic subtest: pipe-B-eDP-1
[659.606928] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.258s)
[659.617488] Starting dynamic subtest: pipe-C-eDP-1
[660.816948] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.207s)
[660.827076] Starting dynamic subtest: pipe-D-eDP-1
[662.029333] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.212s)
[662.032059] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.308s)
[662.913524] [123/131] (360s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[662.980320] Subtest writes-after-reads-uncached: SKIP (0.000s)
[663.066353] [124/131] (360s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[663.160830] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[663.165205] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[663.274693] [125/131] (360s left) gem_mmap_gtt (big-bo-tiledy)
[663.338959] Subtest big-bo-tiledY: SKIP (0.000s)
[663.406137] [126/131] (360s left) i915_query (engine-info)
[663.453267] Starting subtest: engine-info
[663.455166] Subtest engine-info: SUCCESS (0.005s)
[663.605677] [127/131] (359s left) gem_ctx_persistence (engines-mixed-process)
[663.673157] Starting subtest: engines-mixed-process
[663.675917] Starting dynamic subtest: rcs0
[665.385953] Dynamic subtest rcs0: SUCCESS (1.713s)
[665.397750] Starting dynamic subtest: bcs0
[667.427346] Dynamic subtest bcs0: SUCCESS (2.037s)
[667.437116] Starting dynamic subtest: vcs0
[669.359306] Dynamic subtest vcs0: SUCCESS (1.933s)
[669.371413] Starting dynamic subtest: vcs1
[671.416134] Dynamic subtest vcs1: SUCCESS (2.055s)
[671.428632] Starting dynamic subtest: vecs0
[673.400261] Dynamic subtest vecs0: SUCCESS (1.982s)
[673.412092] Starting dynamic subtest: ccs0
[675.354079] Dynamic subtest ccs0: SUCCESS (1.952s)
[675.356436] Subtest engines-mixed-process: SUCCESS (11.684s)
[675.458948] [128/131] (348s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[675.524358] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[675.630807] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[675.732960] [129/131] (347s left) sysfs_heartbeat_interval (precise)
[675.804742] Starting subtest: precise
[675.807001] Starting dynamic subtest: vecs0
[683.434135] Dynamic subtest vecs0: SUCCESS (7.627s)
[683.446950] Starting dynamic subtest: ccs0
[684.666041] Dynamic subtest ccs0: SUCCESS (1.232s)
[684.677682] Starting dynamic subtest: vcs0
[692.380350] Dynamic subtest vcs0: SUCCESS (7.715s)
[692.392631] Starting dynamic subtest: bcs0
[693.567576] Dynamic subtest bcs0: SUCCESS (1.184s)
[693.581945] Starting dynamic subtest: rcs0
[694.799934] Dynamic subtest rcs0: SUCCESS (1.229s)
[694.811842] Starting dynamic subtest: vcs1
[702.358448] Dynamic subtest vcs1: SUCCESS (7.552s)
[702.360932] Subtest precise: SUCCESS (26.551s)
[702.462030] [130/131] (321s left) kms_psr (fbc-pr-cursor-render)
[702.563477] Starting subtest: fbc-pr-cursor-render
[702.568000] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[702.665966] [131/131] (321s left) kms_psr (psr2-sprite-render)
[702.755672] Starting subtest: psr2-sprite-render
[702.757969] Starting dynamic subtest: eDP-1
[704.480960] Dynamic subtest eDP-1: SUCCESS (1.723s)
[704.483289] Subtest psr2-sprite-render: SUCCESS (1.724s)
[705.375072] 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.