[51.293862] Initializing watchdogs
[51.294433]   /dev/watchdog0
[51.326191] [001/142] (960s left) kms_sysfs_edid_timing
[52.175452] [002/142] (959s left) syncobj_wait (wait-delayed-signal)
[52.563410] Starting subtest: wait-delayed-signal
[52.667851] Subtest wait-delayed-signal: SUCCESS (0.106s)
[52.815394] [003/142] (959s left) gem_exec_fence (syncobj-invalid-wait)
[54.881948] Starting subtest: syncobj-invalid-wait
[54.886212] Subtest syncobj-invalid-wait: SUCCESS (0.003s)
[55.756131] [004/142] (956s left) kms_ccs (pipe-a-bad-pixel-format-y_tiled_gen12_mc_ccs)
[56.270114] Starting subtest: pipe-A-bad-pixel-format-y_tiled_gen12_mc_ccs
[56.276781] Subtest pipe-A-bad-pixel-format-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[58.202596] [005/142] (953s left) kms_psr (psr2_primary_page_flip)
[58.704947] Starting subtest: psr2_primary_page_flip
[61.966834] Subtest psr2_primary_page_flip: SUCCESS (3.258s)
[62.895340] [006/142] (949s left) device_reset (unbind-reset-rebind)
[63.713460] Starting subtest: unbind-reset-rebind
[68.338813] Subtest unbind-reset-rebind: SUCCESS (4.625s)
[68.440643] [007/142] (943s left) gem_exec_gttfill (engines)
[68.894326] Starting subtest: engines
[68.897807] Starting dynamic subtest: rcs0
[99.468281] Dynamic subtest rcs0: SUCCESS (30.572s)
[99.496675] Starting dynamic subtest: bcs0
[127.607063] Dynamic subtest bcs0: SUCCESS (28.137s)
[127.638512] Starting dynamic subtest: vcs0
[156.557805] Dynamic subtest vcs0: SUCCESS (28.949s)
[156.591825] Starting dynamic subtest: vcs1
[185.578280] Dynamic subtest vcs1: SUCCESS (29.018s)
[185.617583] Starting dynamic subtest: vecs0
[214.545507] Dynamic subtest vecs0: SUCCESS (28.967s)
[214.585462] Starting dynamic subtest: ccs0
[241.833083] Dynamic subtest ccs0: SUCCESS (27.286s)
[241.836538] Subtest engines: SUCCESS (172.938s)
[242.119988] [008/142] (770s left) gem_lmem_swapping (heavy-verify-multi)
[242.677806] Subtest heavy-verify-multi: SKIP (0.000s)
[242.796485] [009/142] (769s left) kms_plane_multiple (tiling-x)
[243.293809] Starting subtest: tiling-x
[243.297561] Starting dynamic subtest: pipe-A-eDP-1
[247.885293] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.587s)
[247.927454] Starting dynamic subtest: pipe-B-eDP-1
[253.100881] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.209s)
[253.148467] Starting dynamic subtest: pipe-C-eDP-1
[258.385234] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.287s)
[258.431242] Starting dynamic subtest: pipe-D-eDP-1
[263.856383] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.462s)
[263.860345] Subtest tiling-x: SUCCESS (20.564s)
[264.788974] [010/142] (747s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs)
[265.217849] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs
[265.223718] Subtest yf-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[265.482374] [011/142] (747s left) syncobj_basic (bad-create-flags)
[265.853736] Starting subtest: bad-create-flags
[265.857396] Subtest bad-create-flags: SUCCESS (0.000s)
[265.988271] [012/142] (746s left) gem_eio (wait-wedge-immediate)
[267.830639] Starting subtest: wait-wedge-immediate
[270.739366] Subtest wait-wedge-immediate: SUCCESS (2.908s)
[272.641799] [013/142] (740s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[273.147449] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[290.620121] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (17.475s)
[290.898986] [014/142] (721s left) gem_exec_balancer (invalid-balancer)
[291.321455] Starting subtest: invalid-balancer
[295.145181] Subtest invalid-balancer: SUCCESS (3.823s)
[296.206936] [015/142] (716s left) gem_exec_reloc (basic-write-wc-active)
[296.622866] Subtest basic-write-wc-active: SKIP (0.000s)
[296.754749] [016/142] (716s left) kms_ccs (pipe-b-bad-pixel-format-4_tiled_dg2_mc_ccs)
[297.858582] Starting subtest: pipe-B-bad-pixel-format-4_tiled_dg2_mc_ccs
[297.864795] Subtest pipe-B-bad-pixel-format-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[299.121942] [017/142] (713s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[299.636995] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[315.144433] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (15.512s)
[315.418851] [018/142] (697s left) kms_draw_crc (draw-method-render)
[315.921358] Starting subtest: draw-method-render
[315.924985] Starting dynamic subtest: xrgb8888-untiled
[316.705081] Dynamic subtest xrgb8888-untiled: SUCCESS (0.782s)
[316.745496] Starting dynamic subtest: rgb565-untiled
[317.416107] Dynamic subtest rgb565-untiled: SUCCESS (0.708s)
[317.454891] Starting dynamic subtest: xrgb2101010-untiled
[318.073566] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.652s)
[318.112584] Starting dynamic subtest: xrgb8888-xtiled
[318.471911] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.396s)
[318.509731] Starting dynamic subtest: rgb565-xtiled
[318.838356] Dynamic subtest rgb565-xtiled: SUCCESS (0.364s)
[318.889400] Starting dynamic subtest: xrgb2101010-xtiled
[319.207330] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.364s)
[319.248662] Starting dynamic subtest: xrgb8888-4tiled
[319.627597] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.420s)
[319.666347] Starting dynamic subtest: rgb565-4tiled
[320.005624] Dynamic subtest rgb565-4tiled: SUCCESS (0.374s)
[320.045956] Starting dynamic subtest: xrgb2101010-4tiled
[320.428055] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.419s)
[320.431472] Subtest draw-method-render: SUCCESS (4.508s)
[320.602160] [019/142] (692s left) gem_vm_create (isolation)
[321.005491] Starting subtest: isolation
[321.037827] Subtest isolation: SUCCESS (0.032s)
[321.212138] [020/142] (692s left) drm_fdinfo (busy-check-all)
[321.602196] Starting subtest: busy-check-all
[321.605886] Starting dynamic subtest: rcs0
[321.618745] Dynamic subtest rcs0: SKIP (0.012s)
[321.659838] Starting dynamic subtest: bcs0
[321.666497] Dynamic subtest bcs0: SKIP (0.004s)
[321.710748] Starting dynamic subtest: vcs0
[321.718352] Dynamic subtest vcs0: SKIP (0.002s)
[321.765159] Starting dynamic subtest: vcs1
[321.771746] Dynamic subtest vcs1: SKIP (0.002s)
[321.811809] Starting dynamic subtest: vecs0
[321.818368] Dynamic subtest vecs0: SKIP (0.003s)
[321.858247] Starting dynamic subtest: ccs0
[321.864683] Dynamic subtest ccs0: SKIP (0.002s)
[321.871238] Subtest busy-check-all: SKIP (0.045s)
[321.929370] [021/142] (691s left) gem_softpin (allocator-evict)
[322.351542] Starting subtest: allocator-evict
[322.355418] Starting dynamic subtest: rcs0
[354.209896] Dynamic subtest rcs0: SUCCESS (31.856s)
[354.245519] Starting dynamic subtest: bcs0
[386.400834] Dynamic subtest bcs0: SUCCESS (32.187s)
[386.455276] Starting dynamic subtest: vcs0
[417.541367] Dynamic subtest vcs0: SUCCESS (31.136s)
[417.561501] Starting dynamic subtest: vcs1
[450.564984] Dynamic subtest vcs1: SUCCESS (33.020s)
[450.583482] Starting dynamic subtest: vecs0
[483.530108] Dynamic subtest vecs0: SUCCESS (32.962s)
[483.567834] Starting dynamic subtest: ccs0
[514.508961] Dynamic subtest ccs0: SUCCESS (30.976s)
[514.512840] Subtest allocator-evict: SUCCESS (192.160s)
[514.684267] [022/142] (498s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[515.291887] Starting subtest: stress-mm-invalidate-close-overlap
[517.443165] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.149s)
[517.699289] [023/142] (495s left) gem_exec_schedule (submit-early-slice)
[518.172632] Starting subtest: submit-early-slice
[518.175689] Starting dynamic subtest: rcs0
[518.329222] Dynamic subtest rcs0: SUCCESS (0.159s)
[518.370177] Starting dynamic subtest: bcs0
[518.477836] Dynamic subtest bcs0: SUCCESS (0.145s)
[518.523901] Starting dynamic subtest: vcs0
[518.609856] Dynamic subtest vcs0: SUCCESS (0.129s)
[518.651684] Starting dynamic subtest: vcs1
[518.741577] Dynamic subtest vcs1: SUCCESS (0.128s)
[518.785384] Starting dynamic subtest: vecs0
[518.875409] Dynamic subtest vecs0: SUCCESS (0.131s)
[518.919178] Starting dynamic subtest: ccs0
[519.022320] Dynamic subtest ccs0: SUCCESS (0.144s)
[519.025951] Subtest submit-early-slice: SUCCESS (0.856s)
[519.756819] [024/142] (493s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[520.140500] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[520.144217] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.003s)
[520.292299] [025/142] (493s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[520.837426] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[534.070632] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (13.239s)
[534.355337] [026/142] (479s left) kms_ccs (pipe-d-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc)
[536.060359] Starting subtest: pipe-D-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc
[536.067190] Subtest pipe-D-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc: SKIP (0.002s)
[536.798898] [027/142] (477s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[537.170519] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[537.291512] [028/142] (476s left) vc4/vc4_purgeable_bo (access-purged-bo-mem)
[537.781800] Subtest access-purged-bo-mem: SKIP (0.000s)
[537.914724] [029/142] (476s left) perf_pmu (busy-accuracy-50)
[538.304547] Starting subtest: busy-accuracy-50
[538.309171] Starting dynamic subtest: rcs0
[539.907590] Dynamic subtest rcs0: SUCCESS (1.598s)
[539.953525] Starting dynamic subtest: bcs0
[541.519486] Dynamic subtest bcs0: SUCCESS (1.606s)
[541.563483] Starting dynamic subtest: vcs0
[543.110935] Dynamic subtest vcs0: SUCCESS (1.588s)
[543.154155] Starting dynamic subtest: vcs1
[544.707130] Dynamic subtest vcs1: SUCCESS (1.591s)
[544.749138] Starting dynamic subtest: vecs0
[546.301278] Dynamic subtest vecs0: SUCCESS (1.589s)
[546.356619] Starting dynamic subtest: ccs0
[547.915079] Dynamic subtest ccs0: SUCCESS (1.609s)
[547.919436] Subtest busy-accuracy-50: SUCCESS (9.610s)
[548.124161] [030/142] (466s left) kms_ccs (pipe-c-missing-ccs-buffer-4_tiled_mtl_mc_ccs)
[549.257390] Starting subtest: pipe-C-missing-ccs-buffer-4_tiled_mtl_mc_ccs
[549.335910] Subtest pipe-C-missing-ccs-buffer-4_tiled_mtl_mc_ccs: SUCCESS (0.080s)
[549.963099] [031/142] (464s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[550.446768] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[550.454780] Starting dynamic subtest: pipe-A-default-mode
[550.846874] Dynamic subtest pipe-A-default-mode: SKIP (0.388s)
[550.853782] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.401s)
[551.742373] [032/142] (462s left) i915_query (test-query-geometry-subslices)
[551.954932] Starting subtest: test-query-geometry-subslices
[551.957862] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[552.045257] [033/142] (462s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[552.261345] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[562.962734] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (10.697s)
[563.187546] [034/142] (451s left) kms_lease (atomic_implicit_crtc)
[563.664203] Starting subtest: atomic_implicit_crtc
[563.667782] Starting dynamic subtest: pipe-A-eDP-1
[563.679997] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.008s)
[563.716658] Starting dynamic subtest: pipe-B-eDP-1
[563.734774] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.039s)
[563.770595] Starting dynamic subtest: pipe-C-eDP-1
[563.773695] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.038s)
[563.817612] Starting dynamic subtest: pipe-D-eDP-1
[563.821177] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.043s)
[563.824591] Subtest atomic_implicit_crtc: SUCCESS (0.160s)
[563.995970] [035/142] (450s left) prime_vgem (basic-write)
[564.428403] Starting subtest: basic-write
[564.460756] Subtest basic-write: SKIP (0.030s)
[564.633514] [036/142] (449s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[565.155785] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[565.162378] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[565.326823] [037/142] (449s left) gem_exec_reloc (basic-softpin)
[565.721368] Subtest basic-softpin: SKIP (0.000s)
[565.868361] [038/142] (448s left) kms_ccs (pipe-b-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs)
[567.201389] Starting subtest: pipe-B-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs
[567.217349] Subtest pipe-B-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs: SKIP (0.013s)
[568.282675] [039/142] (446s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[568.858493] Starting subtest: basic-flip-after-cursor-legacy
[570.471400] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.615s)
[571.434660] [040/142] (443s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[571.996826] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[572.003841] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[572.169488] [041/142] (442s left) kms_flip (absolute-wf_vblank-interruptible)
[572.597221] Starting subtest: absolute-wf_vblank-interruptible
[572.625249] Starting dynamic subtest: A-eDP1
[581.944610] Dynamic subtest A-eDP1: SUCCESS (9.319s)
[581.989747] Starting dynamic subtest: B-eDP1
[591.096581] Dynamic subtest B-eDP1: SUCCESS (9.147s)
[591.140895] Starting dynamic subtest: C-eDP1
[600.229210] Dynamic subtest C-eDP1: SUCCESS (9.127s)
[600.278122] Starting dynamic subtest: D-eDP1
[609.361354] Dynamic subtest D-eDP1: SUCCESS (9.127s)
[609.387395] Subtest absolute-wf_vblank-interruptible: SUCCESS (36.795s)
[610.930197] [042/142] (404s left) gem_ctx_param (invalid-get-engines)
[611.324462] Starting subtest: invalid-get-engines
[611.328648] Subtest invalid-get-engines: SUCCESS (0.002s)
[611.471964] [043/142] (403s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[611.988682] Starting subtest: fbcpsr-rgb101010-draw-blt
[620.200092] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (8.213s)
[620.466483] [044/142] (394s left) kms_plane (plane-position-hole)
[620.963871] Starting subtest: plane-position-hole
[620.974759] Starting dynamic subtest: pipe-A-planes
[628.993786] Dynamic subtest pipe-A-planes: SUCCESS (8.024s)
[629.047123] Starting dynamic subtest: pipe-B-planes
[635.962198] Dynamic subtest pipe-B-planes: SUCCESS (6.956s)
[635.966701] Subtest plane-position-hole: SUCCESS (15.002s)
[636.856189] [045/142] (378s left) i915_selftest (perf)
[640.834121] Starting subtest: perf
[640.837809] Starting dynamic subtest: engine_cs
[645.939200] Dynamic subtest engine_cs: SUCCESS (5.109s)
[645.968858] Starting dynamic subtest: request
[652.684883] Dynamic subtest request: SUCCESS (6.741s)
[652.714496] Starting dynamic subtest: migrate
[656.999079] Dynamic subtest migrate: SUCCESS (4.311s)
[657.030816] Starting dynamic subtest: region
[665.666912] Dynamic subtest region: SUCCESS (8.664s)
[665.671309] Subtest perf: SUCCESS (24.841s)
[665.742149] [046/142] (349s left) gem_exec_whisper (basic-forked-all)
[668.890668] Starting subtest: basic-forked-all
[717.034061] Subtest basic-forked-all: FAIL (47.673s)
[717.097578] [047/142] (298s left) kms_frontbuffer_tracking (fbc-stridechange)
[717.626331] Starting subtest: fbc-stridechange
[720.536252] Subtest fbc-stridechange: SUCCESS (2.915s)
[720.718952] [048/142] (294s left) kms_cursor_crc (cursor-offscreen-256x85)
[721.548556] Starting subtest: cursor-offscreen-256x85
[721.580857] Starting dynamic subtest: pipe-A-eDP-1
[724.148074] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.570s)
[724.346673] Starting dynamic subtest: pipe-D-eDP-1
[728.391610] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.081s)
[728.395059] Subtest cursor-offscreen-256x85: SUCCESS (6.840s)
[729.324992] [049/142] (286s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[729.903565] Starting subtest: cursorB-vs-flipA-atomic-transitions
[729.920043] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.016s)
[730.249336] [050/142] (285s left) gem_ctx_param (non-root-set)
[730.620406] Starting subtest: non-root-set
[730.686237] Subtest non-root-set: SUCCESS (0.066s)
[730.843848] [051/142] (285s left) kms_vblank (pipe-d-ts-continuation-idle-hang)
[731.321305] Starting subtest: pipe-D-ts-continuation-idle-hang
[747.823489] Subtest pipe-D-ts-continuation-idle-hang: SUCCESS (16.504s)
[748.772553] [052/142] (267s left) kms_vblank (pipe-b-query-forked)
[749.258565] Starting subtest: pipe-B-query-forked
[752.900095] Subtest pipe-B-query-forked: SUCCESS (3.646s)
[753.848585] [053/142] (262s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[754.429903] Starting subtest: cursorB-vs-flipA-varying-size
[754.445990] Subtest cursorB-vs-flipA-varying-size: SKIP (0.016s)
[754.773295] [054/142] (261s left) gem_busy (busy)
[755.194470] Starting subtest: busy
[755.197528] Starting dynamic subtest: all-engines
[755.405740] Dynamic subtest all-engines: SUCCESS (0.209s)
[755.458574] Starting dynamic subtest: rcs0
[756.550070] Dynamic subtest rcs0: SUCCESS (1.140s)
[756.600740] Starting dynamic subtest: bcs0
[756.604510] Dynamic subtest bcs0: SUCCESS (0.047s)
[756.645900] Starting dynamic subtest: vcs0
[756.655345] Dynamic subtest vcs0: SUCCESS (0.049s)
[756.696406] Starting dynamic subtest: vcs1
[758.527934] Dynamic subtest vcs1: SUCCESS (1.868s)
[758.568699] Starting dynamic subtest: vecs0
[760.510826] Dynamic subtest vecs0: SUCCESS (1.977s)
[760.553931] Starting dynamic subtest: ccs0
[762.559913] Dynamic subtest ccs0: SUCCESS (2.045s)
[762.563422] Subtest busy: SUCCESS (7.364s)
[763.091573] [055/142] (253s left) kms_flip (2x-blocking-absolute-wf_vblank)
[763.494460] Starting subtest: 2x-blocking-absolute-wf_vblank
[763.657417] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.161s)
[763.852447] [056/142] (252s left) kms_vblank (pipe-c-wait-forked)
[764.337529] Starting subtest: pipe-C-wait-forked
[768.029904] Subtest pipe-C-wait-forked: SUCCESS (3.696s)
[768.972956] [057/142] (247s left) kms_color (ctm-green-to-red)
[769.455743] Starting subtest: ctm-green-to-red
[769.458847] Starting dynamic subtest: pipe-A
[770.721238] Dynamic subtest pipe-A: SUCCESS (1.264s)
[770.758534] Starting dynamic subtest: pipe-B
[772.669639] Dynamic subtest pipe-B: SUCCESS (1.944s)
[772.710350] Starting dynamic subtest: pipe-C
[774.560192] Dynamic subtest pipe-C: SUCCESS (1.887s)
[774.597914] Starting dynamic subtest: pipe-D
[777.041390] Dynamic subtest pipe-D: SUCCESS (2.478s)
[777.044459] Subtest ctm-green-to-red: SUCCESS (7.589s)
[778.022292] [058/142] (238s left) kms_plane_scaling (planes-downscale-factor-0-75)
[778.505814] Starting subtest: planes-downscale-factor-0-75
[778.514483] Starting dynamic subtest: pipe-A-eDP-1
[778.644498] Dynamic subtest pipe-A-eDP-1: SKIP (0.124s)
[778.686824] Starting dynamic subtest: pipe-B-eDP-1
[778.880558] Dynamic subtest pipe-B-eDP-1: SKIP (0.226s)
[778.924966] Starting dynamic subtest: pipe-C-eDP-1
[779.117291] Dynamic subtest pipe-C-eDP-1: SKIP (0.228s)
[779.169413] Starting dynamic subtest: pipe-D-eDP-1
[779.354752] Dynamic subtest pipe-D-eDP-1: SKIP (0.227s)
[779.361656] Subtest planes-downscale-factor-0-75: SKIP (0.848s)
[779.529727] [059/142] (237s left) i915_module_load (load)
[779.895172] Starting subtest: load
[779.909579] Subtest load: SKIP (0.006s)
[780.044263] [060/142] (236s left) kms_selftest (drm_plane)
[780.403795] Starting subtest: drm_plane
[780.416311] Subtest drm_plane: SKIP (0.008s)
[780.540616] [061/142] (236s left) gem_userptr_blits (coherency-unsync)
[780.947263] Subtest coherency-unsync: SKIP (0.000s)
[781.222172] [062/142] (235s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[781.767232] Starting subtest: y-tiled-32bpp-rotate-90
[781.774254] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[781.920940] [063/142] (234s left) gem_mmap_offset (open-flood)
[782.301926] Starting subtest: open-flood
[803.899462] Subtest open-flood: SUCCESS (21.599s)
[804.095420] [064/142] (212s left) vc4/vc4_wait_bo (bad-bo)
[804.629779] Subtest bad-bo: SKIP (0.000s)
[804.753802] [065/142] (212s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[805.254850] Starting subtest: fbc-farfromfence-mmap-gtt
[805.261239] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[805.441675] [066/142] (211s left) gem_userptr_blits (sd-probe)
[805.660914] Starting subtest: sd-probe
[805.664518] Subtest sd-probe: SUCCESS (0.003s)
[805.936228] [067/142] (211s left) kms_chamelium_frames (hdmi-frame-dump)
[806.810200] Subtest hdmi-frame-dump: SKIP (0.000s)
[807.679608] [068/142] (209s left) gem_exec_flush (basic-uc-pro-default)
[808.106678] Starting subtest: basic-uc-pro-default
[814.011602] Subtest basic-uc-pro-default: SUCCESS (5.904s)
[814.331171] [069/142] (203s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[814.861411] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[814.868519] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[815.035107] [070/142] (202s left) kms_vblank (pipe-a-wait-forked-hang)
[815.525833] Starting subtest: pipe-A-wait-forked-hang
[829.838395] Subtest pipe-A-wait-forked-hang: SUCCESS (14.309s)
[830.790746] [071/142] (186s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[831.294539] Starting subtest: fbc-rgb101010-draw-mmap-wc
[836.658152] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (5.368s)
[836.907993] [072/142] (180s left) kms_chamelium_color (ctm-negative)
[837.396196] Subtest ctm-negative: SKIP (0.000s)
[837.508269] [073/142] (180s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-cpu)
[838.023160] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-cpu
[848.681846] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (10.667s)
[848.961641] [074/142] (168s left) vgem_basic (debugfs)
[849.337066] Starting subtest: debugfs
[849.340944] Subtest debugfs: SUCCESS (0.004s)
[849.467965] [075/142] (168s left) gem_pwrite (basic-exhaustion)
[849.838583] Subtest basic-exhaustion: SKIP (0.000s)
[849.955726] [076/142] (168s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[850.512418] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[855.878297] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: FAIL (4.558s)
[855.947355] [077/142] (162s left) kms_legacy_colorkey (invalid-plane)
[856.436828] Starting subtest: invalid-plane
[856.440360] Starting dynamic subtest: zero-id
[856.443831] Dynamic subtest zero-id: SUCCESS (0.000s)
[856.489595] Starting dynamic subtest: outrange-id
[856.493346] Dynamic subtest outrange-id: SUCCESS (0.000s)
[856.496596] Subtest invalid-plane: SUCCESS (0.007s)
[856.584536] [078/142] (161s left) gem_userptr_blits (readonly-unsync)
[857.001211] Subtest readonly-unsync: SKIP (0.000s)
[857.273215] [079/142] (160s left) api_intel_bb (bb-with-allocator)
[857.651514] Starting subtest: bb-with-allocator
[857.664847] Subtest bb-with-allocator: SUCCESS (0.018s)
[857.848294] [080/142] (160s left) syncobj_timeline (wait-all-for-submit-complex)
[858.237688] Starting subtest: wait-all-for-submit-complex
[858.455513] Subtest wait-all-for-submit-complex: SUCCESS (0.218s)
[858.602662] [081/142] (159s left) kms_content_protection (legacy)
[859.278659] Starting subtest: legacy
[863.771360] Subtest legacy: SKIP (4.489s)
[865.348140] [082/142] (153s left) i915_hangman (engine-error-state-capture)
[865.784561] Starting subtest: engine-error-state-capture
[865.788184] Starting dynamic subtest: rcs0
[870.521378] Dynamic subtest rcs0: SUCCESS (4.733s)
[870.566808] Starting dynamic subtest: bcs0
[877.496065] Dynamic subtest bcs0: SUCCESS (6.971s)
[877.538201] Starting dynamic subtest: vcs0
[883.511441] Dynamic subtest vcs0: SUCCESS (6.011s)
[883.553854] Starting dynamic subtest: vcs1
[889.528071] Dynamic subtest vcs1: SUCCESS (6.012s)
[889.570846] Starting dynamic subtest: vecs0
[895.543540] Dynamic subtest vecs0: SUCCESS (6.011s)
[895.586241] Starting dynamic subtest: ccs0
[902.520416] Dynamic subtest ccs0: SUCCESS (6.973s)
[902.524201] Subtest engine-error-state-capture: SUCCESS (36.736s)
[902.754229] [083/142] (115s left) prime_vgem (coherency-blt)
[903.183880] Starting subtest: coherency-blt
[903.340119] Subtest coherency-blt: FAIL (0.121s)
[903.530155] [084/142] (115s left) kms_flip (wf_vblank-ts-check-interruptible)
[903.960949] Starting subtest: wf_vblank-ts-check-interruptible
[903.993287] Starting dynamic subtest: A-eDP1
[913.450624] Dynamic subtest A-eDP1: SUCCESS (9.457s)
[913.498745] Starting dynamic subtest: B-eDP1
[922.786595] Dynamic subtest B-eDP1: SUCCESS (9.330s)
[922.840518] Starting dynamic subtest: C-eDP1
[932.104479] Dynamic subtest C-eDP1: SUCCESS (9.311s)
[932.152705] Starting dynamic subtest: D-eDP1
[941.427551] Dynamic subtest D-eDP1: SUCCESS (9.315s)
[941.451413] Subtest wf_vblank-ts-check-interruptible: SUCCESS (37.490s)
[942.992362] [085/142] ( 75s left) i915_pm_dc (dc9-dpms)
[944.498896] Starting subtest: dc9-dpms
[944.508613] Subtest dc9-dpms: SKIP (0.001s)
[944.648738] [086/142] ( 74s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[945.469335] Starting subtest: cursor-rapid-movement-64x21
[945.505782] Starting dynamic subtest: pipe-A-eDP-1
[946.810146] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.307s)
[947.008863] Starting dynamic subtest: pipe-D-eDP-1
[949.652912] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.686s)
[949.657162] Subtest cursor-rapid-movement-64x21: SUCCESS (4.182s)
[950.858348] [087/142] ( 68s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[951.338795] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[951.349774] Starting dynamic subtest: pipe-A-default-mode
[953.654452] Dynamic subtest pipe-A-default-mode: SKIP (2.299s)
[953.661332] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (2.314s)
[953.952947] [088/142] ( 65s left) gem_ctx_persistence (heartbeat-hostile)
[954.353155] Starting subtest: heartbeat-hostile
[954.360052] Subtest heartbeat-hostile: SKIP (0.001s)
[954.510337] [089/142] ( 64s left) gem_mmap_gtt (cpuset-big-copy-odd)
[954.894797] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[955.009307] [090/142] ( 64s left) kms_ccs (pipe-a-bad-aux-stride-yf_tiled_ccs)
[956.050307] Starting subtest: pipe-A-bad-aux-stride-yf_tiled_ccs
[956.056955] Subtest pipe-A-bad-aux-stride-yf_tiled_ccs: SKIP (0.000s)
[957.386509] [091/142] ( 61s left) kms_vblank (pipe-b-ts-continuation-modeset)
[957.870756] Starting subtest: pipe-B-ts-continuation-modeset
[960.943184] Subtest pipe-B-ts-continuation-modeset: SUCCESS (3.071s)
[961.893238] [092/142] ( 57s left) perf_pmu (semaphore-wait)
[962.298923] Starting subtest: semaphore-wait
[962.302776] Starting dynamic subtest: rcs0
[962.833345] Dynamic subtest rcs0: SUCCESS (0.531s)
[962.876531] Starting dynamic subtest: bcs0
[963.353264] Dynamic subtest bcs0: SUCCESS (0.516s)
[963.395638] Starting dynamic subtest: vcs0
[963.873607] Dynamic subtest vcs0: SUCCESS (0.516s)
[963.915418] Starting dynamic subtest: vcs1
[964.393528] Dynamic subtest vcs1: SUCCESS (0.516s)
[964.434995] Starting dynamic subtest: vecs0
[964.913338] Dynamic subtest vecs0: SUCCESS (0.516s)
[964.954866] Starting dynamic subtest: ccs0
[965.435601] Dynamic subtest ccs0: SUCCESS (0.518s)
[965.439283] Subtest semaphore-wait: SUCCESS (3.138s)
[966.690123] [093/142] ( 52s left) v3d/v3d_create_bo (create-bo-0)
[967.190962] Subtest create-bo-0: SKIP (0.000s)
[967.329566] [094/142] ( 52s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[967.848297] Starting subtest: psr-1p-primscrn-spr-indfb-move
[979.332822] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (11.481s)
[979.627396] [095/142] ( 40s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[980.178630] Starting subtest: 4-tiled-32bpp-rotate-270
[980.246522] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.060s)
[980.430223] [096/142] ( 39s left) kms_ccs (pipe-b-random-ccs-data-y_tiled_ccs)
[981.661265] Starting subtest: pipe-B-random-ccs-data-y_tiled_ccs
[981.670998] Subtest pipe-B-random-ccs-data-y_tiled_ccs: SKIP (0.000s)
[982.859313] [097/142] ( 36s left) gem_exec_fence (basic-wait)
[983.441063] Starting subtest: basic-wait
[983.444993] Starting dynamic subtest: rcs0
[983.520987] Dynamic subtest rcs0: SUCCESS (0.079s)
[983.571793] Starting dynamic subtest: bcs0
[983.580777] Dynamic subtest bcs0: SUCCESS (0.056s)
[983.632433] Starting dynamic subtest: vcs0
[983.635831] Dynamic subtest vcs0: SUCCESS (0.034s)
[983.680231] Starting dynamic subtest: vcs1
[983.683332] Dynamic subtest vcs1: SUCCESS (0.048s)
[983.728086] Starting dynamic subtest: vecs0
[983.731774] Dynamic subtest vecs0: SUCCESS (0.040s)
[983.775472] Starting dynamic subtest: ccs0
[983.779288] Dynamic subtest ccs0: SUCCESS (0.056s)
[983.782743] Subtest basic-wait: SUCCESS (0.337s)
[985.691555] [098/142] ( 34s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[986.084563] Starting subtest: invalid-single-wait-unsubmitted
[986.088422] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[986.268701] [099/142] ( 33s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[986.804165] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[986.810150] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.001s)
[986.987572] [100/142] ( 33s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[987.538758] Starting subtest: 4-tiled-8bpp-rotate-270
[987.604807] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.058s)
[987.795813] [101/142] ( 32s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[988.309059] Starting subtest: fbc-rgb565-draw-render
[1002.842469] Subtest fbc-rgb565-draw-render: SUCCESS (14.532s)
[1003.161444] [102/142] ( 17s left) prime_self_import (basic-llseek-size)
[1003.527962] Starting subtest: basic-llseek-size
[1003.541466] Subtest basic-llseek-size: SUCCESS (0.013s)
[1003.712576] [103/142] ( 16s left) gem_exec_reloc (basic-write-wc)
[1004.118854] Subtest basic-write-wc: SKIP (0.000s)
[1004.259352] [104/142] ( 16s left) gem_ctx_shared (q-smoketest)
[1004.686044] Starting subtest: Q-smoketest
[1004.690079] Starting dynamic subtest: rcs0
[1010.928934] Dynamic subtest rcs0: SUCCESS (6.169s)
[1010.970749] Starting dynamic subtest: bcs0
[1017.021398] Dynamic subtest bcs0: SUCCESS (6.088s)
[1017.064769] Starting dynamic subtest: vcs0
[1023.008328] Dynamic subtest vcs0: SUCCESS (5.980s)
[1023.050203] Starting dynamic subtest: vcs1
[1028.972739] Dynamic subtest vcs1: SUCCESS (5.961s)
[1029.018053] Starting dynamic subtest: vecs0
[1035.051137] Dynamic subtest vecs0: SUCCESS (6.072s)
[1035.104636] Starting dynamic subtest: ccs0
[1041.190383] Dynamic subtest ccs0: SUCCESS (6.136s)
[1041.193711] Subtest Q-smoketest: SUCCESS (36.432s)
[1041.475679] Overall timeout time exceeded, stopping.
[1041.476964] Closing watchdogs
Done.