[54.284944] Initializing watchdogs
[54.285065]   /dev/watchdog0
[54.299948] [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]
[54.304419] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[54.306560] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[54.309811] [001/133] (960s left) gem_exec_balancer (semaphore)
[54.393812] Starting subtest: semaphore
[55.894898] Subtest semaphore: SUCCESS (1.511s)
[56.262553] [002/133] (958s left) gem_pxp (protected-raw-src-copy-not-readible)
[56.390274] Starting subtest: protected-raw-src-copy-not-readible
[56.452552] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.064s)
[56.598687] [003/133] (958s left) gem_ctx_param (invalid-set-ringsize)
[56.649639] Starting subtest: invalid-set-ringsize
[56.652055] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[56.743951] [004/133] (958s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[56.847502] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[56.851627] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[56.985279] [005/133] (957s left) gem_eio (suspend)
[57.136341] Starting subtest: suspend
[69.343817] Subtest suspend: SUCCESS (12.232s)
[69.518209] [006/133] (945s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[69.638414] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[69.642803] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[69.756469] [007/133] (945s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[69.825511] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[69.908195] [008/133] (945s left) prime_mmap (test_forked_cpu_write)
[69.962092] Starting subtest: test_forked_cpu_write
[69.964400] Starting dynamic subtest: test_forked_cpu_write-smem
[69.973493] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.012s)
[69.975813] Subtest test_forked_cpu_write: SUCCESS (0.012s)
[70.087833] [009/133] (945s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[70.185121] Starting subtest: crc-primary-suspend-y-tiled-ccs
[70.187477] Starting dynamic subtest: pipe-A-eDP-1
[70.197033] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[70.206950] Starting dynamic subtest: pipe-B-eDP-1
[70.216333] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[70.227706] Starting dynamic subtest: pipe-C-eDP-1
[70.234942] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[70.242494] Starting dynamic subtest: pipe-D-eDP-1
[70.249271] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[70.252717] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.003s)
[72.478987] [010/133] (942s left) prime_mmap (test_dup)
[72.538617] Starting subtest: test_dup
[72.540997] Starting dynamic subtest: test_dup-smem
[72.570985] Dynamic subtest test_dup-smem: SUCCESS (0.033s)
[72.573299] Subtest test_dup: SUCCESS (0.033s)
[72.666301] [011/133] (942s left) kms_dp_link_training (non-uhbr-mst)
[72.759259] Starting subtest: non-uhbr-mst
[72.768022] Subtest non-uhbr-mst: SKIP (0.000s)
[72.853383] [012/133] (942s left) gem_mmap_gtt (basic-wc)
[72.915242] Subtest basic-wc: SKIP (0.000s)
[72.984216] [013/133] (942s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[73.079490] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[73.083737] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[73.194573] [014/133] (942s left) gem_exec_fence (syncobj-timeline-repeat)
[73.744904] Starting subtest: syncobj-timeline-repeat
[73.979611] Subtest syncobj-timeline-repeat: SUCCESS (0.235s)
[74.989834] [FACT gem_exec_fence (syncobj-timeline-repeat)] new: kernel.kmod_is_loaded.vgem: true
[74.992945] [015/133] (940s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[75.098587] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[75.102750] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[75.247052] [016/133] (940s left) gem_lmem_swapping (parallel-multi)
[75.286277] Subtest parallel-multi: SKIP (0.000s)
[75.329318] [017/133] (940s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[75.389532] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[75.394153] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[75.597705] [018/133] (939s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[76.134691] Starting subtest: syncobj-timeline-multiple-ext-nodes
[76.136976] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.003s)
[78.006209] [019/133] (937s left) syncobj_timeline (single-wait-all-signaled)
[78.058085] Starting subtest: single-wait-all-signaled
[78.060459] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[78.195134] [020/133] (937s left) kms_cursor_crc (cursor-dpms)
[78.330646] Starting subtest: cursor-dpms
[78.332974] Starting dynamic subtest: pipe-A-eDP-1
[81.365049] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.034s)
[81.375226] Starting dynamic subtest: pipe-D-eDP-1
[85.061063] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.698s)
[85.063507] Subtest cursor-dpms: SUCCESS (6.734s)
[85.927653] [021/133] (929s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[86.036184] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[90.666564] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.635s)
[91.839448] [022/133] (923s left) gem_exec_balancer (nohangcheck)
[92.101420] Starting subtest: nohangcheck
[92.985335] Subtest nohangcheck: SUCCESS (0.882s)
[93.134133] [023/133] (922s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[93.230324] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[93.942906] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.715s)
[94.160947] [024/133] (921s left) gem_eio (wait-10ms)
[94.378679] Starting subtest: wait-10ms
[94.692863] Subtest wait-10ms: SUCCESS (0.314s)
[94.861661] [025/133] (920s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[94.973876] Starting subtest: yf-tiled-8bpp-rotate-270
[94.977485] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[95.108077] [026/133] (920s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[95.204879] Starting subtest: stress-xrgb8888-xtiled
[101.084028] Subtest stress-xrgb8888-xtiled: SUCCESS (5.880s)
[101.140078] [027/133] (914s left) kms_plane_scaling (invalid-num-scalers)
[101.236667] Starting subtest: invalid-num-scalers
[101.238630] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[101.258167] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.019s)
[101.266958] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[101.294620] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.037s)
[101.305034] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[101.333887] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.037s)
[101.342199] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[101.366449] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.032s)
[101.368262] Subtest invalid-num-scalers: SUCCESS (0.129s)
[101.497927] [028/133] (914s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[101.551079] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[101.619019] [029/133] (914s left) gem_ctx_shared (q-independent)
[101.686928] Starting subtest: Q-independent
[101.688974] Starting dynamic subtest: rcs0
[101.758327] Dynamic subtest rcs0: SUCCESS (0.071s)
[101.768319] Starting dynamic subtest: vcs0
[101.802378] Dynamic subtest vcs0: SUCCESS (0.044s)
[101.814148] Starting dynamic subtest: vcs1
[101.845495] Dynamic subtest vcs1: SUCCESS (0.043s)
[101.856693] Starting dynamic subtest: vecs0
[101.888304] Dynamic subtest vecs0: SUCCESS (0.042s)
[101.898663] Starting dynamic subtest: ccs0
[101.949044] Dynamic subtest ccs0: SUCCESS (0.059s)
[101.951454] Subtest Q-independent: SUCCESS (0.261s)
[103.063439] [030/133] (912s left) api_intel_bb (intel-bb-blit-x)
[103.125617] Starting subtest: intel-bb-blit-x
[107.123104] Subtest intel-bb-blit-x: SUCCESS (3.995s)
[107.293933] [031/133] (908s left) i915_drm_fdinfo (memory-info-resident)
[107.333682] Starting subtest: memory-info-resident
[107.336113] Starting dynamic subtest: smem0
[109.999589] Dynamic subtest smem0: SUCCESS (2.668s)
[110.001497] Subtest memory-info-resident: SUCCESS (2.668s)
[110.109171] [032/133] (906s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[110.204365] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[110.207871] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[110.334315] [033/133] (905s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[110.434698] Starting subtest: plane-lut1d-ctm3x4-lut1d
[110.450341] Starting dynamic subtest: pipe-A-eDP-1
[111.090491] Dynamic subtest pipe-A-eDP-1: FAIL (0.320s)
[111.878144] Starting dynamic subtest: pipe-B-eDP-1
[112.719515] Dynamic subtest pipe-B-eDP-1: FAIL (0.313s)
[113.304117] Starting dynamic subtest: pipe-C-eDP-1
[114.131924] Dynamic subtest pipe-C-eDP-1: FAIL (0.247s)
[114.634712] Starting dynamic subtest: pipe-D-eDP-1
[115.454899] Dynamic subtest pipe-D-eDP-1: FAIL (0.235s)
[115.456953] Subtest plane-lut1d-ctm3x4-lut1d: FAIL (4.734s)
[116.044528] [034/133] (900s left) kms_cursor_crc (cursor-random-32x32)
[116.192275] Starting subtest: cursor-random-32x32
[116.241758] Subtest cursor-random-32x32: SKIP (0.044s)
[116.544590] [035/133] (899s left) api_intel_allocator (reopen)
[116.601865] Starting subtest: reopen
[116.606881] Subtest reopen: SUCCESS (0.005s)
[116.752327] [036/133] (899s left) testdisplay
[117.094841] [037/133] (899s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[117.227187] Starting subtest: basic-busy-flip-before-cursor-legacy
[117.230927] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[117.397315] [038/133] (898s left) gem_ctx_param (root-set)
[117.455606] Starting subtest: root-set
[117.457896] Subtest root-set: SUCCESS (0.001s)
[117.592128] [039/133] (898s left) gen9_exec_parse (batch-without-end)
[117.650084] Subtest batch-without-end: SKIP (0.000s)
[117.731170] [040/133] (898s left) kms_flip_scaled_crc (flip-nv12-linear-to-nv12-linear-reflect-x)
[117.827056] Starting subtest: flip-NV12-linear-to-NV12-linear-reflect-x
[117.828930] Starting dynamic subtest: pipe-A-default-mode
[118.990087] Dynamic subtest pipe-A-default-mode: SKIP (1.161s)
[118.994658] Subtest flip-NV12-linear-to-NV12-linear-reflect-x: SKIP (1.162s)
[119.193589] [041/133] (897s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[119.292156] Starting subtest: psr-rgb565-draw-pwrite
[126.260179] Subtest psr-rgb565-draw-pwrite: SUCCESS (6.969s)
[126.405008] [042/133] (890s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[126.511839] Starting subtest: x-tiled-32bpp-rotate-90
[126.531910] Subtest x-tiled-32bpp-rotate-90: SKIP (0.019s)
[126.693146] [043/133] (889s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[126.809964] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[126.814344] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[126.941449] [044/133] (889s left) kms_psr (pr-basic)
[127.022979] Starting subtest: pr-basic
[127.027434] Subtest pr-basic: SKIP (0.000s)
[127.119674] [045/133] (889s left) gem_exec_store (dword)
[127.187725] Starting subtest: dword
[127.189628] Starting dynamic subtest: rcs0
[127.285430] Dynamic subtest rcs0: SUCCESS (0.098s)
[127.297252] Starting dynamic subtest: bcs0
[127.327388] Dynamic subtest bcs0: SUCCESS (0.040s)
[127.337172] Starting dynamic subtest: vcs0
[127.368868] Dynamic subtest vcs0: SUCCESS (0.040s)
[127.378676] Starting dynamic subtest: vcs1
[127.410053] Dynamic subtest vcs1: SUCCESS (0.039s)
[127.420844] Starting dynamic subtest: vecs0
[127.450809] Dynamic subtest vecs0: SUCCESS (0.039s)
[127.460331] Starting dynamic subtest: ccs0
[127.493933] Dynamic subtest ccs0: SUCCESS (0.041s)
[127.496066] Subtest dword: SUCCESS (0.309s)
[127.700402] [046/133] (889s left) kms_cursor_edge_walk (64x64-right-edge)
[127.809145] Starting subtest: 64x64-right-edge
[127.811384] Starting dynamic subtest: pipe-A-eDP-1
[131.227434] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.419s)
[131.237071] Starting dynamic subtest: pipe-D-eDP-1
[134.347986] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.118s)
[134.350114] Subtest 64x64-right-edge: SUCCESS (6.539s)
[135.182721] [047/133] (881s left) gem_mmap_gtt (pf-nonblock)
[135.246395] Subtest pf-nonblock: SKIP (0.000s)
[135.317748] [048/133] (881s left) kms_rmfb (close-fd)
[135.412114] Starting subtest: close-fd
[135.414421] Starting dynamic subtest: pipe-A-eDP-1
[135.520229] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.107s)
[135.529903] Starting dynamic subtest: pipe-B-eDP-1
[136.714343] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.193s)
[136.724109] Starting dynamic subtest: pipe-C-eDP-1
[137.842215] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.127s)
[137.851225] Starting dynamic subtest: pipe-D-eDP-1
[138.979833] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.138s)
[138.982258] Subtest close-fd: SUCCESS (3.570s)
[140.213230] [049/133] (876s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[140.314538] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[140.317061] Starting dynamic subtest: pipe-A-eDP-1
[140.338538] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[140.349963] Starting dynamic subtest: pipe-B-eDP-1
[140.369549] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[140.378325] Starting dynamic subtest: pipe-C-eDP-1
[140.397885] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[140.406903] Starting dynamic subtest: pipe-D-eDP-1
[140.426287] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[140.428199] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[142.568510] [050/133] (874s left) perf (non-zero-reason)
[142.712353] Starting subtest: non-zero-reason
[142.714584] Starting dynamic subtest: 0-rcs0
[148.150400] Dynamic subtest 0-rcs0: SUCCESS (5.438s)
[148.163693] Starting dynamic subtest: 1-vecs0
[152.074351] Dynamic subtest 1-vecs0: SUCCESS (3.924s)
[152.077155] Subtest non-zero-reason: SUCCESS (9.363s)
[152.122849] [051/133] (864s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[152.223516] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[152.227765] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[152.353074] [052/133] (864s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[152.454394] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[152.467855] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.011s)
[152.566248] [053/133] (864s left) i915_pm_rpm (gem-execbuf-stress)
[154.089963] Starting subtest: gem-execbuf-stress
[154.092318] Starting dynamic subtest: smem0
[167.003789] Dynamic subtest smem0: SUCCESS (12.917s)
[167.014804] Starting dynamic subtest: extra-wait-smem0
[229.020670] Dynamic subtest extra-wait-smem0: SUCCESS (62.018s)
[229.023341] Subtest gem-execbuf-stress: SUCCESS (74.940s)
[229.428733] [054/133] (787s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[229.828468] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[230.609273] [055/133] (786s left) gem_ctx_exec (basic)
[230.669616] Starting subtest: basic
[230.676379] Subtest basic: SUCCESS (0.008s)
[230.827807] [056/133] (786s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[230.920996] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[231.305592] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[234.099405] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.792s)
[234.111908] Starting dynamic subtest: pipe-A-eDP-1-4
[236.274090] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.173s)
[236.285586] Starting dynamic subtest: pipe-A-eDP-1-4
[238.284827] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[238.297034] Starting dynamic subtest: pipe-A-eDP-1-x
[240.463930] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.178s)
[240.839164] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[243.630046] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.796s)
[243.642156] Starting dynamic subtest: pipe-B-eDP-1-4
[245.816434] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s)
[245.826105] Starting dynamic subtest: pipe-B-eDP-1-4
[247.826837] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[247.838831] Starting dynamic subtest: pipe-B-eDP-1-x
[250.028561] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.200s)
[250.404084] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[253.159194] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.761s)
[253.171525] Starting dynamic subtest: pipe-C-eDP-1-4
[255.335650] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s)
[255.347299] Starting dynamic subtest: pipe-C-eDP-1-4
[257.345417] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[257.354794] Starting dynamic subtest: pipe-C-eDP-1-x
[259.524818] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s)
[259.888581] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[262.685800] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.805s)
[262.697980] Starting dynamic subtest: pipe-D-eDP-1-4
[264.861029] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[264.872804] Starting dynamic subtest: pipe-D-eDP-1-4
[266.870668] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[266.879833] Starting dynamic subtest: pipe-D-eDP-1-x
[269.061435] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.189s)
[269.064262] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.136s)
[270.303834] [057/133] (746s left) kms_invalid_mode (bad-vsync-end)
[270.399435] Starting subtest: bad-vsync-end
[270.401733] Starting dynamic subtest: pipe-A-eDP-1
[270.684302] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.282s)
[270.694711] Starting dynamic subtest: pipe-B-eDP-1
[270.696613] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[270.705348] Starting dynamic subtest: pipe-C-eDP-1
[270.707537] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[270.718443] Starting dynamic subtest: pipe-D-eDP-1
[270.720852] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[270.723873] Subtest bad-vsync-end: SUCCESS (0.288s)
[271.535633] [058/133] (745s left) gem_mmap_gtt (basic)
[271.603671] Subtest basic: SKIP (0.000s)
[271.670677] [059/133] (745s left) kms_vblank (crtc-id)
[271.771660] Starting subtest: crtc-id
[271.773714] Starting dynamic subtest: pipe-A-eDP-1
[272.216160] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.443s)
[272.230296] Starting dynamic subtest: pipe-D-eDP-1
[273.343889] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.126s)
[273.346120] Subtest crtc-id: SUCCESS (1.574s)
[274.220552] [060/133] (743s left) kms_frontbuffer_tracking (psr-abgr161616f-draw-render)
[274.332321] Starting subtest: psr-abgr161616f-draw-render
[274.336640] Subtest psr-abgr161616f-draw-render: SKIP (0.000s)
[274.471394] [061/133] (742s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[274.582062] Starting subtest: 4-tiled-32bpp-rotate-180
[276.083640] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.501s)
[276.239362] [062/133] (741s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[281.241939] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[281.246593] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.002s)
[282.153203] [063/133] (735s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[282.222620] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[282.332564] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.109s)
[282.433510] [064/133] (735s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[282.528411] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[282.532886] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[282.660332] [065/133] (734s left) syncobj_wait (reset-signaled)
[282.722085] Starting subtest: reset-signaled
[282.724373] Subtest reset-signaled: SUCCESS (0.000s)
[282.860770] [066/133] (734s left) gem_spin_batch (resubmit-new)
[282.933711] Starting subtest: resubmit-new
[282.936078] Starting dynamic subtest: rcs0
[282.942594] Dynamic subtest rcs0: SUCCESS (0.009s)
[282.953510] Starting dynamic subtest: bcs0
[282.955436] Dynamic subtest bcs0: SUCCESS (0.004s)
[282.965675] Starting dynamic subtest: vcs0
[282.967817] Dynamic subtest vcs0: SUCCESS (0.004s)
[282.976857] Starting dynamic subtest: vcs1
[282.978750] Dynamic subtest vcs1: SUCCESS (0.004s)
[282.987491] Starting dynamic subtest: vecs0
[282.989421] Dynamic subtest vecs0: SUCCESS (0.005s)
[282.997962] Starting dynamic subtest: ccs0
[282.999891] Dynamic subtest ccs0: SUCCESS (0.004s)
[283.001785] Subtest resubmit-new: SUCCESS (0.034s)
[284.952380] [067/133] (732s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[285.050588] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[285.054670] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[285.184822] [068/133] (732s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[285.289054] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[308.410400] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (23.123s)
[308.580356] [069/133] (709s left) kms_lease (lease-get)
[308.677286] Starting subtest: lease-get
[308.679196] Starting dynamic subtest: pipe-A-eDP-1
[308.681071] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[308.690417] Starting dynamic subtest: pipe-B-eDP-1
[308.692161] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[308.700681] Starting dynamic subtest: pipe-C-eDP-1
[308.702705] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[308.711245] Starting dynamic subtest: pipe-D-eDP-1
[308.712962] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[308.714977] Subtest lease-get: SUCCESS (0.011s)
[308.834518] [070/133] (708s left) kms_atomic_interruptible (legacy-pageflip)
[308.934116] Starting subtest: legacy-pageflip
[308.935920] Starting dynamic subtest: pipe-A-eDP-1
[316.364902] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.427s)
[316.367166] Subtest legacy-pageflip: SUCCESS (7.429s)
[317.208876] [071/133] (700s left) syncobj_basic (create-signaled)
[317.275625] Starting subtest: create-signaled
[317.277572] Subtest create-signaled: SUCCESS (0.000s)
[317.382409] [072/133] (700s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[317.482122] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[317.484384] Starting dynamic subtest: pipe-A-eDP-1
[317.506023] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[317.520676] Starting dynamic subtest: pipe-B-eDP-1
[317.541800] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[317.554730] Starting dynamic subtest: pipe-C-eDP-1
[317.576547] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[317.587202] Starting dynamic subtest: pipe-D-eDP-1
[317.609816] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[317.614249] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[319.759460] [073/133] (698s left) gem_create (create-invalid-size)
[319.827402] Starting subtest: create-invalid-size
[319.829428] Subtest create-invalid-size: SUCCESS (0.000s)
[320.045400] [074/133] (697s left) kms_feature_discovery (psr2)
[320.145824] Starting subtest: psr2
[320.148058] Subtest psr2: SUCCESS (0.000s)
[320.244548] [075/133] (697s left) gem_ctx_engines (invalid-engines)
[320.303218] Starting subtest: invalid-engines
[320.311039] Subtest invalid-engines: SUCCESS (0.008s)
[320.585151] [076/133] (697s left) kms_rotation_crc (primary-rotation-270)
[320.689093] Starting subtest: primary-rotation-270
[320.693312] Subtest primary-rotation-270: SKIP (0.001s)
[320.787585] [077/133] (697s left) i915_query (query-regions-unallocated)
[320.845560] Starting subtest: query-regions-unallocated
[320.847528] Subtest query-regions-unallocated: SUCCESS (0.000s)
[320.969148] [078/133] (697s left) dmabuf_sync_file (export-multiwait)
[321.019605] Starting subtest: export-multiwait
[321.021802] Subtest export-multiwait: SUCCESS (0.001s)
[321.104072] [079/133] (697s left) gem_ctx_persistence (legacy-engines-hostile)
[321.163544] Starting subtest: legacy-engines-hostile
[321.166039] Starting dynamic subtest: render
[321.319895] Dynamic subtest render: SUCCESS (0.156s)
[321.334398] Starting dynamic subtest: bsd1
[321.436953] Dynamic subtest bsd1: SUCCESS (0.114s)
[321.448962] Starting dynamic subtest: bsd2
[321.551218] Dynamic subtest bsd2: SUCCESS (0.112s)
[321.565248] Starting dynamic subtest: blt
[321.664235] Dynamic subtest blt: SUCCESS (0.110s)
[321.677736] Starting dynamic subtest: vebox
[321.785256] Dynamic subtest vebox: SUCCESS (0.118s)
[321.787370] Subtest legacy-engines-hostile: SUCCESS (0.624s)
[321.887426] [080/133] (696s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[321.961134] Starting subtest: invalid-bsd2-flag-on-vebox
[321.962984] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[322.102242] [081/133] (696s left) kms_pm_rpm (fences-dpms)
[324.042906] Starting subtest: fences-dpms
[324.047795] Subtest fences-dpms: SKIP (0.000s)
[324.422968] [082/133] (693s left) kms_flip (blocking-wf_vblank)
[324.531355] Starting subtest: blocking-wf_vblank
[324.533752] Starting dynamic subtest: A-eDP1
[333.448857] Dynamic subtest A-eDP1: SUCCESS (8.920s)
[333.462516] Starting dynamic subtest: B-eDP1
[342.381731] Dynamic subtest B-eDP1: SUCCESS (8.930s)
[342.391469] Starting dynamic subtest: C-eDP1
[351.305225] Dynamic subtest C-eDP1: SUCCESS (8.920s)
[351.315743] Starting dynamic subtest: D-eDP1
[360.244685] Dynamic subtest D-eDP1: SUCCESS (8.937s)
[360.247077] Subtest blocking-wf_vblank: SUCCESS (35.717s)
[361.498142] [083/133] (656s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[366.437070] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[366.439444] Starting dynamic subtest: pipe-A-eDP-1
[378.487027] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.047s)
[378.496881] Starting dynamic subtest: pipe-B-eDP-1
[390.517515] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.031s)
[390.519852] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (24.081s)
[391.396314] [084/133] (626s left) kms_flip (2x-flip-vs-fences-interruptible)
[391.508304] Starting subtest: 2x-flip-vs-fences-interruptible
[391.512353] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[391.654255] [085/133] (626s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[391.753757] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[391.758164] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[391.898809] [086/133] (626s left) kms_psr (psr-sprite-plane-onoff)
[391.999047] Starting subtest: psr-sprite-plane-onoff
[392.001336] Starting dynamic subtest: eDP-1
[393.728175] Dynamic subtest eDP-1: SUCCESS (1.728s)
[393.730478] Subtest psr-sprite-plane-onoff: SUCCESS (1.729s)
[394.564859] [087/133] (623s left) kms_big_fb (linear-8bpp-rotate-0)
[394.674589] Starting subtest: linear-8bpp-rotate-0
[395.919054] Subtest linear-8bpp-rotate-0: SUCCESS (1.245s)
[396.106471] [088/133] (622s left) sysfs_timeslice_duration (invalid)
[396.176531] Starting subtest: invalid
[396.178572] Starting dynamic subtest: vecs0
[396.180469] Dynamic subtest vecs0: SUCCESS (0.000s)
[396.190620] Starting dynamic subtest: ccs0
[396.192467] Dynamic subtest ccs0: SUCCESS (0.000s)
[396.200772] Starting dynamic subtest: vcs0
[396.202559] Dynamic subtest vcs0: SUCCESS (0.000s)
[396.210893] Starting dynamic subtest: bcs0
[396.212685] Dynamic subtest bcs0: SUCCESS (0.000s)
[396.221122] Starting dynamic subtest: rcs0
[396.222858] Dynamic subtest rcs0: SUCCESS (0.000s)
[396.231428] Starting dynamic subtest: vcs1
[396.233285] Dynamic subtest vcs1: SUCCESS (0.000s)
[396.234893] Subtest invalid: SUCCESS (0.006s)
[396.316177] [089/133] (622s left) gem_userptr_blits (probe)
[396.389125] Starting subtest: probe
[396.466577] Subtest probe: SUCCESS (0.077s)
[396.621841] [090/133] (622s left) kms_chamelium_color (ctm-negative)
[396.728197] Subtest ctm-negative: SKIP (0.000s)
[396.773009] [091/133] (621s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[396.869230] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[396.872846] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[397.991192] [092/133] (620s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[398.092744] Starting subtest: fbcpsr-rgb565-draw-render
[405.151993] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.062s)
[405.321250] [093/133] (613s left) gem_exec_schedule (smoketest)
[405.501727] Starting subtest: smoketest
[405.503927] Starting dynamic subtest: rcs0
[411.048964] Dynamic subtest rcs0: SUCCESS (5.494s)
[411.065193] Starting dynamic subtest: bcs0
[416.571923] Dynamic subtest bcs0: SUCCESS (5.527s)
[416.582826] Starting dynamic subtest: vcs0
[422.067062] Dynamic subtest vcs0: SUCCESS (5.494s)
[422.078033] Starting dynamic subtest: vcs1
[427.581169] Dynamic subtest vcs1: SUCCESS (5.510s)
[427.592250] Starting dynamic subtest: vecs0
[433.086304] Dynamic subtest vecs0: SUCCESS (5.505s)
[433.098090] Starting dynamic subtest: ccs0
[438.590893] Dynamic subtest ccs0: SUCCESS (5.505s)
[438.593209] Subtest smoketest: SUCCESS (33.042s)
[438.834346] [094/133] (579s left) kms_async_flips (invalid-async-flip)
[438.937064] Starting subtest: invalid-async-flip
[439.310900] Starting dynamic subtest: pipe-A-eDP-1
[440.118285] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.808s)
[440.474398] Starting dynamic subtest: pipe-B-eDP-1
[441.246030] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.779s)
[441.615251] Starting dynamic subtest: pipe-C-eDP-1
[442.377336] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.769s)
[442.738334] Starting dynamic subtest: pipe-D-eDP-1
[443.510432] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.780s)
[443.512822] Subtest invalid-async-flip: SUCCESS (4.576s)
[444.692216] [095/133] (574s left) kms_pm_dc (dc6-dpms)
[445.800040] Starting subtest: dc6-dpms
[447.846307] Subtest dc6-dpms: SUCCESS (2.045s)
[447.949812] [096/133] (570s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[448.010583] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[448.117084] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.105s)
[448.216070] [097/133] (570s left) gem_exec_reloc (basic-write-read-noreloc)
[448.283404] Subtest basic-write-read-noreloc: SKIP (0.000s)
[448.366006] [098/133] (570s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[448.461030] Starting subtest: disable-crc-after-crtc
[448.462923] Starting dynamic subtest: pipe-A-eDP-1
[450.140448] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.681s)
[450.151252] Starting dynamic subtest: pipe-B-eDP-1
[452.409552] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.265s)
[452.419207] Starting dynamic subtest: pipe-C-eDP-1
[454.644716] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.234s)
[454.655157] Starting dynamic subtest: pipe-D-eDP-1
[456.906093] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.258s)
[456.908044] Subtest disable-crc-after-crtc: SUCCESS (8.445s)
[457.758121] [099/133] (561s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[457.855205] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[457.857606] Starting dynamic subtest: pipe-A-default-mode
[458.987864] Dynamic subtest pipe-A-default-mode: SKIP (1.131s)
[458.992113] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.133s)
[459.169792] [100/133] (559s left) gem_eio (in-flight-immediate)
[459.412352] Starting subtest: in-flight-immediate
[469.675343] Subtest in-flight-immediate: SUCCESS (10.264s)
[469.883476] [101/133] (549s left) gem_exec_reloc (basic-cpu-wc-active)
[469.953635] Subtest basic-cpu-wc-active: SKIP (0.000s)
[470.033485] [102/133] (549s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[470.148104] Starting subtest: cursorA-vs-flipA-varying-size
[481.314642] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.166s)
[482.210695] [103/133] (536s left) kms_frontbuffer_tracking (fbcpsr-argb161616f-draw-mmap-gtt)
[482.325464] Starting subtest: fbcpsr-argb161616f-draw-mmap-gtt
[482.329701] Subtest fbcpsr-argb161616f-draw-mmap-gtt: SKIP (0.000s)
[482.449296] [104/133] (536s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[487.486941] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[487.489524] Starting dynamic subtest: pipe-A-eDP-1
[488.260779] Dynamic subtest pipe-A-eDP-1: SKIP (0.771s)
[488.270417] Starting dynamic subtest: pipe-B-eDP-1
[489.392029] Dynamic subtest pipe-B-eDP-1: SKIP (1.129s)
[489.396115] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.904s)
[490.605173] [105/133] (528s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[490.711902] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[498.138974] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.423s)
[498.283584] [106/133] (521s left) kms_content_protection (suspend-resume)
[498.426208] Starting subtest: suspend-resume
[498.430749] Subtest suspend-resume: SKIP (0.000s)
[498.564633] [107/133] (520s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[498.677485] Starting subtest: flip-vs-cursor-atomic-transitions
[506.222239] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.545s)
[507.125446] [108/133] (512s left) kms_psr (fbc-psr2-cursor-render)
[507.221041] Starting subtest: fbc-psr2-cursor-render
[507.223310] Starting dynamic subtest: eDP-1
[507.227598] Dynamic subtest eDP-1: SKIP (0.000s)
[507.231870] Subtest fbc-psr2-cursor-render: SKIP (0.001s)
[507.317992] [109/133] (512s left) perf (stress-open-close)
[507.427740] Starting subtest: stress-open-close
[507.430057] Starting dynamic subtest: 0-rcs0
[509.592470] Dynamic subtest 0-rcs0: SUCCESS (2.165s)
[509.602020] Starting dynamic subtest: 1-vcs1
[511.757895] Dynamic subtest 1-vcs1: SUCCESS (2.164s)
[511.759735] Subtest stress-open-close: SUCCESS (4.331s)
[511.801206] [110/133] (507s left) gem_basic (multigpu-create-close)
[511.861346] Starting subtest: multigpu-create-close
[511.865061] Subtest multigpu-create-close: SKIP (0.000s)
[511.999493] [111/133] (507s left) kms_flip (2x-modeset-vs-vblank-race)
[512.116091] Starting subtest: 2x-modeset-vs-vblank-race
[512.126178] Subtest 2x-modeset-vs-vblank-race: SKIP (0.011s)
[512.228935] [112/133] (507s left) kms_chamelium_hpd (vga-hpd-fast)
[512.613399] Subtest vga-hpd-fast: SKIP (0.000s)
[513.402091] [113/133] (506s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[513.501305] Starting subtest: fbc-psr2-primary-mmap-gtt
[513.503753] Starting dynamic subtest: eDP-1
[513.508329] Dynamic subtest eDP-1: SKIP (0.000s)
[513.512944] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s)
[513.602759] [114/133] (506s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[513.700228] Starting subtest: primary-4-tiled-reflect-x-180
[520.911518] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.211s)
[522.128720] [115/133] (497s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[522.185779] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[522.188072] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[522.314191] [116/133] (497s left) i915_pm_freq_api (freq-reset)
[522.394063] Starting subtest: freq-reset
[522.396449] Starting dynamic subtest: gt0
[522.592752] Dynamic subtest gt0: SUCCESS (0.197s)
[522.602625] Starting dynamic subtest: gt1
[522.766810] Dynamic subtest gt1: SUCCESS (0.172s)
[522.769743] Subtest freq-reset: SUCCESS (0.372s)
[522.868269] [117/133] (496s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[522.977087] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[522.981466] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[523.133185] [118/133] (496s left) prime_self_import (basic-with_one_bo)
[523.172586] Starting subtest: basic-with_one_bo
[523.194590] Subtest basic-with_one_bo: SUCCESS (0.025s)
[523.318045] [119/133] (496s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[523.425697] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[523.428102] Starting dynamic subtest: pipe-A
[523.447536] Dynamic subtest pipe-A: SKIP (0.019s)
[523.459086] Starting dynamic subtest: pipe-B
[523.482208] Dynamic subtest pipe-B: SKIP (0.033s)
[523.492138] Starting dynamic subtest: pipe-C
[523.514767] Dynamic subtest pipe-C: SKIP (0.033s)
[523.524139] Starting dynamic subtest: pipe-D
[523.550286] Dynamic subtest pipe-D: SKIP (0.035s)
[523.553911] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.122s)
[523.667060] [120/133] (496s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[523.779680] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[531.248239] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.471s)
[531.430178] [121/133] (488s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[531.502527] Starting subtest: multi-wait-for-submit-available-submitted
[531.504922] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s)
[531.637930] [122/133] (488s left) kms_atomic_interruptible (universal-setplane-cursor)
[531.735999] Starting subtest: universal-setplane-cursor
[531.738344] Starting dynamic subtest: pipe-A-eDP-1
[539.116532] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.379s)
[539.118741] Subtest universal-setplane-cursor: SUCCESS (7.380s)
[539.992589] [123/133] (480s left) perf_pmu (busy-accuracy-50)
[540.036845] Starting subtest: busy-accuracy-50
[540.039210] Starting dynamic subtest: rcs0
[541.573270] Dynamic subtest rcs0: SUCCESS (1.534s)
[541.585914] Starting dynamic subtest: bcs0
[543.109802] Dynamic subtest bcs0: SUCCESS (1.534s)
[543.122490] Starting dynamic subtest: vcs0
[544.658164] Dynamic subtest vcs0: SUCCESS (1.546s)
[544.670327] Starting dynamic subtest: vcs1
[546.199463] Dynamic subtest vcs1: SUCCESS (1.539s)
[546.212126] Starting dynamic subtest: vecs0
[547.740957] Dynamic subtest vecs0: SUCCESS (1.539s)
[547.753077] Starting dynamic subtest: ccs0
[549.286732] Dynamic subtest ccs0: SUCCESS (1.543s)
[549.289623] Subtest busy-accuracy-50: SUCCESS (9.248s)
[549.447729] [124/133] (470s left) gem_exec_schedule (preempt-queue-chain)
[549.539802] Subtest preempt-queue-chain: SKIP (0.000s)
[549.856389] [125/133] (470s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[549.984766] Starting subtest: basic-busy-flip-before-cursor-atomic
[549.989309] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[550.167319] [126/133] (469s left) gem_readwrite (read-write)
[550.226248] Subtest read-write: SKIP (0.000s)
[550.294540] [127/133] (469s left) kms_vblank (ts-continuation-idle)
[550.404535] Starting subtest: ts-continuation-idle
[550.406803] Starting dynamic subtest: pipe-A-eDP-1
[550.800988] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.396s)
[550.817289] Starting dynamic subtest: pipe-D-eDP-1
[551.856552] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.052s)
[551.858469] Subtest ts-continuation-idle: SUCCESS (1.453s)
[552.761798] [128/133] (467s left) kms_psr (psr2-sprite-plane-move)
[552.861763] Starting subtest: psr2-sprite-plane-move
[552.864018] Starting dynamic subtest: eDP-1
[554.555459] Dynamic subtest eDP-1: SUCCESS (1.693s)
[554.557766] Subtest psr2-sprite-plane-move: SUCCESS (1.694s)
[555.420881] [129/133] (464s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[555.491398] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[555.584175] [130/133] (464s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[555.674087] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[555.676393] Starting dynamic subtest: pipe-A-eDP-1
[555.696077] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[555.706100] Starting dynamic subtest: pipe-B-eDP-1
[555.725376] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[555.736847] Starting dynamic subtest: pipe-C-eDP-1
[555.755570] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[555.764807] Starting dynamic subtest: pipe-D-eDP-1
[555.783911] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[555.785832] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[557.977183] [131/133] (462s left) gem_pxp (create-regular-context-2)
[558.079558] Starting subtest: create-regular-context-2
[558.081629] Subtest create-regular-context-2: SUCCESS (0.001s)
[558.250307] [132/133] (462s left) kms_frontbuffer_tracking (fbc-abgr161616f-draw-render)
[558.348037] Starting subtest: fbc-abgr161616f-draw-render
[558.352140] Subtest fbc-abgr161616f-draw-render: SKIP (0.000s)
[558.478807] [133/133] (462s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[558.594516] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[565.150927] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.559s)
[565.286836] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_balancer
results: parsing output: 1/ for test: gem_pxp
results: parsing output: 2/ for test: gem_ctx_param
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: gem_eio
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: gem_exec_reloc
results: parsing output: 7/ for test: prime_mmap
results: parsing output: 8/ for test: kms_ccs
results: parsing output: 9/ for test: prime_mmap
results: parsing output: 10/ for test: kms_dp_link_training
results: parsing output: 11/ for test: gem_mmap_gtt
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: gem_exec_fence
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: gem_lmem_swapping
results: parsing output: 16/ for test: gem_render_copy
results: parsing output: 17/ for test: gem_exec_fence
results: parsing output: 18/ for test: syncobj_timeline
results: parsing output: 19/ for test: kms_cursor_crc
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_exec_balancer
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: gem_eio
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: kms_pipe_stress
results: parsing output: 26/ for test: kms_plane_scaling
results: parsing output: 27/ for test: gem_mmap_gtt
results: parsing output: 28/ for test: gem_ctx_shared
results: parsing output: 29/ for test: api_intel_bb
results: parsing output: 30/ for test: i915_drm_fdinfo
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_color_pipeline
results: parsing output: 33/ for test: kms_cursor_crc
results: parsing output: 34/ for test: api_intel_allocator
results: parsing output: 35/ for test: testdisplay
results: parsing output: 36/ for test: kms_cursor_legacy
results: parsing output: 37/ for test: gem_ctx_param
results: parsing output: 38/ for test: gen9_exec_parse
results: parsing output: 39/ for test: kms_flip_scaled_crc
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_psr
results: parsing output: 44/ for test: gem_exec_store
results: parsing output: 45/ for test: kms_cursor_edge_walk
results: parsing output: 46/ for test: gem_mmap_gtt
results: parsing output: 47/ for test: kms_rmfb
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: perf
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_flip
results: parsing output: 52/ for test: i915_pm_rpm
results: parsing output: 53/ for test: kms_chamelium_edid
results: parsing output: 54/ for test: gem_ctx_exec
results: parsing output: 55/ for test: kms_async_flips
results: parsing output: 56/ for test: kms_invalid_mode
results: parsing output: 57/ for test: gem_mmap_gtt
results: parsing output: 58/ for test: kms_vblank
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: kms_psr2_sf
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: syncobj_wait
results: parsing output: 65/ for test: gem_spin_batch
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_lease
results: parsing output: 69/ for test: kms_atomic_interruptible
results: parsing output: 70/ for test: syncobj_basic
results: parsing output: 71/ for test: kms_ccs
results: parsing output: 72/ for test: gem_create
results: parsing output: 73/ for test: kms_feature_discovery
results: parsing output: 74/ for test: gem_ctx_engines
results: parsing output: 75/ for test: kms_rotation_crc
results: parsing output: 76/ for test: i915_query
results: parsing output: 77/ for test: dmabuf_sync_file
results: parsing output: 78/ for test: gem_ctx_persistence
results: parsing output: 79/ for test: gem_exec_params
results: parsing output: 80/ for test: kms_pm_rpm
results: parsing output: 81/ for test: kms_flip
results: parsing output: 82/ for test: kms_psr2_sf
results: parsing output: 83/ for test: kms_flip
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: sysfs_timeslice_duration
results: parsing output: 88/ for test: gem_userptr_blits
results: parsing output: 89/ for test: kms_chamelium_color
results: parsing output: 90/ for test: kms_ccs
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: gem_exec_schedule
results: parsing output: 93/ for test: kms_async_flips
results: parsing output: 94/ for test: kms_pm_dc
results: parsing output: 95/ for test: syncobj_timeline
results: parsing output: 96/ for test: gem_exec_reloc
results: parsing output: 97/ for test: kms_pipe_crc_basic
results: parsing output: 98/ for test: kms_flip_scaled_crc
results: parsing output: 99/ for test: gem_eio
results: parsing output: 100/ for test: gem_exec_reloc
results: parsing output: 101/ for test: kms_cursor_legacy
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_psr2_sf
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_content_protection
results: parsing output: 106/ for test: kms_cursor_legacy
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: perf
results: parsing output: 109/ for test: gem_basic
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: kms_chamelium_hpd
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: kms_rotation_crc
results: parsing output: 114/ for test: syncobj_timeline
results: parsing output: 115/ for test: i915_pm_freq_api
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: prime_self_import
results: parsing output: 118/ for test: kms_plane_scaling
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: kms_atomic_interruptible
results: parsing output: 122/ for test: perf_pmu
results: parsing output: 123/ for test: gem_exec_schedule
results: parsing output: 124/ for test: kms_cursor_legacy
results: parsing output: 125/ for test: gem_readwrite
results: parsing output: 126/ for test: kms_vblank
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: gem_exec_reloc
results: parsing output: 129/ for test: kms_ccs
results: parsing output: 130/ for test: gem_pxp
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.