[60.064102] Initializing watchdogs
[60.064151]   /dev/watchdog0
[60.078821] [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]
[60.083303] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.085370] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.087249] [001/133] (960s left) gem_exec_balancer (semaphore)
[60.159189] Starting subtest: semaphore
[61.921736] Subtest semaphore: SUCCESS (1.761s)
[62.264384] [002/133] (958s left) gem_pxp (protected-raw-src-copy-not-readible)
[62.375428] Starting subtest: protected-raw-src-copy-not-readible
[62.441599] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.067s)
[62.582268] [003/133] (958s left) gem_ctx_param (invalid-set-ringsize)
[62.636406] Starting subtest: invalid-set-ringsize
[62.637424] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[62.717159] [004/133] (957s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[62.814991] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[62.817017] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[62.946941] [005/133] (957s left) gem_eio (suspend)
[63.103455] Starting subtest: suspend
[75.295786] Subtest suspend: SUCCESS (12.194s)
[85.440598] [006/133] (945s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[85.544749] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[85.546513] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[85.683084] [007/133] (945s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[85.750397] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[85.834432] [008/133] (944s left) prime_mmap (test_forked_cpu_write)
[85.900083] Starting subtest: test_forked_cpu_write
[85.900954] Starting dynamic subtest: test_forked_cpu_write-smem
[85.906581] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.007s)
[85.907476] Subtest test_forked_cpu_write: SUCCESS (0.008s)
[86.033823] [009/133] (944s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[86.129632] Starting subtest: crc-primary-suspend-y-tiled-ccs
[86.130603] Starting dynamic subtest: pipe-A-eDP-1
[86.134125] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[86.142034] Starting dynamic subtest: pipe-B-eDP-1
[86.145375] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[86.152325] Starting dynamic subtest: pipe-C-eDP-1
[86.156771] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[86.166601] Starting dynamic subtest: pipe-D-eDP-1
[86.169889] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[86.171565] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.003s)
[88.405398] [010/133] (942s left) prime_mmap (test_dup)
[88.467213] Starting subtest: test_dup
[88.468387] Starting dynamic subtest: test_dup-smem
[88.500492] Dynamic subtest test_dup-smem: SUCCESS (0.033s)
[88.501513] Subtest test_dup: SUCCESS (0.034s)
[88.592725] [011/133] (942s left) kms_dp_link_training (non-uhbr-mst)
[88.681298] Starting subtest: non-uhbr-mst
[88.685136] Subtest non-uhbr-mst: SKIP (0.000s)
[88.767434] [012/133] (942s left) gem_mmap_gtt (basic-wc)
[88.825496] Subtest basic-wc: SKIP (0.000s)
[88.886671] [013/133] (942s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[88.974551] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[88.976219] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[89.101658] [014/133] (941s left) gem_exec_fence (syncobj-timeline-repeat)
[89.638653] Starting subtest: syncobj-timeline-repeat
[89.864861] Subtest syncobj-timeline-repeat: SUCCESS (0.226s)
[90.977974] [FACT gem_exec_fence (syncobj-timeline-repeat)] new: kernel.kmod_is_loaded.vgem: true
[90.979909] [015/133] (940s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[91.086834] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[91.088676] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[91.226215] [016/133] (939s left) gem_lmem_swapping (parallel-multi)
[91.259907] Subtest parallel-multi: SKIP (0.000s)
[91.294671] [017/133] (939s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[91.350752] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[91.352548] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[91.549878] [018/133] (939s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[92.074883] Starting subtest: syncobj-timeline-multiple-ext-nodes
[92.076056] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.005s)
[94.028361] [019/133] (937s left) syncobj_timeline (single-wait-all-signaled)
[94.080247] Starting subtest: single-wait-all-signaled
[94.081118] Subtest single-wait-all-signaled: SUCCESS (0.001s)
[94.212861] [020/133] (936s left) kms_cursor_crc (cursor-dpms)
[94.355411] Starting subtest: cursor-dpms
[94.356323] Starting dynamic subtest: pipe-A-eDP-1
[97.368930] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.011s)
[97.376429] Starting dynamic subtest: pipe-D-eDP-1
[100.947920] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.577s)
[100.948972] Subtest cursor-dpms: SUCCESS (6.590s)
[101.803594] [021/133] (929s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[101.898326] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[106.516216] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.618s)
[107.701130] [022/133] (923s left) gem_exec_balancer (nohangcheck)
[107.949326] Starting subtest: nohangcheck
[108.831141] Subtest nohangcheck: SUCCESS (0.879s)
[108.975703] [023/133] (922s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[109.080019] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[109.738430] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.659s)
[109.963097] [024/133] (921s left) gem_eio (wait-10ms)
[110.173248] Starting subtest: wait-10ms
[110.482814] Subtest wait-10ms: SUCCESS (0.310s)
[110.645260] [025/133] (920s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[110.743894] Starting subtest: yf-tiled-8bpp-rotate-270
[110.745803] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[110.874828] [026/133] (920s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[110.958682] Starting subtest: stress-xrgb8888-xtiled
[116.862890] Subtest stress-xrgb8888-xtiled: SUCCESS (5.904s)
[116.905389] [027/133] (914s left) kms_plane_scaling (invalid-num-scalers)
[116.991312] Starting subtest: invalid-num-scalers
[116.992260] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[117.008979] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.017s)
[117.016301] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[117.043176] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.033s)
[117.050550] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[117.076881] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.033s)
[117.083925] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[117.109033] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.031s)
[117.109903] Subtest invalid-num-scalers: SUCCESS (0.119s)
[117.243911] [028/133] (914s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[117.291733] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[117.351830] [029/133] (914s left) gem_ctx_shared (q-independent)
[117.408833] Starting subtest: Q-independent
[117.409817] Starting dynamic subtest: rcs0
[117.480959] Dynamic subtest rcs0: SUCCESS (0.071s)
[117.491218] Starting dynamic subtest: vcs0
[117.522511] Dynamic subtest vcs0: SUCCESS (0.042s)
[117.530920] Starting dynamic subtest: vcs1
[117.566809] Dynamic subtest vcs1: SUCCESS (0.044s)
[117.575686] Starting dynamic subtest: vecs0
[117.607855] Dynamic subtest vecs0: SUCCESS (0.041s)
[117.616199] Starting dynamic subtest: ccs0
[117.659482] Dynamic subtest ccs0: SUCCESS (0.051s)
[117.660518] Subtest Q-independent: SUCCESS (0.250s)
[119.077392] [030/133] (912s left) api_intel_bb (intel-bb-blit-x)
[119.143700] Starting subtest: intel-bb-blit-x
[123.156592] Subtest intel-bb-blit-x: SUCCESS (4.010s)
[123.302318] [031/133] (908s left) i915_drm_fdinfo (memory-info-resident)
[123.342500] Starting subtest: memory-info-resident
[123.343418] Starting dynamic subtest: smem0
[126.042561] Dynamic subtest smem0: SUCCESS (2.699s)
[126.044229] Subtest memory-info-resident: SUCCESS (2.700s)
[126.132570] [032/133] (905s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[126.231740] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[126.233592] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[126.361719] [033/133] (905s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[126.446361] Starting subtest: plane-lut1d-ctm3x4-lut1d
[126.461227] Starting dynamic subtest: pipe-A-eDP-1
[126.900798] Dynamic subtest pipe-A-eDP-1: FAIL (0.303s)
[127.848803] Starting dynamic subtest: pipe-B-eDP-1
[128.331727] Dynamic subtest pipe-B-eDP-1: FAIL (0.291s)
[129.181454] Starting dynamic subtest: pipe-C-eDP-1
[129.651459] Dynamic subtest pipe-C-eDP-1: FAIL (0.256s)
[130.507795] Starting dynamic subtest: pipe-D-eDP-1
[130.951213] Dynamic subtest pipe-D-eDP-1: FAIL (0.236s)
[131.027271] Subtest plane-lut1d-ctm3x4-lut1d: FAIL (4.582s)
[131.899685] [034/133] (899s left) kms_cursor_crc (cursor-random-32x32)
[132.048112] Starting subtest: cursor-random-32x32
[132.088579] Subtest cursor-random-32x32: SKIP (0.039s)
[132.396624] [035/133] (899s left) api_intel_allocator (reopen)
[132.455081] Starting subtest: reopen
[132.457630] Subtest reopen: SUCCESS (0.004s)
[132.612400] [036/133] (899s left) testdisplay
[132.946564] [037/133] (898s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[133.063897] Starting subtest: basic-busy-flip-before-cursor-legacy
[133.065631] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[133.225168] [038/133] (898s left) gem_ctx_param (root-set)
[133.273430] Starting subtest: root-set
[133.274429] Subtest root-set: SUCCESS (0.001s)
[133.407999] [039/133] (898s left) gen9_exec_parse (batch-without-end)
[133.465714] Subtest batch-without-end: SKIP (0.000s)
[133.524266] [040/133] (898s left) kms_flip_scaled_crc (flip-nv12-linear-to-nv12-linear-reflect-x)
[133.615193] Starting subtest: flip-NV12-linear-to-NV12-linear-reflect-x
[133.616096] Starting dynamic subtest: pipe-A-default-mode
[134.745863] Dynamic subtest pipe-A-default-mode: SKIP (1.128s)
[134.747687] Subtest flip-NV12-linear-to-NV12-linear-reflect-x: SKIP (1.130s)
[134.926447] [041/133] (896s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[135.026949] Starting subtest: psr-rgb565-draw-pwrite
[141.949871] Subtest psr-rgb565-draw-pwrite: SUCCESS (6.923s)
[142.095777] [042/133] (889s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[142.195728] Starting subtest: x-tiled-32bpp-rotate-90
[142.214034] Subtest x-tiled-32bpp-rotate-90: SKIP (0.018s)
[142.361361] [043/133] (889s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[142.452937] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[142.454842] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[142.576158] [044/133] (889s left) kms_psr (pr-basic)
[142.669440] Starting subtest: pr-basic
[142.671283] Subtest pr-basic: SKIP (0.000s)
[142.768746] [045/133] (889s left) gem_exec_store (dword)
[142.831941] Starting subtest: dword
[142.833033] Starting dynamic subtest: rcs0
[142.933031] Dynamic subtest rcs0: SUCCESS (0.100s)
[142.944421] Starting dynamic subtest: bcs0
[142.977505] Dynamic subtest bcs0: SUCCESS (0.043s)
[142.986915] Starting dynamic subtest: vcs0
[143.018788] Dynamic subtest vcs0: SUCCESS (0.040s)
[143.028184] Starting dynamic subtest: vcs1
[143.060130] Dynamic subtest vcs1: SUCCESS (0.040s)
[143.069598] Starting dynamic subtest: vecs0
[143.101891] Dynamic subtest vecs0: SUCCESS (0.040s)
[143.111183] Starting dynamic subtest: ccs0
[143.143070] Dynamic subtest ccs0: SUCCESS (0.040s)
[143.144225] Subtest dword: SUCCESS (0.312s)
[143.342838] [046/133] (888s left) kms_cursor_edge_walk (64x64-right-edge)
[143.433895] Starting subtest: 64x64-right-edge
[143.434837] Starting dynamic subtest: pipe-A-eDP-1
[146.904836] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.469s)
[146.912549] Starting dynamic subtest: pipe-D-eDP-1
[150.019784] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.114s)
[150.020719] Subtest 64x64-right-edge: SUCCESS (6.585s)
[150.849470] [047/133] (881s left) gem_mmap_gtt (pf-nonblock)
[150.904867] Subtest pf-nonblock: SKIP (0.000s)
[150.972627] [048/133] (881s left) kms_rmfb (close-fd)
[151.053189] Starting subtest: close-fd
[151.054496] Starting dynamic subtest: pipe-A-eDP-1
[151.161885] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s)
[151.169958] Starting dynamic subtest: pipe-B-eDP-1
[152.290147] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.129s)
[152.298370] Starting dynamic subtest: pipe-C-eDP-1
[153.406428] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.114s)
[153.413752] Starting dynamic subtest: pipe-D-eDP-1
[154.537176] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.130s)
[154.538057] Subtest close-fd: SUCCESS (3.484s)
[155.768197] [049/133] (876s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[155.864156] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[155.864986] Starting dynamic subtest: pipe-A-eDP-1
[155.872747] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.003s)
[155.880067] Starting dynamic subtest: pipe-B-eDP-1
[155.887945] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[155.894985] Starting dynamic subtest: pipe-C-eDP-1
[155.902990] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[155.909702] Starting dynamic subtest: pipe-D-eDP-1
[155.917323] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[155.918218] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.014s)
[158.034843] [050/133] (874s left) perf (non-zero-reason)
[158.169178] Starting subtest: non-zero-reason
[158.170076] Starting dynamic subtest: 0-rcs0
[163.580898] Dynamic subtest 0-rcs0: SUCCESS (5.409s)
[163.591772] Starting dynamic subtest: 1-vecs0
[167.493077] Dynamic subtest 1-vecs0: SUCCESS (3.911s)
[167.494663] Subtest non-zero-reason: SUCCESS (9.322s)
[167.526839] [051/133] (864s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[167.616728] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[167.618389] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[167.739303] [052/133] (864s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[167.839175] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[167.851058] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.011s)
[167.946921] [053/133] (864s left) i915_pm_rpm (gem-execbuf-stress)
[170.080850] Starting subtest: gem-execbuf-stress
[170.082111] Starting dynamic subtest: smem0
[182.784505] Dynamic subtest smem0: SUCCESS (12.707s)
[182.796559] Starting dynamic subtest: extra-wait-smem0
[244.865879] Dynamic subtest extra-wait-smem0: SUCCESS (62.076s)
[244.867381] Subtest gem-execbuf-stress: SUCCESS (74.789s)
[245.265246] [054/133] (787s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[245.657987] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[246.444852] [055/133] (785s left) gem_ctx_exec (basic)
[246.498402] Starting subtest: basic
[246.507352] Subtest basic: SUCCESS (0.009s)
[246.653467] [056/133] (785s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[246.742567] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[247.121761] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[249.846589] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.722s)
[249.855772] Starting dynamic subtest: pipe-A-eDP-1-4
[252.022441] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.174s)
[252.032393] Starting dynamic subtest: pipe-A-eDP-1-4
[254.032294] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[254.042459] Starting dynamic subtest: pipe-A-eDP-1-x
[256.222241] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.189s)
[256.583848] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[259.381910] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.801s)
[259.392555] Starting dynamic subtest: pipe-B-eDP-1-4
[261.568128] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.186s)
[261.578417] Starting dynamic subtest: pipe-B-eDP-1-4
[263.578426] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[263.588390] Starting dynamic subtest: pipe-B-eDP-1-x
[265.780047] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.201s)
[266.143508] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[268.912096] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.772s)
[268.921927] Starting dynamic subtest: pipe-C-eDP-1-4
[271.087687] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s)
[271.097181] Starting dynamic subtest: pipe-C-eDP-1-4
[273.097858] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[273.107119] Starting dynamic subtest: pipe-C-eDP-1-x
[275.265591] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.167s)
[275.630051] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[278.358527] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.737s)
[278.369648] Starting dynamic subtest: pipe-D-eDP-1-4
[280.533013] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[280.546228] Starting dynamic subtest: pipe-D-eDP-1-4
[282.543289] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[282.553059] Starting dynamic subtest: pipe-D-eDP-1-x
[284.722519] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[284.723703] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (37.975s)
[285.954694] [057/133] (746s left) kms_invalid_mode (bad-vsync-end)
[286.040050] Starting subtest: bad-vsync-end
[286.040947] Starting dynamic subtest: pipe-A-eDP-1
[286.321749] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.282s)
[286.329217] Starting dynamic subtest: pipe-B-eDP-1
[286.330205] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[286.336851] Starting dynamic subtest: pipe-C-eDP-1
[286.337925] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[286.344671] Starting dynamic subtest: pipe-D-eDP-1
[286.345729] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[286.346725] Subtest bad-vsync-end: SUCCESS (0.288s)
[287.180833] [058/133] (745s left) gem_mmap_gtt (basic)
[287.240696] Subtest basic: SKIP (0.000s)
[287.297923] [059/133] (745s left) kms_vblank (crtc-id)
[287.388220] Starting subtest: crtc-id
[287.389087] Starting dynamic subtest: pipe-A-eDP-1
[287.841724] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.453s)
[287.852320] Starting dynamic subtest: pipe-D-eDP-1
[288.985055] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.140s)
[288.986039] Subtest crtc-id: SUCCESS (1.597s)
[289.848344] [060/133] (742s left) kms_frontbuffer_tracking (psr-abgr161616f-draw-render)
[289.944608] Starting subtest: psr-abgr161616f-draw-render
[289.946324] Subtest psr-abgr161616f-draw-render: SKIP (0.000s)
[290.084128] [061/133] (742s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[290.185979] Starting subtest: 4-tiled-32bpp-rotate-180
[291.664931] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.479s)
[291.865053] [062/133] (740s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[296.930167] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[296.933100] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.002s)
[297.801575] [063/133] (734s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[297.853133] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[297.962048] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.106s)
[298.052803] [064/133] (734s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[298.147760] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[298.149582] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[298.282397] [065/133] (734s left) syncobj_wait (reset-signaled)
[298.342038] Starting subtest: reset-signaled
[298.343103] Subtest reset-signaled: SUCCESS (0.000s)
[298.473508] [066/133] (734s left) gem_spin_batch (resubmit-new)
[298.527648] Starting subtest: resubmit-new
[298.528807] Starting dynamic subtest: rcs0
[298.536672] Dynamic subtest rcs0: SUCCESS (0.009s)
[298.545480] Starting dynamic subtest: bcs0
[298.546406] Dynamic subtest bcs0: SUCCESS (0.005s)
[298.553796] Starting dynamic subtest: vcs0
[298.554801] Dynamic subtest vcs0: SUCCESS (0.006s)
[298.562067] Starting dynamic subtest: vcs1
[298.562960] Dynamic subtest vcs1: SUCCESS (0.004s)
[298.569990] Starting dynamic subtest: vecs0
[298.571019] Dynamic subtest vecs0: SUCCESS (0.004s)
[298.577892] Starting dynamic subtest: ccs0
[298.578812] Dynamic subtest ccs0: SUCCESS (0.006s)
[298.579742] Subtest resubmit-new: SUCCESS (0.037s)
[299.979914] [067/133] (732s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[300.070677] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[300.072407] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[300.200997] [068/133] (732s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[300.301506] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[322.998516] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.697s)
[323.164243] [069/133] (709s left) kms_lease (lease-get)
[323.271320] Starting subtest: lease-get
[323.272204] Starting dynamic subtest: pipe-A-eDP-1
[323.273082] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[323.283722] Starting dynamic subtest: pipe-B-eDP-1
[323.284686] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[323.291949] Starting dynamic subtest: pipe-C-eDP-1
[323.292817] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[323.299978] Starting dynamic subtest: pipe-D-eDP-1
[323.300868] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[323.301781] Subtest lease-get: SUCCESS (0.012s)
[323.425222] [070/133] (709s left) kms_atomic_interruptible (legacy-pageflip)
[323.517432] Starting subtest: legacy-pageflip
[323.518359] Starting dynamic subtest: pipe-A-eDP-1
[330.941961] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.423s)
[330.942841] Subtest legacy-pageflip: SUCCESS (7.424s)
[331.807995] [071/133] (701s left) syncobj_basic (create-signaled)
[331.866044] Starting subtest: create-signaled
[331.867548] Subtest create-signaled: SUCCESS (0.000s)
[331.977913] [072/133] (700s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[332.114387] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[332.115350] Starting dynamic subtest: pipe-A-eDP-1
[332.123850] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[332.131471] Starting dynamic subtest: pipe-B-eDP-1
[332.140286] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[332.149249] Starting dynamic subtest: pipe-C-eDP-1
[332.157731] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[332.165887] Starting dynamic subtest: pipe-D-eDP-1
[332.174776] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[332.176541] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[334.287901] [073/133] (698s left) gem_create (create-invalid-size)
[334.339784] Starting subtest: create-invalid-size
[334.340711] Subtest create-invalid-size: SUCCESS (0.000s)
[334.541264] [074/133] (698s left) kms_feature_discovery (psr2)
[334.639216] Starting subtest: psr2
[334.640172] Subtest psr2: SUCCESS (0.000s)
[334.729973] [075/133] (698s left) gem_ctx_engines (invalid-engines)
[334.797393] Starting subtest: invalid-engines
[334.805052] Subtest invalid-engines: SUCCESS (0.009s)
[335.064649] [076/133] (697s left) kms_rotation_crc (primary-rotation-270)
[335.155545] Starting subtest: primary-rotation-270
[335.157397] Subtest primary-rotation-270: SKIP (0.001s)
[335.245772] [077/133] (697s left) i915_query (query-regions-unallocated)
[335.299872] Starting subtest: query-regions-unallocated
[335.300838] Subtest query-regions-unallocated: SUCCESS (0.000s)
[335.432446] [078/133] (697s left) dmabuf_sync_file (export-multiwait)
[335.476061] Starting subtest: export-multiwait
[335.477053] Subtest export-multiwait: SUCCESS (0.000s)
[335.556586] [079/133] (697s left) gem_ctx_persistence (legacy-engines-hostile)
[335.624516] Starting subtest: legacy-engines-hostile
[335.625424] Starting dynamic subtest: render
[335.801368] Dynamic subtest render: SUCCESS (0.177s)
[335.813489] Starting dynamic subtest: bsd1
[335.925426] Dynamic subtest bsd1: SUCCESS (0.122s)
[335.937110] Starting dynamic subtest: bsd2
[336.053438] Dynamic subtest bsd2: SUCCESS (0.125s)
[336.064590] Starting dynamic subtest: blt
[336.170478] Dynamic subtest blt: SUCCESS (0.114s)
[336.181934] Starting dynamic subtest: vebox
[336.288689] Dynamic subtest vebox: SUCCESS (0.115s)
[336.290063] Subtest legacy-engines-hostile: SUCCESS (0.666s)
[336.389550] [080/133] (696s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[336.460537] Starting subtest: invalid-bsd2-flag-on-vebox
[336.461461] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[336.596018] [081/133] (696s left) kms_pm_rpm (fences-dpms)
[338.126413] Starting subtest: fences-dpms
[338.129133] Subtest fences-dpms: SKIP (0.000s)
[338.928355] [082/133] (694s left) kms_flip (blocking-wf_vblank)
[339.026267] Starting subtest: blocking-wf_vblank
[339.028549] Starting dynamic subtest: A-eDP1
[347.941484] Dynamic subtest A-eDP1: SUCCESS (8.913s)
[347.952952] Starting dynamic subtest: B-eDP1
[356.874614] Dynamic subtest B-eDP1: SUCCESS (8.930s)
[356.885983] Starting dynamic subtest: C-eDP1
[365.798650] Dynamic subtest C-eDP1: SUCCESS (8.921s)
[365.811752] Starting dynamic subtest: D-eDP1
[374.734723] Dynamic subtest D-eDP1: SUCCESS (8.935s)
[374.737081] Subtest blocking-wf_vblank: SUCCESS (35.711s)
[375.985769] [083/133] (657s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[380.954379] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[380.956848] Starting dynamic subtest: pipe-A-eDP-1
[392.993929] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.038s)
[393.002248] Starting dynamic subtest: pipe-B-eDP-1
[405.032050] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.036s)
[405.034071] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (24.078s)
[405.889669] [084/133] (627s left) kms_flip (2x-flip-vs-fences-interruptible)
[405.984044] Starting subtest: 2x-flip-vs-fences-interruptible
[405.985680] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[406.111011] [085/133] (627s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[406.208366] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[406.210117] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[406.358129] [086/133] (627s left) kms_psr (psr-sprite-plane-onoff)
[406.452304] Starting subtest: psr-sprite-plane-onoff
[406.453145] Starting dynamic subtest: eDP-1
[408.212653] Dynamic subtest eDP-1: SUCCESS (1.760s)
[408.213506] Subtest psr-sprite-plane-onoff: SUCCESS (1.761s)
[409.044141] [087/133] (624s left) kms_big_fb (linear-8bpp-rotate-0)
[409.135851] Starting subtest: linear-8bpp-rotate-0
[410.348817] Subtest linear-8bpp-rotate-0: SUCCESS (1.213s)
[410.513293] [088/133] (622s left) sysfs_timeslice_duration (invalid)
[410.574622] Starting subtest: invalid
[410.575628] Starting dynamic subtest: vecs0
[410.576578] Dynamic subtest vecs0: SUCCESS (0.000s)
[410.584269] Starting dynamic subtest: ccs0
[410.585136] Dynamic subtest ccs0: SUCCESS (0.000s)
[410.592306] Starting dynamic subtest: vcs0
[410.593174] Dynamic subtest vcs0: SUCCESS (0.000s)
[410.600335] Starting dynamic subtest: bcs0
[410.601263] Dynamic subtest bcs0: SUCCESS (0.000s)
[410.608717] Starting dynamic subtest: rcs0
[410.609633] Dynamic subtest rcs0: SUCCESS (0.000s)
[410.616777] Starting dynamic subtest: vcs1
[410.617737] Dynamic subtest vcs1: SUCCESS (0.000s)
[410.618636] Subtest invalid: SUCCESS (0.006s)
[410.717690] [089/133] (622s left) gem_userptr_blits (probe)
[410.792632] Starting subtest: probe
[410.865955] Subtest probe: SUCCESS (0.074s)
[411.010759] [090/133] (622s left) kms_chamelium_color (ctm-negative)
[411.113244] Subtest ctm-negative: SKIP (0.000s)
[411.151666] [091/133] (622s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[411.259563] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[411.261240] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[412.371539] [092/133] (621s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[412.469054] Starting subtest: fbcpsr-rgb565-draw-render
[419.427840] Subtest fbcpsr-rgb565-draw-render: SUCCESS (6.960s)
[419.569973] [093/133] (614s left) gem_exec_schedule (smoketest)
[419.758278] Starting subtest: smoketest
[419.759447] Starting dynamic subtest: rcs0
[425.289850] Dynamic subtest rcs0: SUCCESS (5.506s)
[425.298604] Starting dynamic subtest: bcs0
[430.824087] Dynamic subtest bcs0: SUCCESS (5.533s)
[430.833611] Starting dynamic subtest: vcs0
[436.339113] Dynamic subtest vcs0: SUCCESS (5.515s)
[436.348160] Starting dynamic subtest: vcs1
[441.846715] Dynamic subtest vcs1: SUCCESS (5.508s)
[441.855522] Starting dynamic subtest: vecs0
[447.353926] Dynamic subtest vecs0: SUCCESS (5.503s)
[447.369823] Starting dynamic subtest: ccs0
[452.886055] Dynamic subtest ccs0: SUCCESS (5.531s)
[452.886967] Subtest smoketest: SUCCESS (33.105s)
[453.071266] [094/133] (580s left) kms_async_flips (invalid-async-flip)
[453.171152] Starting subtest: invalid-async-flip
[453.557780] Starting dynamic subtest: pipe-A-eDP-1
[454.418185] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.860s)
[454.777826] Starting dynamic subtest: pipe-B-eDP-1
[455.548290] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.780s)
[455.910436] Starting dynamic subtest: pipe-C-eDP-1
[456.663383] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.759s)
[457.014055] Starting dynamic subtest: pipe-D-eDP-1
[457.797654] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.790s)
[457.798492] Subtest invalid-async-flip: SUCCESS (4.627s)
[458.975266] [095/133] (574s left) kms_pm_dc (dc6-dpms)
[460.069123] Starting subtest: dc6-dpms
[462.141476] Subtest dc6-dpms: SUCCESS (2.070s)
[462.234120] [096/133] (571s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[462.290773] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[462.401422] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.108s)
[462.493912] [097/133] (571s left) gem_exec_reloc (basic-write-read-noreloc)
[462.553587] Subtest basic-write-read-noreloc: SKIP (0.000s)
[462.617423] [098/133] (571s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[462.696454] Starting subtest: disable-crc-after-crtc
[462.697361] Starting dynamic subtest: pipe-A-eDP-1
[464.344424] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.647s)
[464.351955] Starting dynamic subtest: pipe-B-eDP-1
[466.596779] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.251s)
[466.604497] Starting dynamic subtest: pipe-C-eDP-1
[468.856934] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.259s)
[468.867920] Starting dynamic subtest: pipe-D-eDP-1
[471.113475] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.255s)
[471.114315] Subtest disable-crc-after-crtc: SUCCESS (8.417s)
[471.980094] [099/133] (561s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[472.070880] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[472.071837] Starting dynamic subtest: pipe-A-default-mode
[473.216300] Dynamic subtest pipe-A-default-mode: SKIP (1.143s)
[473.217948] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.145s)
[473.394082] [100/133] (560s left) gem_eio (in-flight-immediate)
[473.642030] Starting subtest: in-flight-immediate
[481.991554] Subtest in-flight-immediate: SUCCESS (8.346s)
[482.184670] [101/133] (551s left) gem_exec_reloc (basic-cpu-wc-active)
[482.235387] Subtest basic-cpu-wc-active: SKIP (0.000s)
[482.297328] [102/133] (551s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[482.422975] Starting subtest: cursorA-vs-flipA-varying-size
[493.572676] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.149s)
[494.452991] [103/133] (539s left) kms_frontbuffer_tracking (fbcpsr-argb161616f-draw-mmap-gtt)
[494.551365] Starting subtest: fbcpsr-argb161616f-draw-mmap-gtt
[494.553120] Subtest fbcpsr-argb161616f-draw-mmap-gtt: SKIP (0.000s)
[494.668311] [104/133] (539s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[499.699840] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[499.700914] Starting dynamic subtest: pipe-A-eDP-1
[500.492868] Dynamic subtest pipe-A-eDP-1: SKIP (0.792s)
[500.503849] Starting dynamic subtest: pipe-B-eDP-1
[501.626198] Dynamic subtest pipe-B-eDP-1: SKIP (1.131s)
[501.627887] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.927s)
[502.938221] [105/133] (531s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[503.030596] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[510.464419] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.434s)
[510.632600] [106/133] (523s left) kms_content_protection (suspend-resume)
[510.828181] Starting subtest: suspend-resume
[510.830051] Subtest suspend-resume: SKIP (0.000s)
[510.998382] [107/133] (523s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[511.110413] Starting subtest: flip-vs-cursor-atomic-transitions
[518.683276] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.572s)
[519.575937] [108/133] (514s left) kms_psr (fbc-psr2-cursor-render)
[519.680642] Starting subtest: fbc-psr2-cursor-render
[519.681564] Starting dynamic subtest: eDP-1
[519.683287] Dynamic subtest eDP-1: SKIP (0.000s)
[519.684867] Subtest fbc-psr2-cursor-render: SKIP (0.001s)
[519.773099] [109/133] (514s left) perf (stress-open-close)
[519.867482] Starting subtest: stress-open-close
[519.868580] Starting dynamic subtest: 0-rcs0
[522.034491] Dynamic subtest 0-rcs0: SUCCESS (2.167s)
[522.042615] Starting dynamic subtest: 1-vecs0
[524.197088] Dynamic subtest 1-vecs0: SUCCESS (2.161s)
[524.197963] Subtest stress-open-close: SUCCESS (4.330s)
[524.230936] [110/133] (509s left) gem_basic (multigpu-create-close)
[524.289163] Starting subtest: multigpu-create-close
[524.290855] Subtest multigpu-create-close: SKIP (0.000s)
[524.430495] [111/133] (509s left) kms_flip (2x-modeset-vs-vblank-race)
[524.532839] Starting subtest: 2x-modeset-vs-vblank-race
[524.544414] Subtest 2x-modeset-vs-vblank-race: SKIP (0.011s)
[524.684195] [112/133] (509s left) kms_chamelium_hpd (vga-hpd-fast)
[525.067382] Subtest vga-hpd-fast: SKIP (0.000s)
[525.861474] [113/133] (508s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[525.950324] Starting subtest: fbc-psr2-primary-mmap-gtt
[525.951233] Starting dynamic subtest: eDP-1
[525.952955] Dynamic subtest eDP-1: SKIP (0.000s)
[525.954723] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s)
[526.045017] [114/133] (508s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[526.130490] Starting subtest: primary-4-tiled-reflect-x-180
[533.087767] Subtest primary-4-tiled-reflect-x-180: SUCCESS (6.958s)
[534.274728] [115/133] (500s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[534.329067] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[534.329893] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[534.456584] [116/133] (499s left) i915_pm_freq_api (freq-reset)
[534.511712] Starting subtest: freq-reset
[534.512603] Starting dynamic subtest: gt0
[534.707056] Dynamic subtest gt0: SUCCESS (0.194s)
[534.715629] Starting dynamic subtest: gt1
[534.880216] Dynamic subtest gt1: SUCCESS (0.171s)
[534.881373] Subtest freq-reset: SUCCESS (0.367s)
[534.972551] [117/133] (499s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[535.061063] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[535.062879] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[535.183821] [118/133] (499s left) prime_self_import (basic-with_one_bo)
[535.218471] Starting subtest: basic-with_one_bo
[535.240818] Subtest basic-with_one_bo: SUCCESS (0.023s)
[535.368364] [119/133] (499s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[535.468966] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[535.470039] Starting dynamic subtest: pipe-A
[535.487917] Dynamic subtest pipe-A: SKIP (0.017s)
[535.495705] Starting dynamic subtest: pipe-B
[535.518738] Dynamic subtest pipe-B: SKIP (0.030s)
[535.526504] Starting dynamic subtest: pipe-C
[535.551618] Dynamic subtest pipe-C: SKIP (0.032s)
[535.559115] Starting dynamic subtest: pipe-D
[535.581091] Dynamic subtest pipe-D: SKIP (0.029s)
[535.582788] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.111s)
[535.691576] [120/133] (498s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[535.785774] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[543.233728] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.448s)
[543.387424] [121/133] (491s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[543.441649] Starting subtest: multi-wait-for-submit-available-submitted
[543.442606] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.001s)
[543.570201] [122/133] (491s left) kms_atomic_interruptible (universal-setplane-cursor)
[543.650513] Starting subtest: universal-setplane-cursor
[543.651482] Starting dynamic subtest: pipe-A-eDP-1
[551.114561] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.462s)
[551.115380] Subtest universal-setplane-cursor: SUCCESS (7.464s)
[551.975478] [123/133] (482s left) perf_pmu (busy-accuracy-50)
[552.016045] Starting subtest: busy-accuracy-50
[552.016915] Starting dynamic subtest: rcs0
[553.550271] Dynamic subtest rcs0: SUCCESS (1.532s)
[553.560604] Starting dynamic subtest: bcs0
[555.094296] Dynamic subtest bcs0: SUCCESS (1.542s)
[555.103595] Starting dynamic subtest: vcs0
[556.638432] Dynamic subtest vcs0: SUCCESS (1.541s)
[556.646542] Starting dynamic subtest: vcs1
[558.177718] Dynamic subtest vcs1: SUCCESS (1.537s)
[558.187564] Starting dynamic subtest: vecs0
[559.717811] Dynamic subtest vecs0: SUCCESS (1.537s)
[559.727940] Starting dynamic subtest: ccs0
[561.264928] Dynamic subtest ccs0: SUCCESS (1.545s)
[561.266371] Subtest busy-accuracy-50: SUCCESS (9.248s)
[561.421302] [124/133] (473s left) gem_exec_schedule (preempt-queue-chain)
[561.500842] Subtest preempt-queue-chain: SKIP (0.000s)
[561.818345] [125/133] (472s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[561.954472] Starting subtest: basic-busy-flip-before-cursor-atomic
[561.956192] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[562.122827] [126/133] (472s left) gem_readwrite (read-write)
[562.176948] Subtest read-write: SKIP (0.000s)
[562.239804] [127/133] (472s left) kms_vblank (ts-continuation-idle)
[562.332382] Starting subtest: ts-continuation-idle
[562.333326] Starting dynamic subtest: pipe-A-eDP-1
[562.739883] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.407s)
[562.749943] Starting dynamic subtest: pipe-D-eDP-1
[563.850857] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.109s)
[563.851859] Subtest ts-continuation-idle: SUCCESS (1.520s)
[564.737824] [128/133] (470s left) kms_psr (psr2-sprite-plane-move)
[564.836268] Starting subtest: psr2-sprite-plane-move
[564.837176] Starting dynamic subtest: eDP-1
[566.545799] Dynamic subtest eDP-1: SUCCESS (1.709s)
[566.546809] Subtest psr2-sprite-plane-move: SUCCESS (1.710s)
[567.410137] [129/133] (467s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[567.476854] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[567.552462] [130/133] (467s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[567.655369] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[567.656296] Starting dynamic subtest: pipe-A-eDP-1
[567.664324] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[567.672840] Starting dynamic subtest: pipe-B-eDP-1
[567.680794] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[567.689468] Starting dynamic subtest: pipe-C-eDP-1
[567.697294] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[567.705231] Starting dynamic subtest: pipe-D-eDP-1
[567.713100] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[567.713962] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[569.983107] [131/133] (464s left) gem_pxp (create-regular-context-2)
[570.094678] Starting subtest: create-regular-context-2
[570.095752] Subtest create-regular-context-2: SUCCESS (0.002s)
[570.239170] [132/133] (464s left) kms_frontbuffer_tracking (fbc-abgr161616f-draw-render)
[570.334795] Starting subtest: fbc-abgr161616f-draw-render
[570.336386] Subtest fbc-abgr161616f-draw-render: SKIP (0.000s)
[570.488523] [133/133] (464s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[570.577532] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[577.122907] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.546s)
[577.278292] 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.