[42.237316] Initializing watchdogs
[42.237362]   /dev/watchdog0
[42.244234] [001/142] (960s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[42.330599] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[43.046764] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.719s)
[43.189913] [002/142] (959s left) kms_flip (modeset-vs-vblank-race-interruptible)
[43.251192] Starting subtest: modeset-vs-vblank-race-interruptible
[43.253703] Starting dynamic subtest: A-eDP1
[48.121316] Dynamic subtest A-eDP1: SUCCESS (4.870s)
[48.131193] Starting dynamic subtest: B-eDP1
[53.049968] Dynamic subtest B-eDP1: SUCCESS (4.928s)
[53.061588] Starting dynamic subtest: C-eDP1
[57.955525] Dynamic subtest C-eDP1: SUCCESS (4.905s)
[57.965321] Starting dynamic subtest: D-eDP1
[62.883295] Dynamic subtest D-eDP1: SUCCESS (4.927s)
[62.890112] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (19.641s)
[64.129161] [003/142] (938s left) syncobj_timeline (transfer-timeline-point)
[64.181635] Starting subtest: transfer-timeline-point
[64.183471] Subtest transfer-timeline-point: SUCCESS (0.000s)
[64.238659] [004/142] (938s left) gem_vm_create (invalid-destroy)
[64.297236] Starting subtest: invalid-destroy
[64.299780] Subtest invalid-destroy: SUCCESS (0.001s)
[64.379791] [005/142] (938s left) gem_exec_reloc (basic-gtt-wc)
[64.434603] Subtest basic-gtt-wc: SKIP (0.000s)
[64.476429] [006/142] (938s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[64.581671] Starting subtest: flip-vs-cursor-busy-crc-legacy
[65.460733] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.879s)
[66.356477] [007/142] (936s left) kms_sequence (get-forked-busy)
[66.428326] Starting subtest: get-forked-busy
[66.430760] Starting dynamic subtest: eDP-1-pipe-A
[68.361541] Dynamic subtest eDP-1-pipe-A: SUCCESS (1.932s)
[68.371908] Starting dynamic subtest: eDP-1-pipe-B
[71.041565] Dynamic subtest eDP-1-pipe-B: SUCCESS (2.677s)
[71.051835] Starting dynamic subtest: eDP-1-pipe-C
[73.700529] Dynamic subtest eDP-1-pipe-C: SUCCESS (2.657s)
[73.710679] Starting dynamic subtest: eDP-1-pipe-D
[76.383966] Dynamic subtest eDP-1-pipe-D: SUCCESS (2.683s)
[76.386440] Subtest get-forked-busy: SUCCESS (9.955s)
[77.301048] [008/142] (925s left) kms_content_protection (legacy)
[77.401741] Starting subtest: legacy
[81.445358] Subtest legacy: SKIP (4.040s)
[82.687336] [009/142] (920s left) kms_ccs (pipe-c-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs)
[83.098044] Starting subtest: pipe-C-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs
[83.103235] Subtest pipe-C-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs: SKIP (0.001s)
[83.955648] [010/142] (918s left) gem_exec_schedule (preempt-self)
[84.046857] Starting subtest: preempt-self
[84.048783] Starting dynamic subtest: rcs0
[84.050810] Dynamic subtest rcs0: SUCCESS (0.010s)
[84.058728] Starting dynamic subtest: bcs0
[84.061231] Dynamic subtest bcs0: SUCCESS (0.007s)
[84.073481] Starting dynamic subtest: vcs0
[84.077625] Dynamic subtest vcs0: SUCCESS (0.007s)
[84.087371] Starting dynamic subtest: vcs1
[84.089281] Dynamic subtest vcs1: SUCCESS (0.009s)
[84.096205] Starting dynamic subtest: vecs0
[84.098095] Dynamic subtest vecs0: SUCCESS (0.008s)
[84.104289] Starting dynamic subtest: ccs0
[84.106186] Dynamic subtest ccs0: SUCCESS (0.008s)
[84.108075] Subtest preempt-self: SUCCESS (0.050s)
[85.566866] [011/142] (917s left) kms_chamelium_hpd (vga-hpd)
[85.936662] Subtest vga-hpd: SKIP (0.000s)
[86.812977] [012/142] (916s left) gem_render_copy (y-tiled-ccs-to-linear)
[86.890840] Starting subtest: y-tiled-ccs-to-linear
[86.895525] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[87.060279] [013/142] (915s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[87.140106] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[87.144052] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[87.224975] [014/142] (915s left) kms_chamelium_audio (hdmi-audio-edid)
[87.596349] Subtest hdmi-audio-edid: SKIP (0.000s)
[88.476759] [015/142] (914s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[88.550449] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[91.329062] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (2.786s)
[91.464234] [016/142] (911s left) kms_frontbuffer_tracking (fbcpsr-badstride)
[91.559171] Starting subtest: fbcpsr-badstride
[101.849832] Subtest fbcpsr-badstride: SUCCESS (10.295s)
[101.952802] [017/142] (901s left) gem_exec_fence (syncobj-timeline-repeat)
[102.558538] Starting subtest: syncobj-timeline-repeat
[102.715491] Subtest syncobj-timeline-repeat: SUCCESS (0.157s)
[103.549666] [018/142] (899s left) gem_fenced_exec_thrash (too-many-fences)
[103.593336] Subtest too-many-fences: SKIP (0.000s)
[103.606789] [019/142] (899s left) gem_userptr_blits (create-destroy-unsync)
[103.684886] Subtest create-destroy-unsync: SKIP (0.000s)
[103.801527] [020/142] (899s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[105.646345] Starting subtest: gem-execbuf-stress-pc8
[105.690874] Subtest gem-execbuf-stress-pc8: SKIP (0.040s)
[106.375524] [021/142] (896s left) kms_feature_discovery (dp-mst)
[106.427775] Starting subtest: dp-mst
[106.432335] Subtest dp-mst: SKIP (0.000s)
[106.481408] [022/142] (896s left) kms_dp_aux_dev
[106.672977] [023/142] (896s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[106.724755] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[106.729619] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[106.784328] [024/142] (896s left) kms_chamelium_edid (vga-edid-read)
[107.146845] Subtest vga-edid-read: SKIP (0.000s)
[107.999321] [025/142] (895s left) gem_fence_thrash (bo-write-verify-threaded-x)
[108.048247] Starting subtest: bo-write-verify-threaded-x
[108.055693] Subtest bo-write-verify-threaded-x: SKIP (0.002s)
[108.085928] [026/142] (895s left) dmabuf_sync_file (export-basic)
[108.152785] Starting subtest: export-basic
[108.155063] Subtest export-basic: SUCCESS (0.001s)
[108.197698] [027/142] (895s left) gem_softpin (overlap)
[108.247459] Starting subtest: overlap
[108.839682] Subtest overlap: SUCCESS (0.592s)
[108.934444] [028/142] (894s left) gem_exec_reloc (basic-wc-cpu-active)
[109.009163] Subtest basic-wc-cpu-active: SKIP (0.000s)
[109.064599] [029/142] (894s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[109.166096] Starting subtest: flip-vs-cursor-legacy
[114.934554] Subtest flip-vs-cursor-legacy: SUCCESS (5.768s)
[115.829305] [030/142] (887s left) syncobj_wait (wait-any-complex)
[115.882726] Starting subtest: wait-any-complex
[115.942372] Subtest wait-any-complex: SUCCESS (0.062s)
[116.006679] [031/142] (887s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[116.081393] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[116.083869] Starting dynamic subtest: pipe-A-default-mode
[118.887366] Dynamic subtest pipe-A-default-mode: SUCCESS (2.806s)
[118.889995] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.808s)
[119.793266] [032/142] (883s left) kms_vblank (pipe-a-query-forked-busy-hang)
[119.861147] Starting subtest: pipe-A-query-forked-busy-hang
[134.281431] Subtest pipe-A-query-forked-busy-hang: SUCCESS (14.422s)
[135.171072] [033/142] (868s left) gem_tiled_blits (basic)
[135.234046] Subtest basic: SKIP (0.000s)
[135.258377] [034/142] (868s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[135.314949] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[138.515573] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (3.208s)
[138.641925] [035/142] (864s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[138.703486] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[138.707318] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[138.879913] [036/142] (864s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[138.951548] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[144.585857] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (5.639s)
[144.717282] [037/142] (858s left) core_getclient
[144.826346] [038/142] (858s left) gem_exec_fence (basic-wait)
[144.991043] Starting subtest: basic-wait
[144.993902] Starting dynamic subtest: rcs0
[145.063131] Dynamic subtest rcs0: SUCCESS (0.072s)
[145.074830] Starting dynamic subtest: bcs0
[145.111208] Dynamic subtest bcs0: SUCCESS (0.047s)
[145.122468] Starting dynamic subtest: vcs0
[145.137681] Dynamic subtest vcs0: SUCCESS (0.026s)
[145.148981] Starting dynamic subtest: vcs1
[145.164063] Dynamic subtest vcs1: SUCCESS (0.025s)
[145.175039] Starting dynamic subtest: vecs0
[145.190546] Dynamic subtest vecs0: SUCCESS (0.026s)
[145.201170] Starting dynamic subtest: ccs0
[145.244411] Dynamic subtest ccs0: SUCCESS (0.053s)
[145.246818] Subtest basic-wait: SUCCESS (0.255s)
[146.552683] [039/142] (857s left) gem_render_copy (x-tiled)
[146.617787] Starting subtest: x-tiled
[146.620048] Starting dynamic subtest: smem
[146.652758] Dynamic subtest smem: SUCCESS (0.036s)
[146.655300] Subtest x-tiled: SUCCESS (0.037s)
[146.827557] [040/142] (856s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[146.890800] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[146.893254] Starting dynamic subtest: pipe-A-eDP-1
[146.897981] Dynamic subtest pipe-A-eDP-1: SKIP (0.003s)
[146.909470] Starting dynamic subtest: pipe-B-eDP-1
[146.914246] Dynamic subtest pipe-B-eDP-1: SKIP (0.013s)
[146.925068] Starting dynamic subtest: pipe-C-eDP-1
[146.929851] Dynamic subtest pipe-C-eDP-1: SKIP (0.013s)
[146.939338] Starting dynamic subtest: pipe-D-eDP-1
[146.943217] Dynamic subtest pipe-D-eDP-1: SKIP (0.013s)
[146.947121] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.044s)
[147.008746] [041/142] (856s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[147.090837] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[147.095453] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[147.173720] [042/142] (856s left) vc4/vc4_purgeable_bo (mark-unpurgeable-check-retained)
[147.250257] Subtest mark-unpurgeable-check-retained: SKIP (0.000s)
[147.291688] [043/142] (856s left) kms_getfb (getfb-handle-valid)
[147.344510] Starting subtest: getfb-handle-valid
[147.346524] Subtest getfb-handle-valid: SUCCESS (0.000s)
[147.424893] [044/142] (856s left) kms_ccs (pipe-d-missing-ccs-buffer-4_tiled_mtl_rc_ccs)
[147.825080] Starting subtest: pipe-D-missing-ccs-buffer-4_tiled_mtl_rc_ccs
[147.827763] Subtest pipe-D-missing-ccs-buffer-4_tiled_mtl_rc_ccs: SUCCESS (0.000s)
[148.658844] [045/142] (855s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[148.728147] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[148.732749] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[148.815089] [046/142] (854s left) kms_busy (extended-pageflip-hang-oldfb)
[148.901131] Starting subtest: extended-pageflip-hang-oldfb
[148.903532] Starting dynamic subtest: pipe-A
[149.311260] Dynamic subtest pipe-A: SUCCESS (0.410s)
[149.326239] Starting dynamic subtest: pipe-D
[150.503135] Dynamic subtest pipe-D: SUCCESS (1.183s)
[150.505746] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.600s)
[151.428395] [047/142] (852s left) kms_ccs (pipe-c-crc-primary-basic-4_tiled_dg2_mc_ccs)
[151.811691] Starting subtest: pipe-C-crc-primary-basic-4_tiled_dg2_mc_ccs
[151.817365] Subtest pipe-C-crc-primary-basic-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[152.693246] [048/142] (851s left) kms_ccs (pipe-b-bad-aux-stride-4_tiled_mtl_rc_ccs)
[153.084789] Starting subtest: pipe-B-bad-aux-stride-4_tiled_mtl_rc_ccs
[153.087643] Subtest pipe-B-bad-aux-stride-4_tiled_mtl_rc_ccs: SUCCESS (0.000s)
[153.973835] [049/142] (849s left) kms_ccs (pipe-b-random-ccs-data-y_tiled_gen12_rc_ccs)
[154.366902] Starting subtest: pipe-B-random-ccs-data-y_tiled_gen12_rc_ccs
[154.375023] Subtest pipe-B-random-ccs-data-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[155.253471] [050/142] (848s left) kms_ccs (pipe-d-bad-pixel-format-y_tiled_gen12_rc_ccs_cc)
[155.640770] Starting subtest: pipe-D-bad-pixel-format-y_tiled_gen12_rc_ccs_cc
[155.646263] Subtest pipe-D-bad-pixel-format-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[156.469675] [051/142] (847s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[156.513551] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[156.572990] [052/142] (847s left) gem_exec_reloc (basic-write-wc-active)
[156.615748] Subtest basic-write-wc-active: SKIP (0.000s)
[156.662439] [053/142] (847s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[156.716309] Starting subtest: multi-wait-all-for-submit-signaled
[156.718609] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[156.774786] [054/142] (847s left) kms_ccs (pipe-c-bad-pixel-format-4_tiled_mtl_mc_ccs)
[157.180074] Starting subtest: pipe-C-bad-pixel-format-4_tiled_mtl_mc_ccs
[157.183292] Subtest pipe-C-bad-pixel-format-4_tiled_mtl_mc_ccs: SUCCESS (0.001s)
[158.028364] [055/142] (845s left) gem_exec_reloc (basic-concurrent0)
[158.094144] Subtest basic-concurrent0: SKIP (0.000s)
[158.152356] [056/142] (845s left) gem_ctx_persistence (engines-hostile)
[158.223175] Starting subtest: engines-hostile
[158.225654] Starting dynamic subtest: rcs0
[158.235461] Dynamic subtest rcs0: SUCCESS (0.013s)
[158.247275] Starting dynamic subtest: bcs0
[158.332394] Dynamic subtest bcs0: SUCCESS (0.096s)
[158.345419] Starting dynamic subtest: vcs0
[158.416045] Dynamic subtest vcs0: SUCCESS (0.082s)
[158.427437] Starting dynamic subtest: vcs1
[158.433825] Dynamic subtest vcs1: SUCCESS (0.017s)
[158.444724] Starting dynamic subtest: vecs0
[158.486197] Dynamic subtest vecs0: SUCCESS (0.052s)
[158.497535] Starting dynamic subtest: ccs0
[158.555634] Dynamic subtest ccs0: SUCCESS (0.068s)
[158.558096] Subtest engines-hostile: SUCCESS (0.334s)
[158.649127] [057/142] (845s left) gem_ctx_shared (q-in-order)
[158.738983] Starting subtest: Q-in-order
[158.741626] Starting dynamic subtest: rcs0
[158.788373] Dynamic subtest rcs0: SUCCESS (0.058s)
[158.809419] Starting dynamic subtest: vcs0
[158.843779] Dynamic subtest vcs0: SUCCESS (0.054s)
[158.863413] Starting dynamic subtest: vcs1
[158.899248] Dynamic subtest vcs1: SUCCESS (0.055s)
[158.918189] Starting dynamic subtest: vecs0
[158.954327] Dynamic subtest vecs0: SUCCESS (0.054s)
[158.972614] Starting dynamic subtest: ccs0
[159.011630] Dynamic subtest ccs0: SUCCESS (0.056s)
[159.013974] Subtest Q-in-order: SUCCESS (0.282s)
[159.555178] [058/142] (844s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[159.641920] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[159.646522] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[159.732438] [059/142] (844s left) v3d/v3d_submit_cl (multi-and-single-sync)
[159.830247] Subtest multi-and-single-sync: SKIP (0.000s)
[159.877723] [060/142] (844s left) kms_invalid_mode (bad-hsync-end)
[159.944397] Starting subtest: bad-hsync-end
[159.946887] Starting dynamic subtest: eDP-1-pipe-A
[160.224589] Dynamic subtest eDP-1-pipe-A: SUCCESS (0.283s)
[160.236084] Starting dynamic subtest: eDP-1-pipe-B
[160.239049] Dynamic subtest eDP-1-pipe-B: SUCCESS (0.001s)
[160.250184] Starting dynamic subtest: eDP-1-pipe-C
[160.253188] Dynamic subtest eDP-1-pipe-C: SUCCESS (0.001s)
[160.263782] Starting dynamic subtest: eDP-1-pipe-D
[160.266496] Dynamic subtest eDP-1-pipe-D: SUCCESS (0.001s)
[160.269048] Subtest bad-hsync-end: SUCCESS (0.293s)
[161.152179] [061/142] (842s left) gem_exec_balancer (nop)
[161.209703] Starting subtest: nop
[207.490628] Subtest nop: SUCCESS (46.281s)
[207.739724] [062/142] (796s left) kms_ccs (pipe-a-bad-pixel-format-4_tiled_mtl_rc_ccs_cc)
[207.790711] Starting subtest: pipe-A-bad-pixel-format-4_tiled_mtl_rc_ccs_cc
[207.793157] Subtest pipe-A-bad-pixel-format-4_tiled_mtl_rc_ccs_cc: SUCCESS (0.000s)
[208.944727] [063/142] (795s left) gen9_exec_parse (batch-zero-length)
[209.010216] Subtest batch-zero-length: SKIP (0.000s)
[209.031864] [064/142] (795s left) kms_universal_plane (universal-plane-pipe-c-sanity)
[209.085177] Starting subtest: universal-plane-pipe-C-sanity
[210.827676] Subtest universal-plane-pipe-C-sanity: SUCCESS (1.743s)
[211.713333] [065/142] (792s left) kms_pm_dc (dc5-dpms-negative)
[212.808842] Starting subtest: dc5-dpms-negative
[212.813100] Subtest dc5-dpms-negative: SKIP (0.000s)
[212.871556] [066/142] (791s left) kms_lease (simple_lease)
[212.929888] Starting subtest: simple_lease
[212.932292] Starting dynamic subtest: pipe-A-eDP-1
[213.421979] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.492s)
[213.443522] Starting dynamic subtest: pipe-B-eDP-1
[214.943616] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.520s)
[214.955521] Starting dynamic subtest: pipe-C-eDP-1
[216.464893] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.516s)
[216.476310] Starting dynamic subtest: pipe-D-eDP-1
[217.931406] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.465s)
[217.933839] Subtest simple_lease: SUCCESS (5.002s)
[218.806577] [067/142] (785s left) kms_ccs (pipe-c-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc)
[219.197951] Starting subtest: pipe-C-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc
[219.203380] Subtest pipe-C-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[220.087940] [068/142] (784s left) kms_cursor_edge_walk (128x128-left-edge)
[220.154404] Starting subtest: 128x128-left-edge
[220.156826] Starting dynamic subtest: pipe-A-eDP-1
[223.775809] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.621s)
[223.787354] Starting dynamic subtest: pipe-D-eDP-1
[227.046747] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.268s)
[227.049206] Subtest 128x128-left-edge: SUCCESS (6.895s)
[227.968630] [069/142] (776s left) gem_softpin (safe-alignment)
[228.016346] Starting subtest: safe-alignment
[228.026245] Subtest safe-alignment: SUCCESS (0.009s)
[229.470937] [070/142] (774s left) kms_flip (blocking-wf_vblank)
[229.543644] Starting subtest: blocking-wf_vblank
[229.546087] Starting dynamic subtest: A-eDP1
[238.565258] Dynamic subtest A-eDP1: SUCCESS (9.020s)
[238.576108] Starting dynamic subtest: B-eDP1
[247.588489] Dynamic subtest B-eDP1: SUCCESS (9.022s)
[247.604751] Starting dynamic subtest: C-eDP1
[256.600267] Dynamic subtest C-eDP1: SUCCESS (9.010s)
[256.612220] Starting dynamic subtest: D-eDP1
[265.562465] Dynamic subtest D-eDP1: SUCCESS (8.960s)
[265.570417] Subtest blocking-wf_vblank: SUCCESS (36.029s)
[266.882869] [071/142] (737s left) gem_ctx_persistence (legacy-engines-hang)
[266.934778] Starting subtest: legacy-engines-hang
[266.937227] Starting dynamic subtest: render
[267.026044] Dynamic subtest render: SUCCESS (0.091s)
[267.037950] Starting dynamic subtest: bsd1
[267.105214] Dynamic subtest bsd1: SUCCESS (0.077s)
[267.118834] Starting dynamic subtest: bsd2
[267.140469] Dynamic subtest bsd2: SUCCESS (0.034s)
[267.151422] Starting dynamic subtest: blt
[267.224619] Dynamic subtest blt: SUCCESS (0.082s)
[267.236251] Starting dynamic subtest: vebox
[267.241501] Dynamic subtest vebox: SUCCESS (0.013s)
[267.243840] Subtest legacy-engines-hang: SUCCESS (0.306s)
[267.335282] [072/142] (737s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[267.419307] Starting subtest: cursorA-vs-flipB-atomic
[267.424432] Subtest cursorA-vs-flipB-atomic: SKIP (0.002s)
[267.549119] [073/142] (736s left) gem_set_tiling_vs_pwrite
[267.631405] [074/142] (736s left) kms_vblank (pipe-c-accuracy-idle)
[267.705882] Starting subtest: pipe-C-accuracy-idle
[270.624718] Subtest pipe-C-accuracy-idle: SUCCESS (2.915s)
[271.556682] [075/142] (732s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[271.630685] Starting subtest: x-tiled-8bpp-rotate-0
[272.685267] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.056s)
[272.794478] [076/142] (731s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[272.835922] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[272.941401] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.107s)
[273.009589] [077/142] (731s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[273.087701] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[273.092326] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[273.165756] [078/142] (731s left) i915_suspend (basic-s2idle-without-i915)
[273.222807] Starting subtest: basic-s2idle-without-i915
[291.503825] Subtest basic-s2idle-without-i915: SUCCESS (3.287s)
[291.584109] [079/142] (727s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[291.646377] Starting subtest: 2x-flip-vs-rmfb-interruptible
[291.663963] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.014s)
[291.730428] [080/142] (727s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[291.791839] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[291.795860] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[291.872936] [081/142] (727s left) prime_mmap (test_correct)
[291.920967] Starting subtest: test_correct
[291.922855] Starting dynamic subtest: test_correct-smem
[291.968139] Dynamic subtest test_correct-smem: SUCCESS (0.048s)
[291.970771] Subtest test_correct: SUCCESS (0.049s)
[292.051551] [082/142] (727s left) vgem_basic (create)
[292.092504] Starting subtest: create
[292.094699] Subtest create: SUCCESS (0.000s)
[292.135512] [083/142] (727s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[292.220946] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[292.224744] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[292.304669] [084/142] (727s left) gem_pread (uncached)
[292.354499] Subtest uncached: SKIP (0.000s)
[292.396207] [085/142] (727s left) gem_lmem_swapping (heavy-verify-random)
[292.461656] Subtest heavy-verify-random: SKIP (0.000s)
[292.493295] [086/142] (727s left) kms_plane_scaling (planes-downscale-factor-0-75)
[292.543735] Starting subtest: planes-downscale-factor-0-75
[292.545876] Starting dynamic subtest: pipe-A-eDP-1
[292.557138] Dynamic subtest pipe-A-eDP-1: SKIP (0.011s)
[292.568370] Starting dynamic subtest: pipe-B-eDP-1
[292.576684] Dynamic subtest pipe-B-eDP-1: SKIP (0.021s)
[292.587408] Starting dynamic subtest: pipe-C-eDP-1
[292.598387] Dynamic subtest pipe-C-eDP-1: SKIP (0.020s)
[292.607213] Starting dynamic subtest: pipe-D-eDP-1
[292.617522] Dynamic subtest pipe-D-eDP-1: SKIP (0.019s)
[292.620877] Subtest planes-downscale-factor-0-75: SKIP (0.074s)
[292.696028] [087/142] (727s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[292.761802] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[297.768986] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (5.009s)
[297.907328] [088/142] (721s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[297.988385] Starting subtest: fbcpsr-suspend
[336.306812] Subtest fbcpsr-suspend: SUCCESS (8.169s)
[336.406218] [089/142] (713s left) kms_ccs (pipe-b-bad-rotation-90-y_tiled_ccs)
[336.818238] Starting subtest: pipe-B-bad-rotation-90-y_tiled_ccs
[336.823902] Subtest pipe-B-bad-rotation-90-y_tiled_ccs: SKIP (0.000s)
[337.685609] [090/142] (712s left) perf_pmu (init-busy)
[337.746343] Starting subtest: init-busy
[337.748924] Starting dynamic subtest: rcs0
[337.751741] Dynamic subtest rcs0: SUCCESS (0.002s)
[337.759357] Starting dynamic subtest: bcs0
[337.762049] Dynamic subtest bcs0: SUCCESS (0.001s)
[337.769222] Starting dynamic subtest: vcs0
[337.772018] Dynamic subtest vcs0: SUCCESS (0.001s)
[337.779347] Starting dynamic subtest: vcs1
[337.781755] Dynamic subtest vcs1: SUCCESS (0.001s)
[337.789224] Starting dynamic subtest: vecs0
[337.791659] Dynamic subtest vecs0: SUCCESS (0.001s)
[337.798606] Starting dynamic subtest: ccs0
[337.800927] Dynamic subtest ccs0: SUCCESS (0.001s)
[337.802826] Subtest init-busy: SUCCESS (0.012s)
[337.837745] [091/142] (712s left) kms_ccs (pipe-a-ccs-on-another-bo-y_tiled_gen12_rc_ccs)
[338.222300] Starting subtest: pipe-A-ccs-on-another-bo-y_tiled_gen12_rc_ccs
[338.227133] Subtest pipe-A-ccs-on-another-bo-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[339.074194] [092/142] (710s left) perf (non-zero-reason)
[339.232827] Starting subtest: non-zero-reason
[339.238125] Starting dynamic subtest: 0-rcs0
[345.542422] Dynamic subtest 0-rcs0: SUCCESS (6.308s)
[345.556726] Starting dynamic subtest: 1-vcs1
[349.871876] Dynamic subtest 1-vcs1: SUCCESS (4.329s)
[349.874496] Subtest non-zero-reason: SUCCESS (10.638s)
[349.912089] [093/142] (700s left) gem_pxp (hw-rejects-pxp-context)
[352.495129] Starting subtest: hw-rejects-pxp-context
[352.497828] Subtest hw-rejects-pxp-context: SUCCESS (0.001s)
[352.566166] [094/142] (697s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[352.622385] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[357.493499] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (4.872s)
[357.616130] [095/142] (692s left) api_intel_bb (object-noreloc-purge-cache-simple)
[357.671876] Starting subtest: object-noreloc-purge-cache-simple
[357.674277] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.004s)
[357.751281] [096/142] (692s left) vgem_basic (bad-fence)
[357.815218] Starting subtest: bad-fence
[357.817756] Subtest bad-fence: SUCCESS (0.000s)
[357.864287] [097/142] (692s left) gem_exec_params (invalid-bsd-ring)
[357.911260] Starting subtest: invalid-bsd-ring
[357.914053] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[357.980995] [098/142] (692s left) kms_flip (dpms-off-confusion-interruptible)
[358.051244] Starting subtest: dpms-off-confusion-interruptible
[358.057408] Starting dynamic subtest: A-eDP1
[366.810398] Dynamic subtest A-eDP1: SUCCESS (8.753s)
[366.823395] Starting dynamic subtest: B-eDP1
[375.577751] Dynamic subtest B-eDP1: SUCCESS (8.766s)
[375.591117] Starting dynamic subtest: C-eDP1
[384.333441] Dynamic subtest C-eDP1: SUCCESS (8.754s)
[384.346556] Starting dynamic subtest: D-eDP1
[393.043208] Dynamic subtest D-eDP1: SUCCESS (8.708s)
[393.051253] Subtest dpms-off-confusion-interruptible: SUCCESS (35.000s)
[394.343038] [099/142] (655s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[394.450024] Starting subtest: y-tiled-32bpp-rotate-90
[394.454554] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[394.532455] [100/142] (655s left) gem_exec_whisper (basic-contexts-priority)
[394.605060] Starting subtest: basic-contexts-priority
[418.664018] Subtest basic-contexts-priority: SUCCESS (24.057s)
[418.842299] [101/142] (631s left) kms_scaling_modes (scaling-mode-none)
[418.919144] Starting subtest: scaling-mode-none
[418.921548] Starting dynamic subtest: eDP-1-pipe-A
[419.007656] Dynamic subtest eDP-1-pipe-A: SKIP (0.085s)
[419.021138] Starting dynamic subtest: eDP-1-pipe-B
[419.040665] Dynamic subtest eDP-1-pipe-B: SKIP (0.030s)
[419.048422] Starting dynamic subtest: eDP-1-pipe-C
[419.070924] Dynamic subtest eDP-1-pipe-C: SKIP (0.030s)
[419.078940] Starting dynamic subtest: eDP-1-pipe-D
[419.095773] Dynamic subtest eDP-1-pipe-D: SKIP (0.023s)
[419.100044] Subtest scaling-mode-none: SKIP (0.174s)
[419.192055] [102/142] (631s left) kms_cursor_crc (cursor-offscreen-32x32)
[419.271967] Starting subtest: cursor-offscreen-32x32
[419.303961] Subtest cursor-offscreen-32x32: SKIP (0.025s)
[419.491500] [103/142] (630s left) kms_ccs (pipe-d-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc)
[419.925596] Starting subtest: pipe-D-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc
[419.931535] Subtest pipe-D-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[420.722273] [104/142] (629s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[420.815088] Starting subtest: coverage-vs-premult-vs-constant
[421.056028] Starting dynamic subtest: pipe-A-eDP-1
[421.630319] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.573s)
[421.640158] Starting dynamic subtest: pipe-D-eDP-1
[423.066086] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.433s)
[423.068228] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.252s)
[423.960041] [105/142] (626s left) gem_exec_balancer (parallel-ordering)
[424.206278] Starting subtest: parallel-ordering
[424.913722] Subtest parallel-ordering: SUCCESS (0.707s)
[425.012033] [106/142] (625s left) perf (invalid-remove-userspace-config)
[425.120680] Starting subtest: invalid-remove-userspace-config
[425.127816] Subtest invalid-remove-userspace-config: SUCCESS (0.010s)
[425.149771] [107/142] (625s left) kms_lease (lease_invalid_plane)
[425.239167] Starting subtest: lease_invalid_plane
[425.241582] Starting dynamic subtest: pipe-A-eDP-1
[425.243932] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[425.258178] Starting dynamic subtest: pipe-B-eDP-1
[425.260519] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[425.271802] Starting dynamic subtest: pipe-C-eDP-1
[425.273766] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[425.281847] Starting dynamic subtest: pipe-D-eDP-1
[425.283739] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[425.285633] Subtest lease_invalid_plane: SUCCESS (0.006s)
[425.304933] [108/142] (625s left) gem_busy (parallel)
[425.512449] Starting subtest: parallel
[425.515525] Starting dynamic subtest: rcs0
[427.581735] Dynamic subtest rcs0: SUCCESS (2.068s)
[427.597385] Starting dynamic subtest: bcs0
[429.566087] Dynamic subtest bcs0: SUCCESS (1.983s)
[429.581393] Starting dynamic subtest: vcs0
[431.614475] Dynamic subtest vcs0: SUCCESS (2.046s)
[431.630440] Starting dynamic subtest: vcs1
[433.597962] Dynamic subtest vcs1: SUCCESS (1.982s)
[433.613191] Starting dynamic subtest: vecs0
[435.581692] Dynamic subtest vecs0: SUCCESS (1.982s)
[435.596555] Starting dynamic subtest: ccs0
[437.566642] Dynamic subtest ccs0: SUCCESS (1.983s)
[437.569960] Subtest parallel: SUCCESS (12.054s)
[437.789270] [109/142] (612s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[437.875165] Starting subtest: plane-all-modeset-transition-fencing
[437.879080] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[437.938264] [110/142] (612s left) kms_async_flips (test-cursor)
[438.010167] Starting subtest: test-cursor
[438.014809] Subtest test-cursor: SKIP (0.000s)
[439.336027] [111/142] (611s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[439.426630] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[439.430947] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[439.513190] [112/142] (611s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[439.588812] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[439.592909] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[439.670783] [113/142] (610s left) gem_mmap (bad-offset)
[439.738669] Subtest bad-offset: SKIP (0.000s)
[439.762443] [114/142] (610s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[439.843754] Starting subtest: psr-shrfb-scaledprimary
[443.662362] Subtest psr-shrfb-scaledprimary: SUCCESS (3.822s)
[443.772408] [115/142] (606s left) vgem_basic (dmabuf-fence-before)
[443.814326] Starting subtest: dmabuf-fence-before
[443.816604] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[443.851405] [116/142] (606s left) v3d/v3d_wait_bo (unused-bo-1ns)
[443.924813] Subtest unused-bo-1ns: SKIP (0.000s)
[443.973955] [117/142] (606s left) v3d/v3d_perfmon (get-values-invalid-pointer)
[444.059722] Subtest get-values-invalid-pointer: SKIP (0.000s)
[444.100582] [118/142] (606s left) kms_ccs (pipe-b-crc-primary-rotation-180-y_tiled_gen12_rc_ccs)
[444.461529] Starting subtest: pipe-B-crc-primary-rotation-180-y_tiled_gen12_rc_ccs
[444.468926] Subtest pipe-B-crc-primary-rotation-180-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[445.351339] [119/142] (605s left) i915_pm_rps (fence-order)
[445.404270] Starting subtest: fence-order
[446.984938] Subtest fence-order: SUCCESS (1.577s)
[447.049178] [120/142] (603s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[447.110170] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[447.114860] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[447.196711] [121/142] (603s left) gem_mmap_gtt (basic-small-bo)
[447.251282] Subtest basic-small-bo: SKIP (0.000s)
[447.277318] [122/142] (603s left) kms_cursor_crc (cursor-random-64x64)
[447.380108] Starting subtest: cursor-random-64x64
[447.382599] Starting dynamic subtest: pipe-A-eDP-1
[450.761849] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.379s)
[450.794760] Starting dynamic subtest: pipe-D-eDP-1
[454.873382] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.085s)
[454.875907] Subtest cursor-random-64x64: SUCCESS (7.494s)
[455.755208] [123/142] (595s left) syncobj_timeline (wait-delayed-signal)
[455.807833] Starting subtest: wait-delayed-signal
[455.906301] Subtest wait-delayed-signal: SUCCESS (0.102s)
[455.977431] [124/142] (594s left) gem_mmap_offset (blt-coherency)
[456.041382] Starting subtest: blt-coherency
[456.044386] Subtest blt-coherency: SUCCESS (0.004s)
[456.136051] [125/142] (594s left) gem_close_race (multigpu-basic-threads)
[456.202987] Starting subtest: multigpu-basic-threads
[456.207869] Subtest multigpu-basic-threads: SKIP (0.000s)
[456.407716] [126/142] (594s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[456.470802] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[456.572648] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.103s)
[456.642393] [127/142] (594s left) kms_psr (psr2_dpms)
[456.719714] Starting subtest: psr2_dpms
[459.822637] Subtest psr2_dpms: SUCCESS (3.102s)
[460.775811] [128/142] (590s left) gem_exec_whisper (basic-contexts)
[460.856705] Starting subtest: basic-contexts
[464.577485] Subtest basic-contexts: SUCCESS (3.721s)
[464.756527] [129/142] (586s left) drm_fdinfo (virtual-busy-idle)
[464.809622] Starting subtest: virtual-busy-idle
[464.813877] Subtest virtual-busy-idle: SKIP (0.000s)
[464.873877] [130/142] (586s left) i915_pm_rc6_residency (rc6-fence)
[464.940512] Starting subtest: rc6-fence
[488.611090] Subtest rc6-fence: SUCCESS (23.671s)
[489.924225] [131/142] (561s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[489.966613] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[489.968495] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[490.015956] [132/142] (561s left) kms_big_fb (linear-16bpp-rotate-90)
[490.120594] Starting subtest: linear-16bpp-rotate-90
[490.137057] Subtest linear-16bpp-rotate-90: SKIP (0.016s)
[490.232454] [133/142] (560s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs)
[490.599771] Starting subtest: pipe-A-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs
[490.605435] Subtest pipe-A-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs: SKIP (0.001s)
[491.480706] [134/142] (559s left) kms_atomic_interruptible (atomic-setmode)
[491.535016] Starting subtest: atomic-setmode
[491.537476] Starting dynamic subtest: eDP-1-pipe-A
[498.450183] Dynamic subtest eDP-1-pipe-A: SUCCESS (6.911s)
[498.452695] Subtest atomic-setmode: SUCCESS (6.913s)
[499.367173] [135/142] (551s left) i915_hangman (error-state-basic)
[499.418278] Starting subtest: error-state-basic
[499.585252] Subtest error-state-basic: SUCCESS (0.168s)
[499.646964] [136/142] (551s left) kms_psr (cursor_blt)
[499.709178] Starting subtest: cursor_blt
[501.494706] Subtest cursor_blt: SUCCESS (1.784s)
[502.435145] [137/142] (548s left) kms_flip (2x-wf_vblank-ts-check)
[502.497309] Starting subtest: 2x-wf_vblank-ts-check
[502.513112] Subtest 2x-wf_vblank-ts-check: SKIP (0.023s)
[502.582965] [138/142] (548s left) gem_exec_reloc (basic-wc-gtt-active)
[502.647316] Subtest basic-wc-gtt-active: SKIP (0.000s)
[502.688054] [139/142] (548s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[502.746469] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[503.335781] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.591s)
[503.489933] [140/142] (547s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[503.570899] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[522.404993] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (18.833s)
[523.296386] [141/142] (528s left) kms_vblank (pipe-d-query-idle-hang)
[523.371788] Starting subtest: pipe-D-query-idle-hang
[538.428623] Subtest pipe-D-query-idle-hang: SUCCESS (15.055s)
[539.353677] [142/142] (511s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[539.438251] Starting subtest: primary-yf-tiled-reflect-x-90
[539.442842] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[539.491277] Closing watchdogs
Done.