[42.304148] Initializing watchdogs
[42.304204]   /dev/watchdog0
[42.310549] [001/139] (960s left) kms_ccs (pipe-a-crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[42.652435] Starting subtest: pipe-A-crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[42.657397] Subtest pipe-A-crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.001s)
[43.580664] [002/139] (959s left) kms_ccs (pipe-b-bad-rotation-90-y-tiled-gen12-rc-ccs)
[43.948179] Starting subtest: pipe-B-bad-rotation-90-y-tiled-gen12-rc-ccs
[43.954204] Subtest pipe-B-bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[44.790533] [003/139] (958s left) perf (oa-exponents)
[44.921796] Starting subtest: oa-exponents
[44.924265] Starting dynamic subtest: 0-rcs0
[46.727660] Dynamic subtest 0-rcs0: SUCCESS (1.806s)
[46.735545] Starting dynamic subtest: 1-vcs0
[48.560126] Dynamic subtest 1-vcs0: SUCCESS (1.832s)
[48.563360] Subtest oa-exponents: SUCCESS (3.638s)
[48.587143] [004/139] (954s left) kms_invalid_mode (zero-vdisplay)
[48.642092] Starting subtest: zero-vdisplay
[48.644484] Starting dynamic subtest: pipe-A-eDP-1
[48.928227] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[48.939621] Starting dynamic subtest: pipe-B-eDP-1
[48.942114] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[48.952711] Starting dynamic subtest: pipe-C-eDP-1
[48.955294] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[48.965225] Starting dynamic subtest: pipe-D-eDP-1
[48.967835] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[48.970476] Subtest zero-vdisplay: SUCCESS (0.297s)
[49.846904] [005/139] (953s left) kms_chamelium_hpd (hdmi-hpd-fast)
[50.212049] Subtest hdmi-hpd-fast: SKIP (0.000s)
[51.099178] [006/139] (951s left) gem_exec_fence (syncobj-unused-fence)
[51.578834] Starting subtest: syncobj-unused-fence
[51.585654] Subtest syncobj-unused-fence: SUCCESS (0.007s)
[53.518658] [007/139] (949s left) gem_softpin (evict-snoop)
[53.577436] Starting subtest: evict-snoop
[53.582116] Subtest evict-snoop: SKIP (0.000s)
[53.639244] [008/139] (949s left) gem_tiled_fence_blits (normal)
[53.703584] Subtest normal: SKIP (0.000s)
[53.728787] [009/139] (949s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[53.794464] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[53.798419] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[53.869483] [010/139] (949s left) syncobj_wait (invalid-wait-zero-handles)
[53.921036] Starting subtest: invalid-wait-zero-handles
[53.923266] Subtest invalid-wait-zero-handles: SUCCESS (0.000s)
[53.970675] [011/139] (949s left) kms_vrr (flip-suspend)
[54.054686] Starting subtest: flip-suspend
[54.058871] Subtest flip-suspend: SKIP (0.000s)
[54.113997] [012/139] (948s left) syncobj_timeline (wait-all-delayed-signal)
[54.180608] Starting subtest: wait-all-delayed-signal
[54.282207] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[54.348326] [013/139] (948s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[54.403886] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[54.503321] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.102s)
[54.566441] [014/139] (948s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[54.658989] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[59.200218] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (4.545s)
[59.324724] [015/139] (943s left) kms_ccs (pipe-b-missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[59.745679] Starting subtest: pipe-B-missing-ccs-buffer-y-tiled-gen12-mc-ccs
[59.750905] Subtest pipe-B-missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[60.604339] [016/139] (942s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[60.663350] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[60.668123] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[60.740755] [017/139] (942s left) vc4/vc4_purgeable_bo (access-purged-bo-mem)
[60.805027] Subtest access-purged-bo-mem: SKIP (0.000s)
[60.847547] [018/139] (942s left) kms_cursor_edge_walk (64x64-right-edge)
[60.930224] Starting subtest: 64x64-right-edge
[60.932665] Starting dynamic subtest: pipe-A-eDP-1
[64.441652] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.509s)
[64.453215] Starting dynamic subtest: pipe-D-eDP-1
[67.689775] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.246s)
[67.692290] Subtest 64x64-right-edge: SUCCESS (6.758s)
[68.601254] [019/139] (934s left) i915_pipe_stress (stress-xrgb8888-ytiled)
[68.673633] Starting subtest: stress-xrgb8888-ytiled
[68.678365] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[68.697145] [020/139] (934s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[68.772268] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[68.776617] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[68.855536] [021/139] (934s left) kms_cursor_crc (cursor-offscreen-max-size)
[69.113762] Starting subtest: cursor-offscreen-max-size
[69.120739] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[69.221276] [022/139] (934s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-cpu)
[69.296050] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-cpu
[72.184040] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (2.891s)
[72.295668] [023/139] (931s left) v3d/v3d_create_bo (create-bo-zeroed)
[72.357741] Subtest create-bo-zeroed: SKIP (0.000s)
[72.396669] [024/139] (930s left) perf_pmu (busy-start)
[72.448796] Starting subtest: busy-start
[72.450912] Starting dynamic subtest: rcs0
[74.995913] Dynamic subtest rcs0: SUCCESS (2.549s)
[75.008328] Starting dynamic subtest: bcs0
[77.545257] Dynamic subtest bcs0: SUCCESS (2.549s)
[77.558229] Starting dynamic subtest: vcs0
[81.476875] Dynamic subtest vcs0: SUCCESS (3.930s)
[81.489203] Starting dynamic subtest: vcs1
[85.443889] Dynamic subtest vcs1: SUCCESS (3.967s)
[85.456299] Starting dynamic subtest: vecs0
[89.476077] Dynamic subtest vecs0: SUCCESS (4.032s)
[89.488337] Starting dynamic subtest: ccs0
[92.043460] Dynamic subtest ccs0: SUCCESS (2.548s)
[92.046071] Subtest busy-start: SUCCESS (19.577s)
[92.094420] [025/139] (911s left) perf (buffer-fill)
[92.174505] Starting subtest: buffer-fill
[92.176952] Starting dynamic subtest: 0-rcs0
[94.306517] Dynamic subtest 0-rcs0: SUCCESS (2.130s)
[94.315187] Starting dynamic subtest: 1-vcs0
[98.501413] Dynamic subtest 1-vcs0: SUCCESS (4.195s)
[98.504148] Subtest buffer-fill: SUCCESS (6.325s)
[98.533462] [026/139] (904s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[98.618085] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[103.426532] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (4.811s)
[103.539494] [027/139] (899s left) kms_ccs (pipe-a-bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[103.903423] Starting subtest: pipe-A-bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[103.908687] Subtest pipe-A-bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[104.828166] [028/139] (898s left) perf (per-context-mode-unprivileged)
[104.933866] Starting subtest: per-context-mode-unprivileged
[104.940688] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[104.957732] [029/139] (898s left) prime_busy (hang-wait)
[105.019537] Starting subtest: hang-wait
[105.021867] Starting dynamic subtest: rcs0
[119.015970] Dynamic subtest rcs0: SUCCESS (13.994s)
[119.028711] Starting dynamic subtest: bcs0
[126.111227] Dynamic subtest bcs0: SUCCESS (7.096s)
[126.123211] Starting dynamic subtest: vcs0
[133.149942] Dynamic subtest vcs0: SUCCESS (7.038s)
[133.162957] Starting dynamic subtest: vcs1
[140.122734] Dynamic subtest vcs1: SUCCESS (6.975s)
[140.135594] Starting dynamic subtest: vecs0
[147.162413] Dynamic subtest vecs0: SUCCESS (7.037s)
[147.175574] Starting dynamic subtest: ccs0
[160.936559] Dynamic subtest ccs0: SUCCESS (13.772s)
[160.939205] Subtest hang-wait: SUCCESS (55.915s)
[161.039658] [030/139] (842s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[161.101443] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[161.106322] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[161.175208] [031/139] (842s left) syncobj_timeline (invalid-signal-illegal-handle)
[161.224437] Starting subtest: invalid-signal-illegal-handle
[161.226775] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[161.286064] [032/139] (842s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[161.342047] Subtest writes-after-reads-uncached: SKIP (0.000s)
[161.394039] [033/139] (842s left) syncobj_timeline (device-submit-unordered)
[161.448486] Starting subtest: device-submit-unordered
[161.450955] Subtest device-submit-unordered: SUCCESS (0.001s)
[161.504765] [034/139] (842s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[161.580996] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[166.690828] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (5.114s)
[166.816216] [035/139] (836s left) vc4/vc4_tiling (get-bad-modifier)
[166.877281] Subtest get-bad-modifier: SKIP (0.000s)
[166.925366] [036/139] (836s left) gem_exec_schedule (preempt-queue-contexts-chain)
[167.008306] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[167.285895] [037/139] (836s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[167.345987] Starting subtest: 4-tiled-16bpp-rotate-180
[168.653298] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.311s)
[168.762917] [038/139] (834s left) gem_reg_read (timestamp-moving)
[168.828264] Starting subtest: timestamp-moving
[169.827597] Subtest timestamp-moving: SUCCESS (1.001s)
[169.892830] [039/139] (833s left) kms_ccs (pipe-d-missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[170.297989] Starting subtest: pipe-D-missing-ccs-buffer-y-tiled-gen12-rc-ccs
[170.303307] Subtest pipe-D-missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[171.130309] [040/139] (832s left) gem_exec_reloc (basic-range-active)
[171.191044] Subtest basic-range-active: SKIP (0.000s)
[171.249546] [041/139] (832s left) gem_mmap_gtt (coherency)
[171.303468] Subtest coherency: SKIP (0.000s)
[171.326864] [042/139] (832s left) kms_ccs (pipe-c-missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[171.714922] Starting subtest: pipe-C-missing-ccs-buffer-4-tiled-mtl-mc-ccs
[171.750126] Subtest pipe-C-missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.036s)
[172.547865] [043/139] (831s left) kms_content_protection (srm)
[172.651128] Starting subtest: srm
[176.215710] Subtest srm: SKIP (3.558s)
[177.465703] [044/139] (826s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[177.552478] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[177.555225] Starting dynamic subtest: pipe-A-default-mode
[177.843657] Dynamic subtest pipe-A-default-mode: SKIP (0.288s)
[177.849203] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.289s)
[178.744946] [045/139] (825s left) gem_exec_whisper (basic-fds-forked)
[178.800518] Starting subtest: basic-fds-forked
[204.565150] Subtest basic-fds-forked: SUCCESS (25.763s)
[204.740408] [046/139] (799s left) api_intel_bb (simple-bb)
[204.788406] Starting subtest: simple-bb
[204.796618] Subtest simple-bb: SUCCESS (0.010s)
[204.894147] [047/139] (799s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[204.964525] Starting subtest: psr-shrfb-scaledprimary
[208.816918] Subtest psr-shrfb-scaledprimary: SUCCESS (3.856s)
[208.920477] [048/139] (795s left) kms_ccs (pipe-a-bad-aux-stride-y-tiled-ccs)
[209.280801] Starting subtest: pipe-A-bad-aux-stride-y-tiled-ccs
[209.286343] Subtest pipe-A-bad-aux-stride-y-tiled-ccs: SKIP (0.000s)
[210.166271] [049/139] (793s left) kms_vblank (query-busy-hang)
[210.249615] Starting subtest: query-busy-hang
[210.252049] Starting dynamic subtest: pipe-A-eDP-1
[224.258554] Dynamic subtest pipe-A-eDP-1: SUCCESS (14.007s)
[224.276722] Starting dynamic subtest: pipe-D-eDP-1
[249.291848] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.029s)
[249.294327] Subtest query-busy-hang: SUCCESS (39.044s)
[250.170546] [050/139] (753s left) kms_ccs (pipe-d-bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[250.564898] Starting subtest: pipe-D-bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[250.567754] Subtest pipe-D-bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.000s)
[251.398323] [051/139] (752s left) gem_exec_balancer (indices)
[251.444981] Starting subtest: indices
[253.409790] Subtest indices: SUCCESS (1.965s)
[253.653731] [052/139] (750s left) kms_chamelium_edid (vga-edid-read)
[254.022976] Subtest vga-edid-read: SKIP (0.000s)
[254.877679] [053/139] (749s left) kms_color (ctm-0-50)
[254.958182] Starting subtest: ctm-0-50
[254.960296] Starting dynamic subtest: pipe-A
[258.643977] Dynamic subtest pipe-A: SUCCESS (3.688s)
[258.657880] Starting dynamic subtest: pipe-B
[263.093772] Dynamic subtest pipe-B: SUCCESS (4.446s)
[263.105797] Starting dynamic subtest: pipe-C
[267.387779] Dynamic subtest pipe-C: SUCCESS (4.296s)
[267.401141] Starting dynamic subtest: pipe-D
[271.714205] Dynamic subtest pipe-D: SUCCESS (4.323s)
[271.716898] Subtest ctm-0-50: SUCCESS (16.756s)
[272.637546] [054/139] (731s left) syncobj_wait (invalid-wait-bad-flags)
[272.690034] Starting subtest: invalid-wait-bad-flags
[272.692546] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[272.750215] [055/139] (731s left) kms_ccs (pipe-c-crc-primary-rotation-180-yf-tiled-ccs)
[273.159508] Starting subtest: pipe-C-crc-primary-rotation-180-yf-tiled-ccs
[273.165166] Subtest pipe-C-crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.000s)
[273.982583] [056/139] (730s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[274.051478] Starting subtest: nonblocking-crc-frame-sequence
[274.053946] Starting dynamic subtest: pipe-A-eDP-1
[274.830767] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.777s)
[274.844331] Starting dynamic subtest: pipe-B-eDP-1
[276.365955] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.532s)
[276.377845] Starting dynamic subtest: pipe-C-eDP-1
[277.834936] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.464s)
[277.850788] Starting dynamic subtest: pipe-D-eDP-1
[279.298088] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.460s)
[279.300901] Subtest nonblocking-crc-frame-sequence: SUCCESS (5.245s)
[280.188661] [057/139] (723s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[280.282208] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[280.286937] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[280.356589] [058/139] (723s left) gem_mmap_gtt (bad-object)
[280.414233] Subtest bad-object: SKIP (0.000s)
[280.440806] [059/139] (723s left) gem_ctx_persistence (process)
[280.513329] Starting subtest: process
[280.611088] Subtest process: SUCCESS (0.099s)
[280.698676] [060/139] (723s left) kms_draw_crc (draw-method-blt)
[280.785872] Starting subtest: draw-method-blt
[280.788150] Starting dynamic subtest: xrgb8888-untiled
[281.087230] Dynamic subtest xrgb8888-untiled: SUCCESS (0.302s)
[281.101434] Starting dynamic subtest: rgb565-untiled
[281.318679] Dynamic subtest rgb565-untiled: SUCCESS (0.233s)
[281.331511] Starting dynamic subtest: xrgb2101010-untiled
[281.551102] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.232s)
[281.558463] Starting dynamic subtest: xrgb8888-xtiled
[281.664574] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.110s)
[281.678722] Starting dynamic subtest: rgb565-xtiled
[281.788820] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s)
[281.797215] Starting dynamic subtest: xrgb2101010-xtiled
[281.884452] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.098s)
[281.892461] Starting dynamic subtest: xrgb8888-4tiled
[281.996598] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.110s)
[282.009592] Starting dynamic subtest: rgb565-4tiled
[282.118379] Dynamic subtest rgb565-4tiled: SUCCESS (0.121s)
[282.133377] Starting dynamic subtest: xrgb2101010-4tiled
[282.218082] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.099s)
[282.220310] Subtest draw-method-blt: SUCCESS (1.436s)
[282.315417] [061/139] (721s left) kms_ccs (pipe-a-random-ccs-data-y-tiled-gen12-rc-ccs)
[282.679265] Starting subtest: pipe-A-random-ccs-data-y-tiled-gen12-rc-ccs
[282.687450] Subtest pipe-A-random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[283.572200] [062/139] (720s left) dumb_buffer (map-invalid-size)
[283.626156] Starting subtest: map-invalid-size
[283.628719] Subtest map-invalid-size: SUCCESS (0.000s)
[283.713769] [063/139] (720s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[283.792794] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[283.797948] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[283.876817] [064/139] (720s left) api_intel_allocator (standalone)
[283.927833] Starting subtest: standalone
[283.953406] Subtest standalone: SUCCESS (0.027s)
[284.049049] [065/139] (720s left) gem_flink_basic (double-flink)
[284.092806] Starting subtest: double-flink
[284.094904] Subtest double-flink: SUCCESS (0.000s)
[284.181078] [066/139] (720s left) gem_userptr_blits (readonly-pwrite-unsync)
[284.252251] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[284.371619] [067/139] (720s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[284.413507] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[284.417613] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[284.587416] [068/139] (719s left) template (b)
[284.630136] Starting subtest: B
[284.633304] Subtest B: SUCCESS (0.000s)
[284.683968] [069/139] (719s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[284.749813] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[285.850963] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.100s)
[285.988247] [070/139] (718s left) kms_flip (blocking-absolute-wf_vblank)
[286.046394] Starting subtest: blocking-absolute-wf_vblank
[286.048844] Starting dynamic subtest: A-eDP1
[294.939325] Dynamic subtest A-eDP1: SUCCESS (8.856s)
[294.953468] Starting dynamic subtest: B-eDP1
[303.725274] Dynamic subtest B-eDP1: SUCCESS (8.822s)
[303.739776] Starting dynamic subtest: C-eDP1
[312.544487] Dynamic subtest C-eDP1: SUCCESS (8.817s)
[312.562286] Starting dynamic subtest: D-eDP1
[321.423201] Dynamic subtest D-eDP1: SUCCESS (8.830s)
[321.425868] Subtest blocking-absolute-wf_vblank: SUCCESS (35.341s)
[322.620819] [071/139] (681s left) kms_plane_scaling (planes-downscale-factor-0-25-upscale-20x20)
[322.675167] Starting subtest: planes-downscale-factor-0-25-upscale-20x20
[322.677769] Starting dynamic subtest: pipe-A-eDP-1
[322.687345] Dynamic subtest pipe-A-eDP-1: SKIP (0.007s)
[322.700485] Starting dynamic subtest: pipe-B-eDP-1
[322.705540] Dynamic subtest pipe-B-eDP-1: SKIP (0.016s)
[322.718031] Starting dynamic subtest: pipe-C-eDP-1
[322.723294] Dynamic subtest pipe-C-eDP-1: SKIP (0.016s)
[322.734427] Starting dynamic subtest: pipe-D-eDP-1
[322.738981] Dynamic subtest pipe-D-eDP-1: SKIP (0.018s)
[322.743249] Subtest planes-downscale-factor-0-25-upscale-20x20: SKIP (0.061s)
[322.835763] [072/139] (681s left) kms_legacy_colorkey (invalid-plane)
[322.909325] Starting subtest: invalid-plane
[322.912108] Starting dynamic subtest: zero-id
[322.914778] Dynamic subtest zero-id: SUCCESS (0.000s)
[322.923103] Starting dynamic subtest: outrange-id
[322.925308] Dynamic subtest outrange-id: SUCCESS (0.000s)
[322.927519] Subtest invalid-plane: SUCCESS (0.001s)
[322.974474] [073/139] (681s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[323.063223] Starting subtest: y-tiled-16bpp-rotate-270
[323.067622] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[323.143294] [074/139] (681s left) gem_exec_schedule (pi-distinct-iova)
[323.320941] Starting subtest: pi-distinct-iova
[323.323079] Starting dynamic subtest: rcs0
[323.413495] Dynamic subtest rcs0: SUCCESS (0.095s)
[323.419279] Starting dynamic subtest: vcs0
[323.506413] Dynamic subtest vcs0: SUCCESS (0.091s)
[323.519955] Starting dynamic subtest: vcs1
[323.572313] Dynamic subtest vcs1: SUCCESS (0.065s)
[323.578634] Starting dynamic subtest: vecs0
[323.647621] Dynamic subtest vecs0: SUCCESS (0.074s)
[323.654711] Starting dynamic subtest: ccs0
[323.720057] Dynamic subtest ccs0: SUCCESS (0.071s)
[323.722590] Subtest pi-distinct-iova: SUCCESS (0.402s)
[325.517889] [075/139] (679s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[325.601018] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[325.603408] Starting dynamic subtest: pipe-A-eDP-1
[330.410894] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.810s)
[330.427764] Starting dynamic subtest: pipe-B-eDP-1
[336.223654] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.810s)
[336.232242] Starting dynamic subtest: pipe-C-eDP-1
[337.580095] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.353s)
[337.597072] Starting dynamic subtest: pipe-D-eDP-1
[338.946636] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.363s)
[338.949430] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (13.346s)
[340.224531] [076/139] (664s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[340.321199] Starting subtest: flip-vs-cursor-busy-crc-atomic
[341.167970] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.848s)
[342.078747] [077/139] (662s left) kms_addfb_basic (invalid-set-prop-any)
[342.140588] Starting subtest: invalid-set-prop-any
[342.142983] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[342.255924] [078/139] (662s left) kms_big_fb (linear-16bpp-rotate-90)
[342.321852] Starting subtest: linear-16bpp-rotate-90
[342.353539] Subtest linear-16bpp-rotate-90: SKIP (0.035s)
[342.445190] [079/139] (662s left) gem_render_copy_redux (normal)
[342.509102] Starting subtest: normal
[342.904159] Subtest normal: SUCCESS (0.397s)
[342.992260] [080/139] (661s left) v3d/v3d_submit_cl (bad-perfmon)
[343.061402] Subtest bad-perfmon: SKIP (0.000s)
[343.097707] [081/139] (661s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[343.155271] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[343.159307] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[343.255282] [082/139] (661s left) kms_ccs (pipe-c-bad-rotation-90-y-tiled-ccs)
[343.655696] Starting subtest: pipe-C-bad-rotation-90-y-tiled-ccs
[343.661358] Subtest pipe-C-bad-rotation-90-y-tiled-ccs: SKIP (0.000s)
[344.508458] [083/139] (660s left) gem_ctx_isolation (preservation-s3)
[344.581724] Starting subtest: preservation-S3
[344.584492] Starting dynamic subtest: rcs0
[361.814336] Dynamic subtest rcs0: SUCCESS (1.237s)
[361.829661] Starting dynamic subtest: bcs0
[377.906697] Dynamic subtest bcs0: SUCCESS (1.334s)
[377.921469] Starting dynamic subtest: vcs0
[393.915759] Dynamic subtest vcs0: SUCCESS (2.421s)
[393.931164] Starting dynamic subtest: vcs1
[411.908631] Dynamic subtest vcs1: SUCCESS (4.993s)
[411.921829] Starting dynamic subtest: vecs0
[429.897650] Dynamic subtest vecs0: SUCCESS (4.989s)
[429.912530] Starting dynamic subtest: ccs0
[447.893524] Dynamic subtest ccs0: SUCCESS (3.154s)
[447.896335] Subtest preservation-S3: SUCCESS (18.132s)
[449.298201] [084/139] (640s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[449.372237] Starting subtest: yf-tiled-8bpp-rotate-270
[449.376185] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[449.464191] [085/139] (640s left) gem_tiled_partial_pwrite_pread (reads)
[449.534604] Subtest reads: SKIP (0.000s)
[449.567924] [086/139] (640s left) gem_ctx_sseu (invalid-args)
[449.612220] Subtest invalid-args: SKIP (0.000s)
[449.631633] [087/139] (640s left) kms_rotation_crc (bad-tiling)
[449.680935] Starting subtest: bad-tiling
[449.684897] Subtest bad-tiling: SKIP (0.001s)
[449.730528] [088/139] (640s left) gen7_exec_parse (cmd-crossing-page)
[449.788294] Subtest cmd-crossing-page: SKIP (0.000s)
[449.820894] [089/139] (640s left) kms_psr (suspend)
[449.869449] Starting subtest: suspend
[468.267553] Subtest suspend: SUCCESS (2.944s)
[469.146304] [090/139] (636s left) kms_ccs (pipe-d-crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[469.570983] Starting subtest: pipe-D-crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[469.577235] Subtest pipe-D-crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[470.395004] [091/139] (635s left) gem_ctx_persistence (heartbeat-hostile)
[470.452608] Starting subtest: heartbeat-hostile
[470.457421] Subtest heartbeat-hostile: SKIP (0.000s)
[470.534434] [092/139] (635s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[470.594493] Starting subtest: 2x-flip-vs-modeset-vs-hang
[470.605861] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.013s)
[470.686008] [093/139] (635s left) gem_eio (wait-immediate)
[470.934601] Starting subtest: wait-immediate
[471.336741] Subtest wait-immediate: SUCCESS (0.401s)
[471.459965] [094/139] (634s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[471.524273] Starting subtest: plane-upscale-20x20-with-modifiers
[471.526426] Starting dynamic subtest: pipe-A-eDP-1
[472.128534] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.606s)
[472.146194] Starting dynamic subtest: pipe-B-eDP-1
[473.850915] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.715s)
[473.866945] Starting dynamic subtest: pipe-C-eDP-1
[475.542054] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.692s)
[475.554328] Starting dynamic subtest: pipe-D-eDP-1
[477.249332] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.705s)
[477.251791] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (5.728s)
[478.484285] [095/139] (627s left) kms_prime (d3hot)
[479.071795] Subtest D3hot: SKIP (0.000s)
[479.155672] [096/139] (626s left) gem_partial_pwrite_pread (write-display)
[479.224319] Subtest write-display: SKIP (0.000s)
[479.263999] [097/139] (626s left) kms_ccs (pipe-b-crc-primary-basic-yf-tiled-ccs)
[479.634725] Starting subtest: pipe-B-crc-primary-basic-yf-tiled-ccs
[479.640488] Subtest pipe-B-crc-primary-basic-yf-tiled-ccs: SKIP (0.000s)
[480.532026] [098/139] (625s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[480.613709] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[480.618106] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[480.699669] [099/139] (625s left) gen7_exec_parse (chained-batch)
[480.750580] Subtest chained-batch: SKIP (0.000s)
[480.780286] [100/139] (625s left) gem_pread (self)
[480.834874] Subtest self: SKIP (0.000s)
[480.886364] [101/139] (625s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[480.976088] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[486.247602] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (5.276s)
[486.364585] [102/139] (619s left) kms_ccs (pipe-c-bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[486.747177] Starting subtest: pipe-C-bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[486.752166] Subtest pipe-C-bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[487.643239] [103/139] (618s left) i915_suspend (fence-restore-tiled2untiled)
[487.707021] Starting subtest: fence-restore-tiled2untiled
[487.711776] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[487.774146] [104/139] (618s left) kms_ccs (pipe-d-bad-rotation-90-yf-tiled-ccs)
[488.169488] Starting subtest: pipe-D-bad-rotation-90-yf-tiled-ccs
[488.175383] Subtest pipe-D-bad-rotation-90-yf-tiled-ccs: SKIP (0.000s)
[489.050946] [105/139] (616s left) syncobj_wait (reset-signaled)
[489.096267] Starting subtest: reset-signaled
[489.098753] Subtest reset-signaled: SUCCESS (0.000s)
[489.147340] [106/139] (616s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[489.230752] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[489.235386] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[489.320581] [107/139] (616s left) kms_pm_rpm (modeset-lpsp)
[500.882379] Starting subtest: modeset-lpsp
[505.481741] Subtest modeset-lpsp: SUCCESS (4.598s)
[505.564687] [108/139] (600s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[505.654941] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[505.659630] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[505.742510] [109/139] (600s left) gem_exec_whisper (basic-queues)
[505.809124] Starting subtest: basic-queues
[513.129786] Subtest basic-queues: SUCCESS (7.321s)
[513.311027] [110/139] (592s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[513.404499] Starting subtest: x-tiled-8bpp-rotate-90
[513.423112] Subtest x-tiled-8bpp-rotate-90: SKIP (0.019s)
[513.518617] [111/139] (592s left) gem_pxp (verify-pxp-stale-buf-execution)
[516.147751] Subtest verify-pxp-stale-buf-execution: SKIP (0.000s)
[516.176768] [112/139] (590s left) gem_exec_fence (submit3)
[516.376519] Starting subtest: submit3
[516.382090] Subtest submit3: SKIP (0.000s)
[518.181508] [113/139] (588s left) drm_fdinfo (all-busy-idle-check-all)
[518.244837] Starting subtest: all-busy-idle-check-all
[518.252901] Subtest all-busy-idle-check-all: SKIP (0.006s)
[518.318360] [114/139] (588s left) gem_close_race (multigpu-basic-threads)
[518.429479] Starting subtest: multigpu-basic-threads
[518.434558] Subtest multigpu-basic-threads: SKIP (0.000s)
[518.637947] [115/139] (587s left) kms_async_flips (test-time-stamp)
[518.696976] Starting subtest: test-time-stamp
[519.068964] Starting dynamic subtest: pipe-A-eDP-1
[519.910775] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.838s)
[520.304324] Starting dynamic subtest: pipe-B-eDP-1
[521.159471] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.868s)
[521.536302] Starting dynamic subtest: pipe-C-eDP-1
[522.372870] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.846s)
[522.758691] Starting dynamic subtest: pipe-D-eDP-1
[523.653912] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.905s)
[523.656644] Subtest test-time-stamp: SUCCESS (4.956s)
[524.951163] [116/139] (581s left) gem_spin_batch (engines)
[525.012152] Starting subtest: engines
[525.014603] Starting dynamic subtest: rcs0
[528.249936] Dynamic subtest rcs0: SUCCESS (3.233s)
[528.266406] Starting dynamic subtest: bcs0
[531.487254] Dynamic subtest bcs0: SUCCESS (3.236s)
[531.504816] Starting dynamic subtest: vcs0
[534.777881] Dynamic subtest vcs0: SUCCESS (3.238s)
[534.794366] Starting dynamic subtest: vcs1
[538.019286] Dynamic subtest vcs1: SUCCESS (3.238s)
[538.035863] Starting dynamic subtest: vecs0
[541.205872] Dynamic subtest vecs0: SUCCESS (3.237s)
[541.222299] Starting dynamic subtest: ccs0
[544.498340] Dynamic subtest ccs0: SUCCESS (3.238s)
[544.502060] Subtest engines: SUCCESS (19.430s)
[544.656496] [117/139] (561s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[544.698062] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[544.724940] [118/139] (561s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[544.829586] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[544.833872] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[544.915814] [119/139] (561s left) syncobj_wait (invalid-single-wait-unsubmitted)
[544.964754] Starting subtest: invalid-single-wait-unsubmitted
[544.966870] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[545.031414] [120/139] (561s left) gem_exec_fair (basic-none-vip)
[545.102247] Subtest basic-none-vip: SKIP (0.000s)
[545.154683] [121/139] (561s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[545.259965] Starting subtest: 2x-cursor-vs-flip-legacy
[545.267343] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.004s)
[545.398756] [122/139] (561s left) i915_pm_rpm (gem-execbuf-stress)
[557.010694] Starting subtest: gem-execbuf-stress
[557.013518] Starting dynamic subtest: smem0
[599.541631] Dynamic subtest smem0: SUCCESS (42.494s)
[599.549707] Starting dynamic subtest: extra-wait-smem0
[678.631406] Dynamic subtest extra-wait-smem0: SUCCESS (79.071s)
[678.634429] Subtest gem-execbuf-stress: SUCCESS (121.569s)
[678.936788] [123/139] (427s left) syncobj_timeline (invalid-multi-wait-all-available-unsubmitted-submitted-sign
[678.989594] Starting subtest: invalid-multi-wait-all-available-unsubmitted-submitted-signaled
[679.035454] Subtest invalid-multi-wait-all-available-unsubmitted-submitted-signaled: FAIL (0.021s)
[679.072928] [124/139] (427s left) kms_psr (psr2_cursor_plane_onoff)
[679.135434] Starting subtest: psr2_cursor_plane_onoff
[680.938683] Subtest psr2_cursor_plane_onoff: SUCCESS (1.802s)
[681.820128] [125/139] (424s left) sysfs_heartbeat_interval (invalid)
[681.880637] Starting subtest: invalid
[681.883327] Starting dynamic subtest: vecs0
[681.885965] Dynamic subtest vecs0: SUCCESS (0.000s)
[681.895408] Starting dynamic subtest: ccs0
[681.897738] Dynamic subtest ccs0: SUCCESS (0.000s)
[681.904757] Starting dynamic subtest: vcs0
[681.907102] Dynamic subtest vcs0: SUCCESS (0.000s)
[681.914160] Starting dynamic subtest: bcs0
[681.916479] Dynamic subtest bcs0: SUCCESS (0.000s)
[681.923186] Starting dynamic subtest: rcs0
[681.925500] Dynamic subtest rcs0: SUCCESS (0.000s)
[681.932226] Starting dynamic subtest: vcs1
[681.934547] Dynamic subtest vcs1: SUCCESS (0.000s)
[681.936824] Subtest invalid: SUCCESS (0.008s)
[681.952912] [126/139] (424s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[682.016163] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[685.289615] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (3.280s)
[685.421923] [127/139] (421s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[685.520796] Starting subtest: cursorB-vs-flipA-atomic-transitions
[685.524905] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.002s)
[685.660581] [128/139] (421s left) gem_exec_reloc (basic-gtt-wc)
[685.718176] Subtest basic-gtt-wc: SKIP (0.000s)
[685.779458] [129/139] (420s left) kms_addfb_basic (basic)
[685.830834] Starting subtest: basic
[685.832936] Subtest basic: SUCCESS (0.000s)
[685.919813] [130/139] (420s left) v3d/v3d_wait_bo (map-bo-0ns)
[685.994569] Subtest map-bo-0ns: SKIP (0.000s)
[686.044234] [131/139] (420s left) syncobj_timeline (multi-wait-all-available-submitted)
[686.095033] Starting subtest: multi-wait-all-available-submitted
[686.097344] Subtest multi-wait-all-available-submitted: SUCCESS (0.000s)
[686.159893] [132/139] (420s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[686.233334] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[686.236762] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[686.325641] [133/139] (420s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[686.423156] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[686.427785] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.002s)
[686.563966] [134/139] (420s left) kms_getfb (getfb2-handle-closed)
[686.618011] Starting subtest: getfb2-handle-closed
[686.620071] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[686.707329] [135/139] (420s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[686.751879] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[686.791188] [136/139] (420s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[686.829410] Starting subtest: invalid-multi-wait-all-unsubmitted
[686.831551] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[686.892726] [137/139] (420s left) kms_sequence (get-forked-busy)
[686.975469] Starting subtest: get-forked-busy
[686.977806] Starting dynamic subtest: pipe-A-eDP-1
[688.916192] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.938s)
[688.933847] Starting dynamic subtest: pipe-B-eDP-1
[691.617203] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.700s)
[691.636229] Starting dynamic subtest: pipe-C-eDP-1
[694.269582] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.651s)
[694.279602] Starting dynamic subtest: pipe-D-eDP-1
[696.960908] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.687s)
[696.963612] Subtest get-forked-busy: SUCCESS (9.987s)
[697.885098] [138/139] (409s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[697.944433] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[700.760029] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (2.821s)
[700.904778] [139/139] (406s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[700.997496] Starting subtest: cursor-rapid-movement-32x32
[701.030003] Subtest cursor-rapid-movement-32x32: SKIP (0.026s)
[701.290009] Closing watchdogs
Done.