[63.078034] Initializing watchdogs
[63.078138]   /dev/watchdog0
[63.092316] [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]
[63.096606] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[63.098851] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.102628] [001/133] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[63.233409] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[63.237988] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[63.340413] [002/133] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[63.432341] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[63.436859] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[63.539121] [003/133] (960s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[63.634802] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[64.676886] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.044s)
[64.821452] [004/133] (958s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[64.921924] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[71.422950] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.509s)
[71.528405] [005/133] (952s left) gem_exec_balancer (noheartbeat)
[71.806858] Starting subtest: noheartbeat
[71.811364] Subtest noheartbeat: SKIP (0.000s)
[71.901311] [006/133] (951s left) syncobj_wait (multi-wait-submitted-signaled)
[71.953118] Starting subtest: multi-wait-submitted-signaled
[71.955428] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[72.039174] [007/133] (951s left) gen7_exec_parse (batch-without-end)
[72.101322] Subtest batch-without-end: SKIP (0.000s)
[72.163359] [008/133] (951s left) gem_pread (exhaustion)
[72.223287] Subtest exhaustion: SKIP (0.000s)
[72.275039] [009/133] (951s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[72.367635] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[72.372228] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[72.474043] [010/133] (951s left) kms_cursor_crc (cursor-sliding-max-size)
[72.796787] Starting subtest: cursor-sliding-max-size
[72.803496] Subtest cursor-sliding-max-size: SKIP (0.000s)
[72.926507] [011/133] (951s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[73.021541] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[73.025238] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[73.130501] [012/133] (950s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[73.228365] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[73.230284] Starting dynamic subtest: pipe-A-eDP-1
[79.148719] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.923s)
[79.155749] Starting dynamic subtest: pipe-B-eDP-1
[85.794988] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.644s)
[85.797452] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.568s)
[86.663035] [013/133] (937s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[86.758896] Starting subtest: fbc-rgb565-draw-blt
[90.909609] Subtest fbc-rgb565-draw-blt: SUCCESS (4.155s)
[92.052470] [014/133] (932s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[92.150353] Starting subtest: plane-upscale-20x20-with-rotation
[92.152825] Starting dynamic subtest: pipe-A
[92.374329] Dynamic subtest pipe-A: SUCCESS (0.226s)
[92.383864] Starting dynamic subtest: pipe-B
[93.621940] Dynamic subtest pipe-B: SUCCESS (1.247s)
[93.629584] Starting dynamic subtest: pipe-C
[94.961276] Dynamic subtest pipe-C: SUCCESS (1.338s)
[94.968719] Starting dynamic subtest: pipe-D
[96.282545] Dynamic subtest pipe-D: SUCCESS (1.321s)
[96.284971] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.135s)
[97.463407] [015/133] (926s left) gem_exec_flush (basic-wb-ro-before-default)
[97.527681] Starting subtest: basic-wb-ro-before-default
[102.977664] Subtest basic-wb-ro-before-default: SUCCESS (5.452s)
[103.163543] [016/133] (921s left) gem_eio (in-flight-internal-immediate)
[103.399942] Starting subtest: in-flight-internal-immediate
[104.995798] Subtest in-flight-internal-immediate: SUCCESS (1.596s)
[105.145986] [017/133] (919s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping)
[105.236104] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping
[105.261486] Starting dynamic subtest: pipe-A-plane-0
[105.561453] Dynamic subtest pipe-A-plane-0: SUCCESS (0.300s)
[105.570971] Starting dynamic subtest: pipe-A-plane-3
[105.795068] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[106.864096] Starting dynamic subtest: pipe-B-plane-0
[107.166223] Dynamic subtest pipe-B-plane-0: SUCCESS (0.311s)
[107.175895] Starting dynamic subtest: pipe-B-plane-3
[107.399567] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s)
[107.711808] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.474s)
[108.543456] [018/133] (915s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[108.795381] Starting subtest: cursor-rapid-movement-256x256
[108.800440] Starting dynamic subtest: pipe-A-eDP-1
[109.355309] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.555s)
[109.380039] Starting dynamic subtest: pipe-D-eDP-1
[110.527095] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.152s)
[110.529361] Subtest cursor-rapid-movement-256x256: SUCCESS (1.731s)
[111.378320] [019/133] (912s left) kms_psr (psr2-sprite-plane-move)
[111.483103] Starting subtest: psr2-sprite-plane-move
[111.485341] Starting dynamic subtest: eDP-1
[113.211496] Dynamic subtest eDP-1: SUCCESS (1.727s)
[113.213786] Subtest psr2-sprite-plane-move: SUCCESS (1.728s)
[114.050086] [020/133] (910s left) kms_invalid_mode (bad-vsync-start)
[114.150799] Starting subtest: bad-vsync-start
[114.153329] Starting dynamic subtest: pipe-A-eDP-1
[114.436201] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[114.445037] Starting dynamic subtest: pipe-B-eDP-1
[114.447057] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[114.454209] Starting dynamic subtest: pipe-C-eDP-1
[114.456081] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[114.466136] Starting dynamic subtest: pipe-D-eDP-1
[114.468250] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[114.470450] Subtest bad-vsync-start: SUCCESS (0.292s)
[115.267735] [021/133] (909s left) kms_cursor_crc (cursor-size-change)
[115.374296] Starting subtest: cursor-size-change
[115.376215] Starting dynamic subtest: pipe-A-eDP-1
[116.184757] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.811s)
[116.192850] Starting dynamic subtest: pipe-D-eDP-1
[117.670189] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.484s)
[117.672372] Subtest cursor-size-change: SUCCESS (2.296s)
[118.534604] [022/133] (905s left) kms_addfb_basic (legacy-format)
[118.597386] Starting subtest: legacy-format
[118.632562] Subtest legacy-format: SUCCESS (0.033s)
[118.768570] [023/133] (905s left) gem_exec_schedule (promotion)
[118.848674] Starting subtest: promotion
[118.850988] Starting dynamic subtest: rcs0
[118.982878] Dynamic subtest rcs0: SUCCESS (0.138s)
[118.996816] Starting dynamic subtest: vcs0
[119.080469] Dynamic subtest vcs0: SUCCESS (0.096s)
[119.093519] Starting dynamic subtest: vcs1
[119.209428] Dynamic subtest vcs1: SUCCESS (0.128s)
[119.224333] Starting dynamic subtest: vecs0
[119.301707] Dynamic subtest vecs0: SUCCESS (0.092s)
[119.315513] Starting dynamic subtest: ccs0
[119.421923] Dynamic subtest ccs0: SUCCESS (0.119s)
[119.424786] Subtest promotion: SUCCESS (0.580s)
[119.991702] [024/133] (904s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[120.104705] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[120.109129] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[120.194455] [025/133] (904s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[120.557829] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[121.338790] [026/133] (903s left) gem_exec_schedule (fairslice-all)
[121.416424] Starting subtest: fairslice-all
[123.465810] Subtest fairslice-all: SUCCESS (2.058s)
[124.954482] [027/133] (899s left) kms_lease (implicit-plane-lease)
[125.047234] Starting subtest: implicit-plane-lease
[125.049643] Subtest implicit-plane-lease: SUCCESS (0.003s)
[125.156484] [028/133] (899s left) kms_cursor_crc (cursor-alpha-opaque)
[125.246160] Starting subtest: cursor-alpha-opaque
[125.248359] Starting dynamic subtest: pipe-A-eDP-1
[125.880190] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.635s)
[125.889306] Starting dynamic subtest: pipe-D-eDP-1
[127.138465] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.258s)
[127.140842] Subtest cursor-alpha-opaque: SUCCESS (1.895s)
[128.036991] [029/133] (896s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[128.136976] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[128.139176] Starting dynamic subtest: pipe-A-eDP-1
[128.161448] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[128.171569] Starting dynamic subtest: pipe-B-eDP-1
[128.192406] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[128.199797] Starting dynamic subtest: pipe-C-eDP-1
[128.222106] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[128.233713] Starting dynamic subtest: pipe-D-eDP-1
[128.255862] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[128.260248] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.004s)
[130.291743] [030/133] (894s left) syncobj_timeline (reset-signaled)
[130.350016] Starting subtest: reset-signaled
[130.352387] Subtest reset-signaled: SUCCESS (0.000s)
[130.447683] [031/133] (894s left) gem_exec_reloc (basic-cpu-active)
[130.519633] Subtest basic-cpu-active: SKIP (0.000s)
[130.576834] [032/133] (894s left) gem_exec_parallel (fds)
[130.637372] Starting subtest: fds
[130.639788] Starting dynamic subtest: rcs0
[133.808100] Dynamic subtest rcs0: SUCCESS (3.169s)
[133.817857] Starting dynamic subtest: bcs0
[137.427296] Dynamic subtest bcs0: SUCCESS (3.618s)
[137.439062] Starting dynamic subtest: vcs0
[141.233048] Dynamic subtest vcs0: SUCCESS (3.803s)
[141.244490] Starting dynamic subtest: vcs1
[145.299306] Dynamic subtest vcs1: SUCCESS (4.062s)
[145.308061] Starting dynamic subtest: vecs0
[149.198731] Dynamic subtest vecs0: SUCCESS (3.896s)
[149.213137] Starting dynamic subtest: ccs0
[153.770420] Dynamic subtest ccs0: SUCCESS (4.568s)
[153.773233] Subtest fds: SUCCESS (23.130s)
[153.980240] [033/133] (870s left) kms_vblank (wait-busy)
[154.079965] Starting subtest: wait-busy
[154.082307] Starting dynamic subtest: pipe-A-eDP-1
[155.954321] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s)
[155.968663] Starting dynamic subtest: pipe-D-eDP-1
[158.542962] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.585s)
[158.545385] Subtest wait-busy: SUCCESS (4.463s)
[159.337420] [034/133] (865s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[159.429227] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[159.433244] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[159.502487] [035/133] (865s left) kms_sequence (queue-busy)
[159.593143] Starting subtest: queue-busy
[159.594982] Starting dynamic subtest: pipe-A-eDP-1
[161.532744] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.940s)
[161.540691] Starting dynamic subtest: pipe-B-eDP-1
[164.143378] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.608s)
[164.152894] Starting dynamic subtest: pipe-C-eDP-1
[166.750806] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.605s)
[166.760073] Starting dynamic subtest: pipe-D-eDP-1
[169.310644] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.559s)
[169.313067] Subtest queue-busy: SUCCESS (9.717s)
[170.116347] [036/133] (854s left) gem_exec_whisper (basic-fds-forked-all)
[170.183949] Starting subtest: basic-fds-forked-all
[192.965335] Subtest basic-fds-forked-all: SUCCESS (22.778s)
[193.141219] [037/133] (831s left) kms_cursor_legacy (torture-bo)
[193.269170] Starting subtest: torture-bo
[193.273439] Starting dynamic subtest: pipe-A
[199.097376] Dynamic subtest pipe-A: SUCCESS (5.827s)
[199.109795] Starting dynamic subtest: pipe-B
[206.053731] Dynamic subtest pipe-B: SUCCESS (6.956s)
[206.066417] Starting dynamic subtest: pipe-C
[212.431503] Dynamic subtest pipe-C: SUCCESS (6.377s)
[212.440486] Starting dynamic subtest: pipe-D
[219.972482] Dynamic subtest pipe-D: SUCCESS (7.539s)
[219.981663] Starting dynamic subtest: all-pipes
[228.200506] Dynamic subtest all-pipes: SUCCESS (8.224s)
[228.203118] Subtest torture-bo: SUCCESS (34.931s)
[228.353946] [038/133] (796s left) perf_pmu (most-busy-idle-check-all)
[228.389765] Starting subtest: most-busy-idle-check-all
[228.391911] Starting dynamic subtest: rcs0
[229.912700] Dynamic subtest rcs0: SUCCESS (1.522s)
[229.924891] Starting dynamic subtest: bcs0
[231.896741] Dynamic subtest bcs0: SUCCESS (1.982s)
[231.908071] Starting dynamic subtest: vcs0
[233.879848] Dynamic subtest vcs0: SUCCESS (1.980s)
[233.899597] Starting dynamic subtest: vcs1
[235.863251] Dynamic subtest vcs1: SUCCESS (1.980s)
[235.882272] Starting dynamic subtest: vecs0
[237.847849] Dynamic subtest vecs0: SUCCESS (1.981s)
[237.866855] Starting dynamic subtest: ccs0
[239.832375] Dynamic subtest ccs0: SUCCESS (1.982s)
[239.835255] Subtest most-busy-idle-check-all: SUCCESS (11.445s)
[239.933492] [039/133] (785s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[240.036033] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[246.705724] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.671s)
[246.840099] [040/133] (778s left) gem_exec_fence (basic-wait)
[247.017489] Starting subtest: basic-wait
[247.019710] Starting dynamic subtest: rcs0
[247.099250] Dynamic subtest rcs0: SUCCESS (0.084s)
[247.109836] Starting dynamic subtest: bcs0
[247.157631] Dynamic subtest bcs0: SUCCESS (0.057s)
[247.167785] Starting dynamic subtest: vcs0
[247.214292] Dynamic subtest vcs0: SUCCESS (0.055s)
[247.224924] Starting dynamic subtest: vcs1
[247.266811] Dynamic subtest vcs1: SUCCESS (0.050s)
[247.277496] Starting dynamic subtest: vecs0
[247.321045] Dynamic subtest vecs0: SUCCESS (0.052s)
[247.331867] Starting dynamic subtest: ccs0
[247.386085] Dynamic subtest ccs0: SUCCESS (0.063s)
[247.389139] Subtest basic-wait: SUCCESS (0.372s)
[249.018774] [FACT gem_exec_fence (basic-wait)] new: kernel.kmod_is_loaded.vgem: true
[249.022284] [041/133] (776s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[249.120280] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[249.122592] Starting dynamic subtest: pipe-A-eDP-1
[249.179186] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[249.188057] Starting dynamic subtest: pipe-B-eDP-1
[249.251368] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[249.261981] Starting dynamic subtest: pipe-C-eDP-1
[249.317940] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[249.327140] Starting dynamic subtest: pipe-D-eDP-1
[249.384507] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[249.388890] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.009s)
[251.404461] [042/133] (773s left) gem_lmem_swapping (verify-ccs)
[251.446810] Subtest verify-ccs: SKIP (0.000s)
[251.485684] [043/133] (773s left) sw_sync (timeline_closed_signaled)
[251.515405] Starting subtest: timeline_closed_signaled
[251.517792] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[251.568295] [044/133] (773s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[251.669817] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[251.674313] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[251.779307] [045/133] (773s left) kms_prop_blob (invalid-set-prop-any)
[251.840317] Starting subtest: invalid-set-prop-any
[251.842465] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[251.951289] [046/133] (773s left) kms_flip (2x-flip-vs-expired-vblank)
[252.055678] Starting subtest: 2x-flip-vs-expired-vblank
[252.064472] Subtest 2x-flip-vs-expired-vblank: SKIP (0.010s)
[252.147427] [047/133] (773s left) gem_lmem_swapping (parallel-random-engines)
[252.190121] Subtest parallel-random-engines: SKIP (0.000s)
[252.230376] [048/133] (773s left) kms_flip (plain-flip-fb-recreate-interruptible)
[252.321706] Starting subtest: plain-flip-fb-recreate-interruptible
[252.323673] Starting dynamic subtest: A-eDP1
[261.180051] Dynamic subtest A-eDP1: SUCCESS (8.857s)
[261.189741] Starting dynamic subtest: B-eDP1
[270.015664] Dynamic subtest B-eDP1: SUCCESS (8.834s)
[270.025974] Starting dynamic subtest: C-eDP1
[278.826681] Dynamic subtest C-eDP1: SUCCESS (8.809s)
[278.838433] Starting dynamic subtest: D-eDP1
[287.665069] Dynamic subtest D-eDP1: SUCCESS (8.835s)
[287.669757] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.348s)
[288.853545] [049/133] (736s left) api_intel_bb (object-reloc-keep-cache)
[288.916000] Starting subtest: object-reloc-keep-cache
[288.920644] Subtest object-reloc-keep-cache: SKIP (0.003s)
[289.043257] [050/133] (736s left) kms_pm_dc (dc5-dpms)
[290.145198] Starting subtest: dc5-dpms
[292.236387] Subtest dc5-dpms: SUCCESS (2.091s)
[292.314232] [051/133] (733s left) kms_plane_cursor (overlay)
[292.401444] Starting subtest: overlay
[292.405998] Starting dynamic subtest: pipe-A-eDP-1-size-64
[294.851250] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.451s)
[294.910294] Starting dynamic subtest: pipe-A-eDP-1-size-128
[297.374224] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.471s)
[297.435960] Starting dynamic subtest: pipe-A-eDP-1-size-256
[299.887361] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.459s)
[300.252740] Starting dynamic subtest: pipe-B-eDP-1-size-64
[303.357181] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.115s)
[303.416437] Starting dynamic subtest: pipe-B-eDP-1-size-128
[305.891871] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.482s)
[305.952091] Starting dynamic subtest: pipe-B-eDP-1-size-256
[308.337992] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.393s)
[308.690294] Starting dynamic subtest: pipe-C-eDP-1-size-64
[311.447515] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.768s)
[311.483078] Starting dynamic subtest: pipe-C-eDP-1-size-128
[313.557945] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.080s)
[313.595486] Starting dynamic subtest: pipe-C-eDP-1-size-256
[315.635352] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.047s)
[315.968383] Starting dynamic subtest: pipe-D-eDP-1-size-64
[318.720718] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.763s)
[318.758157] Starting dynamic subtest: pipe-D-eDP-1-size-128
[320.775831] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.025s)
[320.813166] Starting dynamic subtest: pipe-D-eDP-1-size-256
[322.864107] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.058s)
[323.190711] Subtest overlay: SUCCESS (30.783s)
[324.041766] [052/133] (701s left) gem_exec_reloc (basic-wc-active)
[324.105741] Subtest basic-wc-active: SKIP (0.000s)
[324.188496] [053/133] (701s left) kms_psr (pr-primary-mmap-gtt)
[324.272109] Starting subtest: pr-primary-mmap-gtt
[324.276589] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[324.350134] [054/133] (701s left) gem_exec_schedule (lateslice)
[324.422962] Starting subtest: lateslice
[324.425061] Starting dynamic subtest: rcs0
[324.431973] Dynamic subtest rcs0: SUCCESS (0.020s)
[324.440871] Starting dynamic subtest: bcs0
[324.449070] Dynamic subtest bcs0: SUCCESS (0.017s)
[324.457740] Starting dynamic subtest: vcs0
[324.468864] Dynamic subtest vcs0: SUCCESS (0.019s)
[324.477598] Starting dynamic subtest: vcs1
[324.488404] Dynamic subtest vcs1: SUCCESS (0.019s)
[324.496798] Starting dynamic subtest: vecs0
[324.507681] Dynamic subtest vecs0: SUCCESS (0.018s)
[324.516073] Starting dynamic subtest: ccs0
[324.525954] Dynamic subtest ccs0: SUCCESS (0.018s)
[324.528249] Subtest lateslice: SUCCESS (0.115s)
[325.986843] [055/133] (699s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[326.083504] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[333.574890] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (7.495s)
[333.722587] [056/133] (692s left) kms_color (ctm-max)
[333.813835] Starting subtest: ctm-max
[333.815684] Starting dynamic subtest: pipe-A-eDP-1
[334.510765] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.698s)
[334.520646] Starting dynamic subtest: pipe-B-eDP-1
[335.965949] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.455s)
[335.975066] Starting dynamic subtest: pipe-C-eDP-1
[337.333452] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.364s)
[337.345570] Starting dynamic subtest: pipe-D-eDP-1
[338.664507] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.331s)
[338.666680] Subtest ctm-max: SUCCESS (4.851s)
[339.466309] [057/133] (686s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[339.522234] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[339.524496] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[339.643486] [058/133] (686s left) gem_eio (reset-stress)
[339.879802] Starting subtest: reset-stress
[339.882270] Starting dynamic subtest: render
[344.965099] Dynamic subtest render: SUCCESS (5.083s)
[344.984838] Starting dynamic subtest: bsd1
[363.410940] Dynamic subtest bsd1: SUCCESS (18.444s)
[363.426936] Starting dynamic subtest: bsd2
[381.373044] Dynamic subtest bsd2: SUCCESS (17.962s)
[381.389744] Starting dynamic subtest: blt
[381.393948] Dynamic subtest blt: SKIP (0.000s)
[381.402554] Starting dynamic subtest: vebox
[399.448818] Dynamic subtest vebox: SUCCESS (18.073s)
[399.451745] Subtest reset-stress: SUCCESS (59.566s)
[400.956487] [059/133] (624s left) kms_addfb_basic (bad-pitch-256)
[401.014426] Starting subtest: bad-pitch-256
[401.016775] Subtest bad-pitch-256: SUCCESS (0.000s)
[401.143487] [060/133] (624s left) kms_addfb_basic (bo-too-small)
[401.234530] Starting subtest: bo-too-small
[401.236755] Subtest bo-too-small: SUCCESS (0.000s)
[401.327497] [061/133] (624s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[401.429585] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[401.433973] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[401.527215] [062/133] (624s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[401.622284] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[401.626289] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[401.698654] [063/133] (624s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[401.799075] Starting subtest: disable-crc-after-crtc
[401.800936] Starting dynamic subtest: pipe-A-eDP-1
[403.428833] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.629s)
[403.437771] Starting dynamic subtest: pipe-B-eDP-1
[405.677697] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.249s)
[405.687579] Starting dynamic subtest: pipe-C-eDP-1
[407.972062] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.291s)
[407.981811] Starting dynamic subtest: pipe-D-eDP-1
[410.228127] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.256s)
[410.230603] Subtest disable-crc-after-crtc: SUCCESS (8.431s)
[411.058445] [064/133] (615s left) kms_chamelium_frames (hdmi-crc-multiple)
[411.442829] Subtest hdmi-crc-multiple: SKIP (0.000s)
[412.261036] [065/133] (613s left) perf (oa-formats)
[412.377025] Starting subtest: oa-formats
[412.379355] Starting dynamic subtest: 0-rcs0
[412.389986] Dynamic subtest 0-rcs0: SUCCESS (0.014s)
[412.399566] Starting dynamic subtest: 1-vecs0
[412.411927] Dynamic subtest 1-vecs0: SUCCESS (0.021s)
[412.414135] Subtest oa-formats: SUCCESS (0.037s)
[412.462313] [066/133] (613s left) kms_dsc (dsc-fractional-bpp-with-bpc)
[412.549242] Starting subtest: dsc-fractional-bpp-with-bpc
[412.578712] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.001s)
[412.619607] [067/133] (613s left) syncobj_eventfd (timeline-wait)
[412.680680] Starting subtest: timeline-wait
[412.689210] Subtest timeline-wait: SUCCESS (0.011s)
[412.807675] [068/133] (613s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[412.904384] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[412.906691] Starting dynamic subtest: pipe-A-eDP-1
[429.583149] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.240s)
[429.592487] Starting dynamic subtest: pipe-B-eDP-1
[446.593007] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.386s)
[446.605246] Starting dynamic subtest: pipe-C-eDP-1
[463.558823] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.437s)
[463.574601] Starting dynamic subtest: pipe-D-eDP-1
[480.549425] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.350s)
[480.551807] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (9.418s)
[481.699242] [069/133] (544s left) gem_mmap_offset (isolation)
[481.757366] Starting subtest: isolation
[481.775049] Subtest isolation: SUCCESS (0.008s)
[481.862062] [070/133] (544s left) kms_chamelium_color (ctm-negative)
[481.960434] Subtest ctm-negative: SKIP (0.000s)
[482.004565] [071/133] (544s left) kms_hdmi_inject (inject-audio)
[482.348482] Starting subtest: inject-audio
[482.623728] Subtest inject-audio: SUCCESS (0.277s)
[483.265010] [072/133] (543s left) i915_drm_fdinfo (virtual-idle)
[483.310355] Starting subtest: virtual-idle
[486.373895] Subtest virtual-idle: SUCCESS (3.078s)
[486.455842] [073/133] (540s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[486.547752] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[486.552291] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[486.641652] [074/133] (539s left) gem_set_tiling_vs_gtt
[486.744787] [075/133] (539s left) api_intel_allocator (reopen-fork)
[486.793343] Starting subtest: reopen-fork
[490.036612] Subtest reopen-fork: SUCCESS (3.254s)
[490.111852] [076/133] (536s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[490.207781] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[490.209913] Starting dynamic subtest: pipe-A-default-mode
[492.887243] Dynamic subtest pipe-A-default-mode: SUCCESS (2.687s)
[492.889647] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.688s)
[493.687666] [077/133] (532s left) gem_eio (wait-1us)
[493.911685] Starting subtest: wait-1us
[494.262204] Subtest wait-1us: SUCCESS (0.352s)
[494.382652] [078/133] (532s left) gem_exec_create (forked)
[494.443054] Starting subtest: forked
[494.445370] Starting dynamic subtest: smem
[516.215060] Dynamic subtest smem: SUCCESS (21.785s)
[516.218010] Subtest forked: SUCCESS (21.787s)
[516.400435] [079/133] (510s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[516.458295] Starting subtest: etime-single-wait-all-for-submit-submitted
[516.562526] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.104s)
[516.644739] [080/133] (510s left) gem_exec_params (rel-constants-invalid-ring)
[516.695466] Starting subtest: rel-constants-invalid-ring
[516.697899] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[516.820511] [081/133] (509s left) kms_flip (plain-flip-interruptible)
[516.930018] Starting subtest: plain-flip-interruptible
[516.931843] Starting dynamic subtest: A-eDP1
[518.659631] Dynamic subtest A-eDP1: SUCCESS (1.728s)
[518.672429] Starting dynamic subtest: B-eDP1
[520.328681] Dynamic subtest B-eDP1: SUCCESS (1.666s)
[520.344328] Starting dynamic subtest: C-eDP1
[521.931118] Dynamic subtest C-eDP1: SUCCESS (1.600s)
[521.942792] Starting dynamic subtest: D-eDP1
[523.539843] Dynamic subtest D-eDP1: SUCCESS (1.607s)
[523.545867] Subtest plain-flip-interruptible: SUCCESS (6.615s)
[524.757622] [082/133] (502s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[524.873407] Starting subtest: short-flip-before-cursor-atomic-transitions
[525.819544] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.946s)
[526.671642] [083/133] (500s left) gem_userptr_blits (forbidden-operations)
[526.733833] Starting subtest: forbidden-operations
[526.738003] Subtest forbidden-operations: SKIP (0.000s)
[526.846675] [084/133] (500s left) gem_ctx_engines (invalid-engines)
[526.910992] Starting subtest: invalid-engines
[526.919402] Subtest invalid-engines: SUCCESS (0.009s)
[527.142756] [085/133] (499s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[527.239783] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[527.244166] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[527.337781] [086/133] (499s left) kms_pm_rpm (i2c)
[529.272189] Starting subtest: i2c
[534.333276] Subtest i2c: SUCCESS (5.064s)
[534.425851] [087/133] (492s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[534.525990] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[541.253174] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.733s)
[541.367529] [088/133] (485s left) kms_atomic (plane-overlay-legacy)
[541.469192] Starting subtest: plane-overlay-legacy
[541.471457] Starting dynamic subtest: pipe-A-eDP-1
[541.880570] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.412s)
[541.882833] Subtest plane-overlay-legacy: SUCCESS (0.414s)
[542.708426] [089/133] (484s left) syncobj_timeline (wait-all-for-submit-complex)
[542.754883] Starting subtest: wait-all-for-submit-complex
[542.967553] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[543.046968] [090/133] (484s left) gem_request_retire (retire-vma-not-inactive)
[543.106694] Starting subtest: retire-vma-not-inactive
[543.170080] Subtest retire-vma-not-inactive: SUCCESS (0.060s)
[543.287688] [091/133] (483s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[543.340990] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[543.345489] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[543.525049] [092/133] (483s left) gem_pxp (reject-modify-context-protection-on)
[543.646454] Starting subtest: reject-modify-context-protection-on
[543.649126] Subtest reject-modify-context-protection-on: SUCCESS (0.002s)
[543.750291] [093/133] (483s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[543.849133] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[543.851503] Starting dynamic subtest: pipe-A-eDP-1
[543.874313] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[543.895933] Starting dynamic subtest: pipe-B-eDP-1
[543.918619] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[543.941137] Starting dynamic subtest: pipe-C-eDP-1
[543.964627] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[543.988257] Starting dynamic subtest: pipe-D-eDP-1
[544.015336] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[544.019956] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[546.102738] [094/133] (481s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[546.194301] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[546.198578] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[546.266149] [095/133] (481s left) gem_exec_fence (syncobj-export)
[546.748601] Starting subtest: syncobj-export
[546.754591] Subtest syncobj-export: SUCCESS (0.005s)
[548.296030] [096/133] (479s left) dumb_buffer (map-invalid-size)
[548.370917] Starting subtest: map-invalid-size
[548.373347] Subtest map-invalid-size: SUCCESS (0.000s)
[548.464711] [097/133] (479s left) kms_psr (fbc-psr-primary-render)
[548.567407] Starting subtest: fbc-psr-primary-render
[548.569658] Starting dynamic subtest: eDP-1
[548.574013] Dynamic subtest eDP-1: SKIP (0.000s)
[548.578356] Subtest fbc-psr-primary-render: SKIP (0.001s)
[548.640101] [098/133] (478s left) fbdev (eof)
[548.680193] Starting subtest: eof
[548.682479] Subtest eof: SUCCESS (0.000s)
[548.747585] [099/133] (478s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[548.837003] Starting subtest: fbc-rgb101010-draw-pwrite
[554.169582] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.337s)
[555.298203] [100/133] (472s left) kms_vrr (negative-basic)
[555.398729] Starting subtest: negative-basic
[555.405536] Starting dynamic subtest: pipe-A-eDP-1
[560.832607] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.430s)
[561.109543] Subtest negative-basic: SUCCESS (5.715s)
[561.913986] [101/133] (465s left) gem_exec_schedule (smoketest-all)
[561.980239] Starting subtest: smoketest-all
[594.374904] Subtest smoketest-all: SUCCESS (32.349s)
[595.192963] [102/133] (432s left) kms_big_fb (y-tiled-addfb-size-overflow)
[595.304204] Starting subtest: y-tiled-addfb-size-overflow
[595.308720] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[595.391331] [103/133] (432s left) vgem_basic (bad-fence)
[595.440072] Starting subtest: bad-fence
[595.442351] Subtest bad-fence: SUCCESS (0.000s)
[595.504587] [104/133] (432s left) gem_ctx_persistence (engines-hostile)
[595.563785] Starting subtest: engines-hostile
[595.566231] Starting dynamic subtest: rcs0
[595.681112] Dynamic subtest rcs0: SUCCESS (0.117s)
[595.706279] Starting dynamic subtest: bcs0
[595.773900] Dynamic subtest bcs0: SUCCESS (0.091s)
[595.786165] Starting dynamic subtest: vcs0
[595.866012] Dynamic subtest vcs0: SUCCESS (0.090s)
[595.878160] Starting dynamic subtest: vcs1
[595.936886] Dynamic subtest vcs1: SUCCESS (0.069s)
[595.948046] Starting dynamic subtest: vecs0
[596.048797] Dynamic subtest vecs0: SUCCESS (0.110s)
[596.059261] Starting dynamic subtest: ccs0
[596.140739] Dynamic subtest ccs0: SUCCESS (0.090s)
[596.143008] Subtest engines-hostile: SUCCESS (0.578s)
[596.262507] [105/133] (431s left) prime_mmap (test_forked)
[596.318908] Starting subtest: test_forked
[596.320845] Starting dynamic subtest: test_forked-smem
[596.352819] Dynamic subtest test_forked-smem: SUCCESS (0.037s)
[596.354859] Subtest test_forked: SUCCESS (0.038s)
[596.455573] [106/133] (431s left) gem_spin_batch (resubmit-all)
[596.516536] Starting subtest: resubmit-all
[596.518441] Starting dynamic subtest: rcs0
[596.525233] Dynamic subtest rcs0: SUCCESS (0.012s)
[596.536641] Starting dynamic subtest: bcs0
[596.538524] Dynamic subtest bcs0: SUCCESS (0.002s)
[596.548175] Starting dynamic subtest: vcs0
[596.549843] Dynamic subtest vcs0: SUCCESS (0.002s)
[596.558966] Starting dynamic subtest: vcs1
[596.560589] Dynamic subtest vcs1: SUCCESS (0.002s)
[596.569385] Starting dynamic subtest: vecs0
[596.570953] Dynamic subtest vecs0: SUCCESS (0.003s)
[596.579887] Starting dynamic subtest: ccs0
[596.581522] Dynamic subtest ccs0: SUCCESS (0.003s)
[596.583108] Subtest resubmit-all: SUCCESS (0.028s)
[596.789024] [107/133] (431s left) i915_drm_fdinfo (busy-idle)
[596.824605] Starting subtest: busy-idle
[596.826423] Starting dynamic subtest: rcs0
[596.848567] Dynamic subtest rcs0: SKIP (0.022s)
[596.858675] Starting dynamic subtest: bcs0
[596.868021] Dynamic subtest bcs0: SKIP (0.019s)
[596.877469] Starting dynamic subtest: vcs0
[596.880850] Dynamic subtest vcs0: SKIP (0.000s)
[596.889921] Starting dynamic subtest: vcs1
[596.893233] Dynamic subtest vcs1: SKIP (0.000s)
[596.902431] Starting dynamic subtest: vecs0
[596.905840] Dynamic subtest vecs0: SKIP (0.000s)
[596.914825] Starting dynamic subtest: ccs0
[596.918302] Dynamic subtest ccs0: SKIP (0.000s)
[596.921682] Subtest busy-idle: SKIP (0.047s)
[596.957558] [108/133] (431s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[597.067371] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[597.860041] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.793s)
[598.007185] [109/133] (430s left) perf (non-sampling-read-error)
[598.112460] Starting subtest: non-sampling-read-error
[598.121210] Subtest non-sampling-read-error: SUCCESS (0.006s)
[598.161670] [110/133] (429s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[598.265528] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[606.874910] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.611s)
[607.008426] [111/133] (421s left) kms_force_connector_basic (force-load-detect)
[607.081396] Starting subtest: force-load-detect
[607.085756] Subtest force-load-detect: SKIP (0.000s)
[607.212031] [112/133] (420s left) kms_content_protection (lic-type-0-hdcp14)
[607.352738] Starting subtest: lic-type-0-hdcp14
[607.357561] Subtest lic-type-0-hdcp14: SKIP (0.000s)
[607.473009] [113/133] (420s left) gem_ctx_shared (q-in-order)
[607.537374] Starting subtest: Q-in-order
[607.539783] Starting dynamic subtest: rcs0
[607.654613] Dynamic subtest rcs0: SUCCESS (0.115s)
[607.668243] Starting dynamic subtest: vcs0
[607.747418] Dynamic subtest vcs0: SUCCESS (0.092s)
[607.766213] Starting dynamic subtest: vcs1
[607.836900] Dynamic subtest vcs1: SUCCESS (0.088s)
[607.855639] Starting dynamic subtest: vecs0
[607.917779] Dynamic subtest vecs0: SUCCESS (0.080s)
[607.936172] Starting dynamic subtest: ccs0
[608.012096] Dynamic subtest ccs0: SUCCESS (0.093s)
[608.014774] Subtest Q-in-order: SUCCESS (0.474s)
[609.308630] [114/133] (418s left) i915_suspend (basic-s3-without-i915)
[609.347889] Starting subtest: basic-s3-without-i915
[612.656673] Subtest basic-s3-without-i915: SKIP (3.303s)
[614.260961] [115/133] (414s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[614.369901] Starting subtest: yf-tiled-32bpp-rotate-270
[614.374366] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[614.459116] [116/133] (413s left) gem_ctx_persistence (legacy-engines-persistence)
[614.520648] Starting subtest: legacy-engines-persistence
[614.522973] Starting dynamic subtest: render
[615.344077] Dynamic subtest render: SUCCESS (0.822s)
[615.357460] Starting dynamic subtest: bsd1
[616.130302] Dynamic subtest bsd1: SUCCESS (0.784s)
[616.142237] Starting dynamic subtest: bsd2
[616.883952] Dynamic subtest bsd2: SUCCESS (0.751s)
[616.895359] Starting dynamic subtest: blt
[617.663254] Dynamic subtest blt: SUCCESS (0.776s)
[617.675333] Starting dynamic subtest: vebox
[618.411213] Dynamic subtest vebox: SUCCESS (0.745s)
[618.414069] Subtest legacy-engines-persistence: SUCCESS (3.892s)
[618.490934] [117/133] (409s left) kms_rotation_crc (primary-rotation-90)
[618.600311] Starting subtest: primary-rotation-90
[618.604880] Subtest primary-rotation-90: SKIP (0.001s)
[618.685322] [118/133] (409s left) syncobj_wait (multi-wait-all-signaled)
[618.737401] Starting subtest: multi-wait-all-signaled
[618.739747] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[618.834623] [119/133] (409s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[618.930149] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[618.934351] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[619.021026] [120/133] (409s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[619.109384] Starting subtest: fbc-pr-sprite-mmap-gtt
[619.113364] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[619.183226] [121/133] (409s left) kms_force_connector_basic (prune-stale-modes)
[619.269645] Starting subtest: prune-stale-modes
[619.717400] Subtest prune-stale-modes: SUCCESS (0.448s)
[619.856957] [122/133] (408s left) perf (stress-open-close)
[619.982605] Starting subtest: stress-open-close
[619.984528] Starting dynamic subtest: 0-rcs0
[622.148964] Dynamic subtest 0-rcs0: SUCCESS (2.168s)
[622.159240] Starting dynamic subtest: 1-vcs1
[624.310408] Dynamic subtest 1-vcs1: SUCCESS (2.161s)
[624.312380] Subtest stress-open-close: SUCCESS (4.331s)
[624.360578] [123/133] (404s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[624.413594] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[624.415548] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[624.497522] [124/133] (404s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[624.602044] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[624.605661] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[624.685645] [125/133] (404s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[624.773768] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[624.775701] Starting dynamic subtest: pipe-A-eDP-1
[624.897622] Dynamic subtest pipe-A-eDP-1: SKIP (0.125s)
[624.907196] Starting dynamic subtest: pipe-B-eDP-1
[626.072036] Dynamic subtest pipe-B-eDP-1: SKIP (1.171s)
[626.076581] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.299s)
[627.321968] [126/133] (401s left) sw_sync (sync_merge_same)
[627.360501] Starting subtest: sync_merge_same
[627.362684] Subtest sync_merge_same: SUCCESS (0.000s)
[627.409667] [127/133] (401s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[627.513246] Starting subtest: 4-tiled-32bpp-rotate-0
[628.944990] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.434s)
[629.102296] [128/133] (399s left) i915_pm_rc6_residency (media-rc6-accuracy)
[629.161367] Starting subtest: media-rc6-accuracy
[629.165293] Subtest media-rc6-accuracy: SKIP (0.000s)
[629.253209] [129/133] (399s left) kms_psr (psr-primary-render)
[629.339509] Starting subtest: psr-primary-render
[629.341467] Starting dynamic subtest: eDP-1
[631.095674] Dynamic subtest eDP-1: SUCCESS (1.756s)
[631.097615] Subtest psr-primary-render: SUCCESS (1.757s)
[631.913457] [130/133] (396s left) kms_getfb (getfb2-handle-closed)
[632.002382] Starting subtest: getfb2-handle-closed
[632.004708] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[632.114074] [131/133] (396s left) gem_wait (write-busy)
[632.182754] Starting subtest: write-busy
[632.185236] Starting dynamic subtest: all-engines
[632.783021] Dynamic subtest all-engines: SUCCESS (0.599s)
[632.801602] Starting dynamic subtest: rcs0
[633.336357] Dynamic subtest rcs0: SUCCESS (0.551s)
[633.354208] Starting dynamic subtest: bcs0
[633.884728] Dynamic subtest bcs0: SUCCESS (0.548s)
[633.900714] Starting dynamic subtest: vcs0
[635.191045] Dynamic subtest vcs0: SUCCESS (1.303s)
[635.208299] Starting dynamic subtest: vcs1
[637.174036] Dynamic subtest vcs1: SUCCESS (1.981s)
[637.192169] Starting dynamic subtest: vecs0
[639.157787] Dynamic subtest vecs0: SUCCESS (1.980s)
[639.172299] Starting dynamic subtest: ccs0
[639.711864] Dynamic subtest ccs0: SUCCESS (0.552s)
[639.714593] Subtest write-busy: SUCCESS (7.530s)
[639.913924] [132/133] (389s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[640.031679] Starting subtest: cursorB-vs-flipB-legacy
[640.036489] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[640.177638] [133/133] (388s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[640.279349] Starting subtest: primary-x-tiled-reflect-x-0
[647.142385] Subtest primary-x-tiled-reflect-x-0: SUCCESS (6.865s)
[648.308589] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: gem_exec_balancer
results: parsing output: 5/ for test: syncobj_wait
results: parsing output: 6/ for test: gen7_exec_parse
results: parsing output: 7/ for test: gem_pread
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_cursor_crc
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_psr2_sf
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_plane_scaling
results: parsing output: 14/ for test: gem_exec_flush
results: parsing output: 15/ for test: gem_eio
results: parsing output: 16/ for test: kms_plane
results: parsing output: 17/ for test: kms_cursor_crc
results: parsing output: 18/ for test: kms_psr
results: parsing output: 19/ for test: kms_invalid_mode
results: parsing output: 20/ for test: kms_cursor_crc
results: parsing output: 21/ for test: kms_addfb_basic
results: parsing output: 22/ for test: gem_exec_schedule
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: kms_chamelium_hpd
results: parsing output: 25/ for test: gem_exec_schedule
results: parsing output: 26/ for test: kms_lease
results: parsing output: 27/ for test: kms_cursor_crc
results: parsing output: 28/ for test: kms_ccs
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: gem_exec_reloc
results: parsing output: 31/ for test: gem_exec_parallel
results: parsing output: 32/ for test: kms_vblank
results: parsing output: 33/ for test: kms_flip_scaled_crc
results: parsing output: 34/ for test: kms_sequence
results: parsing output: 35/ for test: gem_exec_whisper
results: parsing output: 36/ for test: kms_cursor_legacy
results: parsing output: 37/ for test: perf_pmu
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_exec_fence
results: parsing output: 40/ for test: kms_ccs
results: parsing output: 41/ for test: gem_lmem_swapping
results: parsing output: 42/ for test: sw_sync
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_prop_blob
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: gem_lmem_swapping
results: parsing output: 47/ for test: kms_flip
results: parsing output: 48/ for test: api_intel_bb
results: parsing output: 49/ for test: kms_pm_dc
results: parsing output: 50/ for test: kms_plane_cursor
results: parsing output: 51/ for test: gem_exec_reloc
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: gem_exec_schedule
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_color
results: parsing output: 56/ for test: syncobj_timeline
results: parsing output: 57/ for test: gem_eio
results: parsing output: 58/ for test: kms_addfb_basic
results: parsing output: 59/ for test: kms_addfb_basic
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_plane
results: parsing output: 62/ for test: kms_pipe_crc_basic
results: parsing output: 63/ for test: kms_chamelium_frames
results: parsing output: 64/ for test: perf
results: parsing output: 65/ for test: kms_dsc
results: parsing output: 66/ for test: syncobj_eventfd
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: gem_mmap_offset
results: parsing output: 69/ for test: kms_chamelium_color
results: parsing output: 70/ for test: kms_hdmi_inject
results: parsing output: 71/ for test: i915_drm_fdinfo
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: gem_set_tiling_vs_gtt
results: parsing output: 74/ for test: api_intel_allocator
results: parsing output: 75/ for test: kms_flip_scaled_crc
results: parsing output: 76/ for test: gem_eio
results: parsing output: 77/ for test: gem_exec_create
results: parsing output: 78/ for test: syncobj_timeline
results: parsing output: 79/ for test: gem_exec_params
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: kms_cursor_legacy
results: parsing output: 82/ for test: gem_userptr_blits
results: parsing output: 83/ for test: gem_ctx_engines
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_pm_rpm
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_atomic
results: parsing output: 88/ for test: syncobj_timeline
results: parsing output: 89/ for test: gem_request_retire
results: parsing output: 90/ for test: gem_render_copy
results: parsing output: 91/ for test: gem_pxp
results: parsing output: 92/ for test: kms_ccs
results: parsing output: 93/ for test: kms_flip_scaled_crc
results: parsing output: 94/ for test: gem_exec_fence
results: parsing output: 95/ for test: dumb_buffer
results: parsing output: 96/ for test: kms_psr
results: parsing output: 97/ for test: fbdev
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_vrr
results: parsing output: 100/ for test: gem_exec_schedule
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: vgem_basic
results: parsing output: 103/ for test: gem_ctx_persistence
results: parsing output: 104/ for test: prime_mmap
results: parsing output: 105/ for test: gem_spin_batch
results: parsing output: 106/ for test: i915_drm_fdinfo
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: perf
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_force_connector_basic
results: parsing output: 111/ for test: kms_content_protection
results: parsing output: 112/ for test: gem_ctx_shared
results: parsing output: 113/ for test: i915_suspend
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: gem_ctx_persistence
results: parsing output: 116/ for test: kms_rotation_crc
results: parsing output: 117/ for test: syncobj_wait
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: kms_force_connector_basic
results: parsing output: 121/ for test: perf
results: parsing output: 122/ for test: syncobj_wait
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_psr2_sf
results: parsing output: 125/ for test: sw_sync
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: i915_pm_rc6_residency
results: parsing output: 128/ for test: kms_psr
results: parsing output: 129/ for test: kms_getfb
results: parsing output: 130/ for test: gem_wait
results: parsing output: 131/ for test: kms_cursor_legacy
results: parsing output: 132/ for test: kms_rotation_crc
Done.