[39.608779] Initializing watchdogs
[39.608832]   /dev/watchdog0
[39.614484] [001/142] (960s left) kms_ccs (pipe-d-bad-pixel-format-4_tiled_mtl_rc_ccs_cc)
[41.654087] Starting subtest: pipe-D-bad-pixel-format-4_tiled_mtl_rc_ccs_cc
[41.655698] Subtest pipe-D-bad-pixel-format-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[41.763612] [002/142] (958s left) v3d/v3d_create_bo (create-bo-4096)
[41.835012] Subtest create-bo-4096: SKIP (0.000s)
[41.887582] [003/142] (958s left) perf (invalid-remove-userspace-config)
[42.896251] Starting subtest: invalid-remove-userspace-config
[42.910176] Subtest invalid-remove-userspace-config: SUCCESS (0.013s)
[42.927725] [004/142] (957s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[44.872222] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[44.873796] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[44.949377] [005/142] (955s left) kms_cursor_crc (cursor-offscreen-256x256)
[47.131188] Starting subtest: cursor-offscreen-256x256
[47.135620] Starting dynamic subtest: pipe-A-HDMI-A-3
[49.673820] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.538s)
[49.700551] Starting dynamic subtest: pipe-D-HDMI-A-3
[52.021509] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.322s)
[52.022324] Subtest cursor-offscreen-256x256: SUCCESS (4.887s)
[52.239754] [006/142] (947s left) core_hotunplug (unbind-rebind)
[52.303868] Starting subtest: unbind-rebind
[58.322554] Subtest unbind-rebind: SUCCESS (6.018s)
[58.381999] [007/142] (941s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[60.383095] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[60.384602] Subtest psr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[60.475063] [008/142] (939s left) gem_mmap_gtt (basic)
[60.610076] Subtest basic: SKIP (0.000s)
[60.628596] [009/142] (939s left) gem_exec_fair (basic-none-share)
[60.682524] Subtest basic-none-share: SKIP (0.000s)
[60.728238] [010/142] (939s left) gem_exec_reloc (basic-cpu-wc-active)
[60.781010] Subtest basic-cpu-wc-active: SKIP (0.000s)
[60.828160] [011/142] (939s left) perf (i915-ref-count)
[60.913308] Starting subtest: i915-ref-count
[61.775167] Subtest i915-ref-count: SUCCESS (0.862s)
[61.850471] [012/142] (938s left) gem_exec_balancer (full-late)
[61.901560] Starting subtest: full-late
[63.158332] Subtest full-late: SUCCESS (1.256s)
[63.504982] [013/142] (936s left) gem_exec_schedule (noreorder-corked)
[63.681473] Starting subtest: noreorder-corked
[63.682350] Starting dynamic subtest: rcs0
[64.824191] Dynamic subtest rcs0: SUCCESS (1.151s)
[64.830398] Starting dynamic subtest: bcs0
[65.953436] Dynamic subtest bcs0: SUCCESS (1.126s)
[65.963349] Starting dynamic subtest: vcs0
[67.076183] Dynamic subtest vcs0: SUCCESS (1.126s)
[67.082116] Starting dynamic subtest: vcs1
[68.201095] Dynamic subtest vcs1: SUCCESS (1.125s)
[68.207424] Starting dynamic subtest: vecs0
[69.325104] Dynamic subtest vecs0: SUCCESS (1.124s)
[69.331258] Starting dynamic subtest: vecs1
[70.426089] Dynamic subtest vecs1: SUCCESS (1.101s)
[70.432141] Starting dynamic subtest: ccs0
[71.530067] Dynamic subtest ccs0: SUCCESS (1.104s)
[71.536133] Starting dynamic subtest: ccs1
[72.632289] Dynamic subtest ccs1: SUCCESS (1.102s)
[72.638121] Starting dynamic subtest: ccs2
[73.733194] Dynamic subtest ccs2: SUCCESS (1.101s)
[73.739058] Starting dynamic subtest: ccs3
[74.861494] Dynamic subtest ccs3: SUCCESS (1.128s)
[74.862715] Subtest noreorder-corked: SUCCESS (11.189s)
[75.057262] [014/142] (925s left) gem_spin_batch (user-each)
[75.119290] Starting subtest: user-each
[78.537498] Subtest user-each: SUCCESS (3.417s)
[78.806218] [015/142] (921s left) gem_mmap_gtt (basic-copy)
[78.891136] Subtest basic-copy: SKIP (0.000s)
[78.912331] [016/142] (921s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[80.895659] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[81.017137] [017/142] (919s left) gem_exec_parallel (userptr)
[81.068827] Starting subtest: userptr
[81.069727] Starting dynamic subtest: rcs0
[82.687653] Dynamic subtest rcs0: SUCCESS (1.619s)
[82.695144] Starting dynamic subtest: bcs0
[84.124465] Dynamic subtest bcs0: SUCCESS (1.437s)
[84.131661] Starting dynamic subtest: vcs0
[85.533596] Dynamic subtest vcs0: SUCCESS (1.408s)
[85.557914] Starting dynamic subtest: vcs1
[87.026127] Dynamic subtest vcs1: SUCCESS (1.492s)
[87.051206] Starting dynamic subtest: vecs0
[88.479489] Dynamic subtest vecs0: SUCCESS (1.453s)
[88.486654] Starting dynamic subtest: vecs1
[89.877546] Dynamic subtest vecs1: SUCCESS (1.398s)
[89.884862] Starting dynamic subtest: ccs0
[91.348464] Dynamic subtest ccs0: SUCCESS (1.471s)
[91.355013] Starting dynamic subtest: ccs1
[92.738457] Dynamic subtest ccs1: SUCCESS (1.390s)
[92.745748] Starting dynamic subtest: ccs2
[94.150540] Dynamic subtest ccs2: SUCCESS (1.412s)
[94.157709] Starting dynamic subtest: ccs3
[95.559063] Dynamic subtest ccs3: SUCCESS (1.407s)
[95.561169] Subtest userptr: SUCCESS (14.490s)
[95.816979] [018/142] (904s left) kms_ccs (pipe-c-bad-rotation-90-4_tiled_dg2_mc_ccs)
[97.884239] Starting subtest: pipe-C-bad-rotation-90-4_tiled_dg2_mc_ccs
[99.245950] Subtest pipe-C-bad-rotation-90-4_tiled_dg2_mc_ccs: SUCCESS (1.353s)
[99.434246] [019/142] (901s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[101.407886] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[101.409785] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[101.484305] [020/142] (898s left) syncobj_timeline (wait-all-interrupted)
[101.614391] Starting subtest: wait-all-interrupted
[101.731231] Subtest wait-all-interrupted: SUCCESS (0.108s)
[101.814782] [021/142] (898s left) kms_ccs (pipe-a-bad-pixel-format-4_tiled_mtl_rc_ccs)
[103.764196] Starting subtest: pipe-A-bad-pixel-format-4_tiled_mtl_rc_ccs
[103.765811] Subtest pipe-A-bad-pixel-format-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[103.969725] [022/142] (896s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[105.933447] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[105.935662] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[106.004981] [023/142] (894s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs)
[108.111760] Starting subtest: pipe-C-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs
[108.119340] Subtest pipe-C-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs: SKIP (0.002s)
[108.226388] [024/142] (892s left) kms_dsc (dsc-basic)
[110.175265] Starting subtest: dsc-basic
[110.177069] Subtest dsc-basic: SKIP (0.000s)
[110.224807] [025/142] (890s left) gem_ccs (ctrl-surf-copy)
[110.323676] Starting subtest: ctrl-surf-copy
[110.325302] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0
[110.412142] Dynamic subtest linear-compressed-compfmt0-smem-lmem0: SUCCESS (0.088s)
[110.418407] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0
[110.626482] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.206s)
[110.632851] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0
[110.637206] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0: SUCCESS (0.018s)
[110.643473] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0
[110.835252] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.189s)
[110.841644] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0
[110.845364] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0: SUCCESS (0.018s)
[110.851656] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0
[111.046977] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.193s)
[111.053292] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0
[111.056195] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0: SUCCESS (0.018s)
[111.062470] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0
[111.250989] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.185s)
[111.252629] Subtest ctrl-surf-copy: SUCCESS (0.919s)
[111.378161] [026/142] (889s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[113.331208] Starting subtest: short-flip-after-cursor-toggle
[114.316891] Subtest short-flip-after-cursor-toggle: SUCCESS (0.986s)
[114.458865] [027/142] (886s left) perf (invalid-oa-format-id)
[114.590894] Starting subtest: invalid-oa-format-id
[114.605015] Subtest invalid-oa-format-id: SUCCESS (0.014s)
[114.631991] [028/142] (886s left) kms_ccs (pipe-c-crc-primary-basic-4_tiled_dg2_mc_ccs)
[116.648182] Starting subtest: pipe-C-crc-primary-basic-4_tiled_dg2_mc_ccs
[120.793023] Subtest pipe-C-crc-primary-basic-4_tiled_dg2_mc_ccs: SUCCESS (4.144s)
[120.992630] [029/142] (879s left) kms_prop_blob (invalid-set-prop-any)
[121.040806] Starting subtest: invalid-set-prop-any
[121.041635] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[121.109319] [030/142] (879s left) kms_psr (cursor_plane_onoff)
[121.158524] Subtest cursor_plane_onoff: SKIP (0.000s)
[121.181304] [031/142] (879s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[123.125898] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[125.641617] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (2.517s)
[125.787301] [032/142] (874s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[127.743123] Starting subtest: x-tiled-16bpp-rotate-0
[129.341640] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.598s)
[129.478771] [033/142] (871s left) gen3_mixed_blits
[129.548646] [034/142] (871s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[131.495118] Starting subtest: fbcpsr-tiling-4
[131.496820] Subtest fbcpsr-tiling-4: SKIP (0.000s)
[131.576686] [035/142] (869s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[134.981317] Starting subtest: heavy-verify-multi-ccs
[134.982123] Starting dynamic subtest: lmem0
[145.393027] Dynamic subtest lmem0: SUCCESS (10.377s)
[145.393901] Subtest heavy-verify-multi-ccs: SUCCESS (10.378s)
[147.778946] [036/142] (853s left) api_intel_bb (object-reloc-keep-cache)
[149.304062] Starting subtest: object-reloc-keep-cache
[149.309338] Subtest object-reloc-keep-cache: SKIP (0.006s)
[150.356192] [037/142] (850s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[153.123228] Starting subtest: addfb25-y-tiled-small-legacy
[153.124861] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[153.214677] [038/142] (847s left) kms_flip (absolute-wf_vblank)
[154.300556] Starting subtest: absolute-wf_vblank
[154.305382] Starting dynamic subtest: A-HDMI-A3
[162.026820] Dynamic subtest A-HDMI-A3: SUCCESS (7.717s)
[162.036982] Starting dynamic subtest: B-HDMI-A3
[169.680181] Dynamic subtest B-HDMI-A3: SUCCESS (7.655s)
[169.686341] Starting dynamic subtest: C-HDMI-A3
[177.362451] Dynamic subtest C-HDMI-A3: SUCCESS (7.660s)
[177.372681] Starting dynamic subtest: D-HDMI-A3
[185.016128] Dynamic subtest D-HDMI-A3: SUCCESS (7.673s)
[185.016929] Subtest absolute-wf_vblank: SUCCESS (30.717s)
[185.231649] [039/142] (815s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[187.174270] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[187.175889] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[187.240084] [040/142] (813s left) kms_psr2_su (page_flip-p010)
[187.372868] Subtest page_flip-P010: SKIP (0.000s)
[187.436157] [041/142] (813s left) kms_sequence (get-forked-busy)
[189.416147] Starting subtest: get-forked-busy
[189.416958] Starting dynamic subtest: HDMI-A-3-pipe-A
[191.962219] Dynamic subtest HDMI-A-3-pipe-A: SUCCESS (2.543s)
[191.989468] Starting dynamic subtest: HDMI-A-3-pipe-B
[194.502645] Dynamic subtest HDMI-A-3-pipe-B: SUCCESS (2.527s)
[194.518526] Starting dynamic subtest: HDMI-A-3-pipe-C
[196.974537] Dynamic subtest HDMI-A-3-pipe-C: SUCCESS (2.477s)
[196.999807] Starting dynamic subtest: HDMI-A-3-pipe-D
[199.503700] Dynamic subtest HDMI-A-3-pipe-D: SUCCESS (2.524s)
[199.505209] Subtest get-forked-busy: SUCCESS (10.086s)
[199.663627] [042/142] (801s left) drm_fdinfo (virtual-busy-hang)
[199.744376] Starting subtest: virtual-busy-hang
[199.746534] Subtest virtual-busy-hang: SKIP (0.000s)
[199.840815] [043/142] (801s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[201.831228] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[201.832725] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[201.918547] [044/142] (799s left) kms_vblank (pipe-d-ts-continuation-modeset)
[203.949212] Starting subtest: pipe-D-ts-continuation-modeset
[204.415965] Subtest pipe-D-ts-continuation-modeset: SUCCESS (0.467s)
[204.528713] [045/142] (796s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[206.503329] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[206.504996] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[206.577832] [046/142] (794s left) gen7_exec_parse (oacontrol-tracking)
[206.711645] Subtest oacontrol-tracking: SKIP (0.000s)
[206.737358] [047/142] (794s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[208.689256] Starting subtest: cursorA-vs-flipB-atomic
[208.690919] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[208.740693] [048/142] (792s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[210.728350] Starting subtest: modeset-transition-nonblocking-fencing
[210.729247] Starting dynamic subtest: 1x-outputs
[213.162375] Dynamic subtest 1x-outputs: SUCCESS (2.434s)
[213.219927] Subtest modeset-transition-nonblocking-fencing: SUCCESS (2.491s)
[213.357534] [049/142] (787s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[215.472574] Starting subtest: cursor-rapid-movement-256x85
[215.477067] Starting dynamic subtest: pipe-A-HDMI-A-3
[215.859059] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.382s)
[215.884480] Starting dynamic subtest: pipe-D-HDMI-A-3
[216.148935] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.270s)
[216.149821] Subtest cursor-rapid-movement-256x85: SUCCESS (0.676s)
[216.383247] [050/142] (784s left) kms_cursor_crc (cursor-suspend)
[218.363280] Starting subtest: cursor-suspend
[218.365178] Starting dynamic subtest: pipe-A-HDMI-A-3
[256.936451] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (7.618s)
[256.952965] Starting dynamic subtest: pipe-D-HDMI-A-3
[295.940453] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (7.095s)
[295.941435] Subtest cursor-suspend: SUCCESS (14.718s)
[300.333977] [051/142] (767s left) i915_pm_rc6_residency (rc6-accuracy)
[300.557435] Starting subtest: rc6-accuracy
[303.584012] Subtest rc6-accuracy: SUCCESS (3.001s)
[303.634836] [052/142] (764s left) kms_getfb (getfb2-handle-protection)
[303.681198] Starting subtest: getfb2-handle-protection
[303.690173] Subtest getfb2-handle-protection: SUCCESS (0.009s)
[303.787160] [053/142] (764s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[305.767715] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[305.769296] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[305.856425] [054/142] (762s left) kms_ccs (pipe-b-bad-aux-stride-4_tiled_mtl_rc_ccs_cc)
[307.970802] Starting subtest: pipe-B-bad-aux-stride-4_tiled_mtl_rc_ccs_cc
[307.972635] Subtest pipe-B-bad-aux-stride-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[308.105559] [055/142] (760s left) i915_pm_rpm (gem-execbuf-stress)
[312.435137] Starting subtest: gem-execbuf-stress
[312.437113] Starting dynamic subtest: lmem0
[327.812941] Dynamic subtest lmem0: SUCCESS (15.377s)
[327.825368] Starting dynamic subtest: extra-wait-lmem0
[390.944294] Dynamic subtest extra-wait-lmem0: SUCCESS (63.131s)
[390.952113] Starting dynamic subtest: smem0
[405.314900] Dynamic subtest smem0: SUCCESS (14.370s)
[405.326115] Starting dynamic subtest: extra-wait-smem0
[468.757173] Dynamic subtest extra-wait-smem0: SUCCESS (63.442s)
[468.757886] Subtest gem-execbuf-stress: SUCCESS (156.323s)
[468.947786] [056/142] (599s left) kms_ccs (pipe-d-random-ccs-data-4_tiled_dg2_mc_ccs)
[471.046690] Starting subtest: pipe-D-random-ccs-data-4_tiled_dg2_mc_ccs
[471.565005] Subtest pipe-D-random-ccs-data-4_tiled_dg2_mc_ccs: SUCCESS (0.518s)
[471.709098] [057/142] (596s left) kms_plane (plane-position-hole-dpms)
[473.669144] Starting subtest: plane-position-hole-dpms
[473.670008] Starting dynamic subtest: pipe-A-planes
[475.907525] Dynamic subtest pipe-A-planes: SUCCESS (2.231s)
[475.915597] Starting dynamic subtest: pipe-B-planes
[477.821959] Dynamic subtest pipe-B-planes: SUCCESS (1.920s)
[477.822885] Subtest plane-position-hole-dpms: SUCCESS (4.155s)
[477.949418] [058/142] (590s left) gem_exec_reloc (basic-cpu-read)
[478.025012] Subtest basic-cpu-read: SKIP (0.000s)
[478.072517] [059/142] (590s left) syncobj_timeline (invalid-signal-illegal-handle)
[478.116122] Starting subtest: invalid-signal-illegal-handle
[478.117221] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[478.188816] [060/142] (590s left) syncobj_wait (multi-wait-signaled)
[478.264995] Starting subtest: multi-wait-signaled
[478.265818] Subtest multi-wait-signaled: SUCCESS (0.000s)
[478.329698] [061/142] (589s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[480.272083] Starting subtest: fbcpsr-rgb565-draw-blt
[480.273578] Subtest fbcpsr-rgb565-draw-blt: SKIP (0.000s)
[480.346842] [062/142] (587s left) gem_exec_params (invalid-ring2)
[480.472466] Starting subtest: invalid-ring2
[480.473384] Subtest invalid-ring2: SUCCESS (0.000s)
[480.579324] [063/142] (587s left) perf_pmu (busy-start)
[480.662947] Starting subtest: busy-start
[480.663726] Starting dynamic subtest: rcs0
[483.232354] Dynamic subtest rcs0: SUCCESS (2.566s)
[483.241561] Starting dynamic subtest: bcs0
[485.782431] Dynamic subtest bcs0: SUCCESS (2.546s)
[485.791572] Starting dynamic subtest: vcs0
[488.333345] Dynamic subtest vcs0: SUCCESS (2.547s)
[488.342334] Starting dynamic subtest: vcs1
[490.883432] Dynamic subtest vcs1: SUCCESS (2.546s)
[490.892375] Starting dynamic subtest: vecs0
[493.433651] Dynamic subtest vecs0: SUCCESS (2.546s)
[493.442570] Starting dynamic subtest: vecs1
[495.983460] Dynamic subtest vecs1: SUCCESS (2.546s)
[495.992521] Starting dynamic subtest: ccs0
[498.535699] Dynamic subtest ccs0: SUCCESS (2.547s)
[498.543688] Starting dynamic subtest: ccs1
[501.084389] Dynamic subtest ccs1: SUCCESS (2.546s)
[501.093112] Starting dynamic subtest: ccs2
[503.634066] Dynamic subtest ccs2: SUCCESS (2.546s)
[503.642122] Starting dynamic subtest: ccs3
[506.183441] Dynamic subtest ccs3: SUCCESS (2.546s)
[506.185108] Subtest busy-start: SUCCESS (25.519s)
[506.254197] [064/142] (562s left) drm_read (short-buffer-block)
[508.260877] Starting subtest: short-buffer-block
[508.261802] Subtest short-buffer-block: SUCCESS (0.000s)
[508.436359] [065/142] (559s left) kms_ccs (pipe-d-random-ccs-data-y_tiled_gen12_mc_ccs)
[510.528037] Starting subtest: pipe-D-random-ccs-data-y_tiled_gen12_mc_ccs
[510.530689] Subtest pipe-D-random-ccs-data-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[510.633108] [066/142] (557s left) kms_properties (crtc-properties-atomic)
[512.596989] Starting subtest: crtc-properties-atomic
[513.038778] Subtest crtc-properties-atomic: SUCCESS (0.443s)
[513.190659] [067/142] (555s left) gem_mmap_offset (open-flood)
[513.245841] Starting subtest: open-flood
[534.729169] Subtest open-flood: SUCCESS (21.484s)
[534.813465] [068/142] (533s left) kms_vblank (pipe-c-query-busy)
[536.799492] Starting subtest: pipe-C-query-busy
[539.325316] Subtest pipe-C-query-busy: SUCCESS (2.526s)
[539.448036] [069/142] (529s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[541.380468] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[541.575959] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (0.196s)
[541.735430] [070/142] (526s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[541.811950] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[541.812851] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[541.867435] [071/142] (526s left) i915_query (hwconfig_table)
[541.923081] Starting subtest: hwconfig_table
[542.118769] Subtest hwconfig_table: SUCCESS (0.002s)
[542.158242] [072/142] (526s left) kms_lease (possible-crtcs-filtering)
[544.102393] Starting subtest: possible-crtcs-filtering
[544.106996] Subtest possible-crtcs-filtering: SUCCESS (0.005s)
[544.168739] [073/142] (524s left) kms_chamelium_hpd (common-hpd-after-suspend)
[546.192602] Subtest common-hpd-after-suspend: SKIP (0.000s)
[546.318317] [074/142] (522s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[548.261979] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[548.262970] Starting dynamic subtest: pipe-A-HDMI-A-3
[579.788764] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (31.526s)
[579.798328] Starting dynamic subtest: pipe-B-HDMI-A-3
[612.131336] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (32.341s)
[612.140537] Starting dynamic subtest: pipe-C-HDMI-A-3
[612.389224] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.256s)
[612.401931] Starting dynamic subtest: pipe-D-HDMI-A-3
[612.629364] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.238s)
[612.630522] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (64.368s)
[612.795344] [075/142] (455s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[614.761226] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[614.762148] Starting dynamic subtest: pipe-A-valid-mode
[616.315008] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.552s)
[616.316083] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SUCCESS (1.553s)
[616.457883] [076/142] (452s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-render)
[618.417082] Starting subtest: psr-1p-offscren-pri-indfb-draw-render
[618.418785] Subtest psr-1p-offscren-pri-indfb-draw-render: SKIP (0.000s)
[618.490871] [077/142] (450s left) vgem_basic (busy-fence)
[618.654414] Starting subtest: busy-fence
[618.655461] Subtest busy-fence: SUCCESS (0.000s)
[618.715860] [078/142] (449s left) kms_ccs (pipe-b-random-ccs-data-yf_tiled_ccs)
[620.751680] Starting subtest: pipe-B-random-ccs-data-yf_tiled_ccs
[620.754284] Subtest pipe-B-random-ccs-data-yf_tiled_ccs: SKIP (0.000s)
[620.893835] [079/142] (447s left) kms_ccs (pipe-a-bad-aux-stride-4_tiled_mtl_rc_ccs_cc)
[622.913258] Starting subtest: pipe-A-bad-aux-stride-4_tiled_mtl_rc_ccs_cc
[622.915148] Subtest pipe-A-bad-aux-stride-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[623.071436] [080/142] (445s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[625.032073] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[625.033826] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[625.108741] [081/142] (443s left) gem_exec_flush (basic-wb-set-default)
[625.241926] Subtest basic-wb-set-default: SKIP (0.000s)
[625.280914] [082/142] (443s left) gem_tiled_swapping (non-threaded)
[625.329568] Subtest non-threaded: SKIP (0.000s)
[625.347741] [083/142] (443s left) kms_flip (2x-flip-vs-dpms)
[626.356834] Starting subtest: 2x-flip-vs-dpms
[626.370970] Subtest 2x-flip-vs-dpms: SKIP (0.015s)
[626.438607] [084/142] (442s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[626.538871] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[626.541414] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[626.766129] [085/142] (442s left) kms_psr (psr2_sprite_mmap_gtt)
[626.828385] Subtest psr2_sprite_mmap_gtt: SKIP (0.000s)
[626.846759] [086/142] (442s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[628.788579] Starting subtest: cursorA-vs-flipA-legacy
[639.675101] Subtest cursorA-vs-flipA-legacy: SUCCESS (10.887s)
[639.812583] [087/142] (429s left) kms_ccs (pipe-a-ccs-on-another-bo-4_tiled_mtl_rc_ccs)
[641.823388] Starting subtest: pipe-A-ccs-on-another-bo-4_tiled_mtl_rc_ccs
[641.824938] Subtest pipe-A-ccs-on-another-bo-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[641.981381] [088/142] (426s left) gem_exec_whisper (basic-queues)
[642.056308] Starting subtest: basic-queues
[651.819303] Subtest basic-queues: SUCCESS (9.753s)
[652.016889] [089/142] (416s left) prime_vgem (basic-fence-blt)
[652.102974] Starting subtest: basic-fence-blt
[652.204685] Subtest basic-fence-blt: SUCCESS (0.101s)
[652.356731] [090/142] (416s left) gem_eio (create)
[652.624928] Starting subtest: create
[653.170430] Subtest create: SUCCESS (0.546s)
[655.133045] [091/142] (413s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[657.171768] Starting subtest: yf-tiled-8bpp-rotate-0
[657.173616] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[657.255318] [092/142] (411s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[659.290429] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[659.291349] Starting dynamic subtest: pipe-A-valid-mode
[660.897450] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.606s)
[660.901386] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (1.608s)
[661.042219] [093/142] (408s left) kms_flip (2x-blocking-wf_vblank)
[662.051458] Starting subtest: 2x-blocking-wf_vblank
[662.065235] Subtest 2x-blocking-wf_vblank: SKIP (0.014s)
[662.135358] [094/142] (406s left) fbdev (pan)
[662.233017] Starting subtest: pan
[662.284509] Subtest pan: SUCCESS (0.051s)
[662.388600] [095/142] (406s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[662.472580] Starting subtest: single-wait-all-for-submit-available-signaled
[662.473585] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[662.576259] [096/142] (406s left) gem_fence_thrash (bo-write-verify-x)
[662.625241] Starting subtest: bo-write-verify-x
[662.628067] Subtest bo-write-verify-x: SKIP (0.002s)
[662.660352] [097/142] (406s left) kms_ccs (pipe-a-crc-primary-rotation-180-y_tiled_gen12_rc_ccs)
[664.644000] Starting subtest: pipe-A-crc-primary-rotation-180-y_tiled_gen12_rc_ccs
[664.645907] Subtest pipe-A-crc-primary-rotation-180-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[664.808627] [098/142] (404s left) kms_universal_plane (universal-plane-pipe-a-functional)
[666.767533] Starting subtest: universal-plane-pipe-A-functional
[668.817863] Subtest universal-plane-pipe-A-functional: SUCCESS (2.050s)
[668.957124] [099/142] (400s left) gem_mmap_gtt (fault-concurrent-y)
[669.005745] Subtest fault-concurrent-Y: SKIP (0.000s)
[669.031506] [100/142] (400s left) syncobj_basic (bad-pad-fd-to-handle)
[669.078752] Starting subtest: bad-pad-fd-to-handle
[669.079623] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[669.154035] [101/142] (400s left) kms_ccs (pipe-d-ccs-on-another-bo-y_tiled_gen12_rc_ccs)
[671.210524] Starting subtest: pipe-D-ccs-on-another-bo-y_tiled_gen12_rc_ccs
[671.212300] Subtest pipe-D-ccs-on-another-bo-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[671.313128] [102/142] (397s left) kms_addfb_basic (unused-offsets)
[671.367604] Starting subtest: unused-offsets
[671.368531] Subtest unused-offsets: SUCCESS (0.000s)
[673.376361] [103/142] (395s left) perf (gen12-group-exclusive-stream-sample-oa)
[674.404916] Starting subtest: gen12-group-exclusive-stream-sample-oa
[674.423086] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.018s)
[674.444877] [104/142] (394s left) v3d/v3d_wait_bo (unused-bo-1ns)
[674.512572] Subtest unused-bo-1ns: SKIP (0.000s)
[674.578701] [105/142] (394s left) gem_softpin (evict-active)
[674.670596] Starting subtest: evict-active
[674.688500] Subtest evict-active: SUCCESS (0.018s)
[674.805899] [106/142] (394s left) gem_pxp (create-regular-context-2)
[677.427172] Subtest create-regular-context-2: SKIP (0.000s)
[677.477643] [107/142] (391s left) gem_ctx_bad_destroy (invalid-pad)
[677.523501] Starting subtest: invalid-pad
[677.524317] Subtest invalid-pad: SUCCESS (0.000s)
[677.585985] [108/142] (391s left) kms_ccs (pipe-b-bad-pixel-format-y_tiled_gen12_mc_ccs)
[679.585154] Starting subtest: pipe-B-bad-pixel-format-y_tiled_gen12_mc_ccs
[679.586929] Subtest pipe-B-bad-pixel-format-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[679.738970] [109/142] (389s left) gem_eio (reset-stress)
[680.100515] Starting subtest: reset-stress
[720.382792] Subtest reset-stress: SUCCESS (40.282s)
[722.406870] [110/142] (347s left) gem_exec_suspend (basic-s3)
[722.557680] Starting subtest: basic-S3
[722.558729] Starting dynamic subtest: smem
[744.655811] Dynamic subtest smem: SUCCESS (6.584s)
[744.664949] Starting dynamic subtest: lmem0
[766.714686] Dynamic subtest lmem0: SUCCESS (6.244s)
[766.715540] Subtest basic-S3: SUCCESS (12.830s)
[769.934465] [111/142] (333s left) vc4/vc4_perfmon (get-values-invalid-pointer)
[770.004453] Subtest get-values-invalid-pointer: SKIP (0.000s)
[770.065906] [112/142] (333s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[772.020013] Starting subtest: 4-tiled-8bpp-rotate-270
[772.071944] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.051s)
[772.218212] [113/142] (331s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[774.211446] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[774.212410] Starting dynamic subtest: pipe-A-HDMI-A-3
[774.304221] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.092s)
[774.315267] Starting dynamic subtest: pipe-B-HDMI-A-3
[774.430307] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.124s)
[774.444453] Starting dynamic subtest: pipe-C-HDMI-A-3
[774.573806] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.141s)
[774.586102] Starting dynamic subtest: pipe-D-HDMI-A-3
[774.698556] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.123s)
[774.699381] Subtest planes-upscale-20x20-downscale-factor-0-75: SUCCESS (0.488s)
[774.842654] [114/142] (329s left) gem_pread (snoop)
[774.908912] Subtest snoop: SKIP (0.000s)
[774.952021] [115/142] (329s left) gem_exec_reloc (basic-cpu-read-active)
[775.001438] Subtest basic-cpu-read-active: SKIP (0.000s)
[775.049676] [116/142] (329s left) kms_ccs (pipe-c-random-ccs-data-4_tiled_dg2_mc_ccs)
[777.071597] Starting subtest: pipe-C-random-ccs-data-4_tiled_dg2_mc_ccs
[777.588970] Subtest pipe-C-random-ccs-data-4_tiled_dg2_mc_ccs: SUCCESS (0.517s)
[777.735751] [117/142] (326s left) gem_ctx_persistence (file)
[777.786389] Starting subtest: file
[777.877021] Subtest file: SUCCESS (0.091s)
[778.032402] [118/142] (326s left) gem_userptr_blits (coherency-sync)
[778.094379] Starting subtest: coherency-sync
[778.706875] Subtest coherency-sync: SKIP (0.604s)
[778.871738] [119/142] (325s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[780.888968] Starting subtest: y-tiled-32bpp-rotate-180
[780.890696] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[780.975469] [120/142] (323s left) gem_eio (in-flight-internal-immediate)
[781.307004] Starting subtest: in-flight-internal-immediate
[782.551069] Subtest in-flight-internal-immediate: SUCCESS (1.245s)
[784.524010] [121/142] (319s left) kms_color (deep-color)
[786.534791] Starting subtest: deep-color
[786.540052] Subtest deep-color: SKIP (0.002s)
[786.606901] [122/142] (317s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[788.607983] Starting subtest: cursor-vs-flip-atomic
[817.157854] Subtest cursor-vs-flip-atomic: SUCCESS (28.549s)
[817.308188] [123/142] (286s left) gen9_exec_parse (cmd-crossing-page)
[817.374028] Subtest cmd-crossing-page: SKIP (0.000s)
[817.396883] [124/142] (286s left) kms_plane_alpha_blend (constant-alpha-min)
[819.339661] Starting subtest: constant-alpha-min
[819.537225] Starting dynamic subtest: pipe-A-HDMI-A-3
[820.174748] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.637s)
[820.184819] Starting dynamic subtest: pipe-D-HDMI-A-3
[820.839531] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.664s)
[820.840373] Subtest constant-alpha-min: SUCCESS (1.501s)
[820.972813] [125/142] (283s left) gem_ctx_param (invalid-set-no-zeromap)
[821.017976] Starting subtest: invalid-set-no-zeromap
[821.018769] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[821.093258] [126/142] (283s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[823.049636] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[823.051344] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[823.147297] [127/142] (281s left) kms_vblank (pipe-c-wait-forked-busy)
[825.204997] Starting subtest: pipe-C-wait-forked-busy
[827.795147] Subtest pipe-C-wait-forked-busy: SUCCESS (2.590s)
[827.910434] [128/142] (276s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[829.876018] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[829.877737] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[829.962067] [129/142] (274s left) gem_softpin (allocator-nopin)
[830.107090] Starting subtest: allocator-nopin
[830.272797] Subtest allocator-nopin: SUCCESS (0.157s)
[830.418150] [130/142] (274s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[832.364620] Starting subtest: cursorB-vs-flipA-atomic-transitions
[832.366407] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.002s)
[832.422689] [131/142] (272s left) kms_big_fb (linear-8bpp-rotate-90)
[834.462479] Starting subtest: linear-8bpp-rotate-90
[834.521624] Subtest linear-8bpp-rotate-90: SKIP (0.057s)
[834.666043] [132/142] (269s left) gem_exec_schedule (preempt-user)
[834.790875] Starting subtest: preempt-user
[834.791761] Starting dynamic subtest: rcs0
[834.843067] Dynamic subtest rcs0: SUCCESS (0.052s)
[834.852800] Starting dynamic subtest: bcs0
[834.871051] Dynamic subtest bcs0: SUCCESS (0.027s)
[834.882107] Starting dynamic subtest: vcs0
[834.898301] Dynamic subtest vcs0: SUCCESS (0.026s)
[834.908101] Starting dynamic subtest: vcs1
[834.925905] Dynamic subtest vcs1: SUCCESS (0.027s)
[834.935695] Starting dynamic subtest: vecs0
[834.952407] Dynamic subtest vecs0: SUCCESS (0.026s)
[834.962259] Starting dynamic subtest: vecs1
[834.979864] Dynamic subtest vecs1: SUCCESS (0.027s)
[834.989598] Starting dynamic subtest: ccs0
[835.007163] Dynamic subtest ccs0: SUCCESS (0.026s)
[835.017070] Starting dynamic subtest: ccs1
[835.035202] Dynamic subtest ccs1: SUCCESS (0.027s)
[835.044997] Starting dynamic subtest: ccs2
[835.062367] Dynamic subtest ccs2: SUCCESS (0.026s)
[835.072223] Starting dynamic subtest: ccs3
[835.088800] Dynamic subtest ccs3: SUCCESS (0.026s)
[835.089640] Subtest preempt-user: SUCCESS (0.298s)
[835.426380] [133/142] (269s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[835.473897] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[835.576696] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.101s)
[835.641058] [134/142] (268s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[837.584373] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[843.653890] Subtest fbc-1p-primscrn-indfb-plflip-blt: FAIL (5.680s)
[843.774995] [135/142] (260s left) gem_exec_params (cliprects-invalid)
[843.829662] Starting subtest: cliprects-invalid
[843.830546] Subtest cliprects-invalid: SUCCESS (0.000s)
[843.975138] [136/142] (260s left) prime_vgem (fence-write-hang)
[844.043629] Subtest fence-write-hang: SKIP (0.000s)
[844.149549] [137/142] (260s left) gem_exec_reloc (basic-gtt-read)
[844.219708] Subtest basic-gtt-read: SKIP (0.000s)
[844.281883] [138/142] (260s left) gem_fenced_exec_thrash (2-spare-fences)
[844.331752] Subtest 2-spare-fences: SKIP (0.000s)
[844.364742] [139/142] (260s left) gem_exec_fair (basic-none-rrul)
[844.421784] Subtest basic-none-rrul: SKIP (0.000s)
[844.467810] [140/142] (260s left) gem_exec_schedule (u-semaphore-codependency)
[844.540928] Starting subtest: u-semaphore-codependency
[844.575336] Subtest u-semaphore-codependency: SUCCESS (0.034s)
[844.943876] [141/142] (259s left) v3d/v3d_submit_csd (bad-extension)
[845.036842] Subtest bad-extension: SKIP (0.000s)
[845.100007] [142/142] (259s left) kms_ccs (pipe-b-crc-primary-rotation-180-y_tiled_ccs)
[847.115766] Starting subtest: pipe-B-crc-primary-rotation-180-y_tiled_ccs
[847.117620] Subtest pipe-B-crc-primary-rotation-180-y_tiled_ccs: SKIP (0.000s)
[847.260514] Closing watchdogs
Done.