[43.144771] Initializing watchdogs [43.144809] /dev/watchdog0 [43.149764] [001/138] (960s left) kms_cursor_crc (cursor-onscreen-64x64) [43.263241] Starting subtest: cursor-onscreen-64x64 [43.272430] Starting dynamic subtest: pipe-A-eDP-1 [45.565229] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.292s) [45.594033] Starting dynamic subtest: pipe-D-eDP-1 [48.442742] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.855s) [48.443894] Subtest cursor-onscreen-64x64: SUCCESS (5.179s) [49.330276] [002/138] (954s left) kms_cursor_crc (cursor-sliding-32x10) [49.431822] Starting subtest: cursor-sliding-32x10 [49.459184] Subtest cursor-sliding-32x10: SKIP (0.025s) [49.631279] [003/138] (954s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt) [49.708835] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt [54.955607] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (5.248s) [55.071963] [004/138] (948s left) kms_addfb_basic (framebuffer-vs-set-tiling) [55.121698] Starting subtest: framebuffer-vs-set-tiling [55.124130] Subtest framebuffer-vs-set-tiling: SKIP (0.000s) [55.214889] [005/138] (948s left) kms_ccs (pipe-c-ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc) [55.604901] Starting subtest: pipe-C-ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc [55.607425] Subtest pipe-C-ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s) [56.442968] [006/138] (947s left) kms_plane_scaling (planes-downscale-factor-0-75) [56.506205] Starting subtest: planes-downscale-factor-0-75 [56.507493] Starting dynamic subtest: pipe-A-eDP-1 [56.516732] Dynamic subtest pipe-A-eDP-1: SKIP (0.010s) [56.525558] Starting dynamic subtest: pipe-B-eDP-1 [56.537113] Dynamic subtest pipe-B-eDP-1: SKIP (0.019s) [56.545530] Starting dynamic subtest: pipe-C-eDP-1 [56.555139] Dynamic subtest pipe-C-eDP-1: SKIP (0.019s) [56.562814] Starting dynamic subtest: pipe-D-eDP-1 [56.575117] Dynamic subtest pipe-D-eDP-1: SKIP (0.019s) [56.577148] Subtest planes-downscale-factor-0-75: SKIP (0.068s) [56.659302] [007/138] (947s left) v3d/v3d_submit_csd (bad-multisync-pad) [56.720689] Subtest bad-multisync-pad: SKIP (0.000s) [56.754443] [008/138] (947s left) gem_ctx_param (set-priority-invalid-size) [56.787928] Starting subtest: set-priority-invalid-size [56.789231] Subtest set-priority-invalid-size: SUCCESS (0.000s) [56.842018] [009/138] (946s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [56.911284] Starting subtest: addfb25-yf-tiled-legacy [56.912495] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [56.997153] [010/138] (946s left) gem_reg_read (timestamp-moving) [57.041139] Starting subtest: timestamp-moving [58.042547] Subtest timestamp-moving: SUCCESS (1.001s) [58.102083] [011/138] (945s left) kms_ccs (pipe-a-ccs-on-another-bo-4-tiled-mtl-rc-ccs) [58.484923] Starting subtest: pipe-A-ccs-on-another-bo-4-tiled-mtl-rc-ccs [58.486226] Subtest pipe-A-ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.000s) [59.401988] [012/138] (944s left) gem_tiled_blits (basic) [59.452731] Subtest basic: SKIP (0.000s) [59.475891] [013/138] (944s left) kms_chamelium_color (ctm-0-25) [59.537843] Subtest ctm-0-25: SKIP (0.000s) [59.553331] [014/138] (944s left) gem_fence_thrash (bo-write-verify-threaded-none) [59.603269] Starting subtest: bo-write-verify-threaded-none [59.606513] Subtest bo-write-verify-threaded-none: SKIP (0.001s) [59.631658] [015/138] (944s left) gem_exec_fence (syncobj-timeline-invalid-wait) [60.214938] Starting subtest: syncobj-timeline-invalid-wait [60.216338] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.003s) [61.512422] [016/138] (942s left) gem_ctx_persistence (legacy-engines-queued) [61.579145] Starting subtest: legacy-engines-queued [61.580386] Starting dynamic subtest: render [61.626799] Dynamic subtest render: SUCCESS (0.048s) [61.636919] Starting dynamic subtest: bsd1 [63.466203] Dynamic subtest bsd1: SUCCESS (1.836s) [63.476807] Starting dynamic subtest: bsd2 [65.449180] Dynamic subtest bsd2: SUCCESS (1.981s) [65.459630] Starting dynamic subtest: blt [65.497993] Dynamic subtest blt: SUCCESS (0.050s) [65.508558] Starting dynamic subtest: vebox [67.432853] Dynamic subtest vebox: SUCCESS (1.932s) [67.434607] Subtest legacy-engines-queued: SUCCESS (5.852s) [67.497606] [017/138] (936s left) kms_sequence (get-forked-busy) [67.560900] Starting subtest: get-forked-busy [67.562214] Starting dynamic subtest: pipe-A-eDP-1 [69.491440] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.929s) [69.500740] Starting dynamic subtest: pipe-B-eDP-1 [72.180832] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.689s) [72.192543] Starting dynamic subtest: pipe-C-eDP-1 [74.856415] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.673s) [74.866220] Starting dynamic subtest: pipe-D-eDP-1 [77.566194] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.709s) [77.567282] Subtest get-forked-busy: SUCCESS (10.006s) [78.461109] [018/138] (925s left) v3d/v3d_get_bo_offset (create-get-offsets) [78.526258] Subtest create-get-offsets: SKIP (0.000s) [78.574334] [019/138] (925s left) kms_flip (flip-vs-dpms-off-vs-modeset) [78.618435] Starting subtest: flip-vs-dpms-off-vs-modeset [78.619507] Starting dynamic subtest: A-eDP1 [82.486763] Dynamic subtest A-eDP1: SUCCESS (3.866s) [82.496889] Starting dynamic subtest: B-eDP1 [85.941724] Dynamic subtest B-eDP1: SUCCESS (3.456s) [85.951673] Starting dynamic subtest: C-eDP1 [89.398393] Dynamic subtest C-eDP1: SUCCESS (3.455s) [89.408560] Starting dynamic subtest: D-eDP1 [92.853892] Dynamic subtest D-eDP1: SUCCESS (3.456s) [92.860046] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (14.244s) [93.769223] [020/138] (910s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [93.836112] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc [93.838209] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [93.911372] [021/138] (910s left) kms_getfb (getfb2-handle-zero) [93.962463] Starting subtest: getfb2-handle-zero [93.963800] Subtest getfb2-handle-zero: SUCCESS (0.000s) [94.049151] [022/138] (910s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt) [94.112561] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt [94.114677] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [94.197732] [023/138] (909s left) kms_color (ctm-signed) [94.278958] Starting subtest: ctm-signed [94.280154] Starting dynamic subtest: pipe-A [96.433154] Dynamic subtest pipe-A: SUCCESS (2.153s) [96.444053] Starting dynamic subtest: pipe-B [99.463281] Dynamic subtest pipe-B: SUCCESS (3.030s) [99.473412] Starting dynamic subtest: pipe-C [102.338291] Dynamic subtest pipe-C: SUCCESS (2.875s) [102.348117] Starting dynamic subtest: pipe-D [105.140384] Dynamic subtest pipe-D: SUCCESS (2.802s) [105.141611] Subtest ctm-signed: SUCCESS (10.862s) [106.056672] [024/138] (898s left) kms_ccs (pipe-b-crc-sprite-planes-basic-4-tiled-dg2-mc-ccs) [106.436162] Starting subtest: pipe-B-crc-sprite-planes-basic-4-tiled-dg2-mc-ccs [106.438478] Subtest pipe-B-crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.001s) [107.339036] [025/138] (896s left) kms_ccs (pipe-a-crc-primary-rotation-180-y-tiled-ccs) [107.699406] Starting subtest: pipe-A-crc-primary-rotation-180-y-tiled-ccs [107.702107] Subtest pipe-A-crc-primary-rotation-180-y-tiled-ccs: SKIP (0.000s) [108.615848] [026/138] (895s left) kms_flip (flip-vs-rmfb-interruptible) [108.674197] Starting subtest: flip-vs-rmfb-interruptible [108.681728] Starting dynamic subtest: A-eDP1 [117.431932] Dynamic subtest A-eDP1: SUCCESS (8.750s) [117.446542] Starting dynamic subtest: B-eDP1 [126.135916] Dynamic subtest B-eDP1: SUCCESS (8.702s) [126.148079] Starting dynamic subtest: C-eDP1 [134.892792] Dynamic subtest C-eDP1: SUCCESS (8.755s) [134.905072] Starting dynamic subtest: D-eDP1 [143.597268] Dynamic subtest D-eDP1: SUCCESS (8.703s) [143.605416] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.931s) [144.906341] [027/138] (859s left) gem_userptr_blits (unsync-unmap-after-close) [144.963915] Subtest unsync-unmap-after-close: SKIP (0.000s) [145.063408] [028/138] (859s left) gem_wait (invalid-flags) [145.127934] Starting subtest: invalid-flags [145.129248] Subtest invalid-flags: SUCCESS (0.000s) [145.338944] [029/138] (858s left) kms_prime (basic-crc-vgem) [145.881241] Starting subtest: basic-crc-vgem [145.882447] Starting dynamic subtest: second-to-first [147.022804] Dynamic subtest second-to-first: SUCCESS (1.143s) [147.024552] Subtest basic-crc-vgem: SUCCESS (1.143s) [147.094380] [030/138] (857s left) gem_exec_params (sol-reset-invalid) [147.192321] Starting subtest: sol-reset-invalid [147.195493] Subtest sol-reset-invalid: SUCCESS (0.002s) [148.533829] [031/138] (855s left) v3d/v3d_perfmon (create-two-perfmon) [148.599454] Subtest create-two-perfmon: SKIP (0.000s) [148.642310] [032/138] (855s left) gem_userptr_blits (relocations) [148.694315] Starting subtest: relocations [148.696387] Subtest relocations: SKIP (0.000s) [148.801609] [033/138] (855s left) dmabuf_sync_file (import-multiple-read-write) [148.872891] Starting subtest: import-multiple-read-write [148.878988] Subtest import-multiple-read-write: SUCCESS (0.006s) [148.931988] [034/138] (855s left) gem_exec_reloc (basic-cpu-gtt-active) [148.972395] Subtest basic-cpu-gtt-active: SKIP (0.000s) [149.017201] [035/138] (855s left) gem_exec_schedule (preempt-other) [149.062066] Starting subtest: preempt-other [149.063098] Starting dynamic subtest: rcs0 [149.123735] Dynamic subtest rcs0: SUCCESS (0.061s) [149.134081] Starting dynamic subtest: bcs0 [149.202832] Dynamic subtest bcs0: SUCCESS (0.078s) [149.214705] Starting dynamic subtest: vcs0 [149.260235] Dynamic subtest vcs0: SUCCESS (0.057s) [149.264317] Starting dynamic subtest: vcs1 [149.344212] Dynamic subtest vcs1: SUCCESS (0.083s) [149.349887] Starting dynamic subtest: vecs0 [149.438109] Dynamic subtest vecs0: SUCCESS (0.093s) [149.449052] Starting dynamic subtest: ccs0 [149.496069] Dynamic subtest ccs0: SUCCESS (0.058s) [149.497490] Subtest preempt-other: SUCCESS (0.434s) [150.539746] [036/138] (853s left) kms_big_fb (4-tiled-64bpp-rotate-90) [150.621674] Starting subtest: 4-tiled-64bpp-rotate-90 [150.638023] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.016s) [150.741613] [037/138] (853s left) sw_sync (sync_expired_merge) [150.789986] Starting subtest: sync_expired_merge [151.866527] Subtest sync_expired_merge: SUCCESS (1.074s) [151.906705] [038/138] (852s left) gem_exec_reloc (basic-range) [151.955772] Subtest basic-range: SKIP (0.000s) [152.000214] [039/138] (852s left) kms_addfb_basic (invalid-set-prop) [152.039281] Starting subtest: invalid-set-prop [152.040387] Subtest invalid-set-prop: SUCCESS (0.000s) [152.152887] [040/138] (852s left) kms_pm_dc (dc9-dpms) [153.230535] Starting subtest: dc9-dpms [154.375226] Subtest dc9-dpms: SUCCESS (1.143s) [154.426371] [041/138] (850s left) kms_ccs (pipe-c-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs) [154.827551] Starting subtest: pipe-C-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs [154.830986] Subtest pipe-C-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.001s) [155.711431] [042/138] (848s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs) [155.749912] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs [155.751821] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s) [155.924302] [043/138] (848s left) kms_cursor_legacy (cursora-vs-flipa-atomic) [156.002027] Starting subtest: cursorA-vs-flipA-atomic [167.190860] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.185s) [168.054772] [044/138] (836s left) gem_close_race (multigpu-basic-process) [168.091427] Starting subtest: multigpu-basic-process [168.093595] Subtest multigpu-basic-process: SKIP (0.000s) [168.296149] [045/138] (836s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted) [168.349276] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted [168.455696] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.103s) [168.518244] [046/138] (836s left) i915_hangman (hangcheck-unterminated) [168.577096] Starting subtest: hangcheck-unterminated [180.456963] Subtest hangcheck-unterminated: SUCCESS (11.878s) [180.560237] [047/138] (824s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc) [180.639625] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc [180.641498] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [180.726194] [048/138] (823s left) gem_exec_balancer (full-pulse) [180.775628] Starting subtest: full-pulse [185.097485] Subtest full-pulse: SUCCESS (4.322s) [185.340844] [049/138] (819s left) kms_big_fb (linear-addfb) [185.417418] Starting subtest: linear-addfb [185.418380] Subtest linear-addfb: SUCCESS (0.000s) [185.504611] [050/138] (819s left) kms_chamelium_frames (hdmi-crc-single) [185.860810] Subtest hdmi-crc-single: SKIP (0.000s) [186.723616] [051/138] (817s left) gem_exec_fence (long-history) [187.158964] Starting subtest: long-history [194.478519] Subtest long-history: SUCCESS (7.320s) [196.521561] [052/138] (808s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt) [196.596360] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt [196.598368] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s) [196.680227] [053/138] (808s left) syncobj_timeline (invalid-multi-wait-available-unsubmitted-signaled) [196.738487] Starting subtest: invalid-multi-wait-available-unsubmitted-signaled [196.739545] Subtest invalid-multi-wait-available-unsubmitted-signaled: SUCCESS (0.001s) [196.804336] [054/138] (807s left) kms_busy (extended-modeset-hang-oldfb) [196.892625] Starting subtest: extended-modeset-hang-oldfb [196.893822] Starting dynamic subtest: pipe-A [211.523654] Dynamic subtest pipe-A: SUCCESS (14.628s) [211.541561] Starting dynamic subtest: pipe-D [236.429338] Dynamic subtest pipe-D: SUCCESS (24.899s) [236.430496] Subtest extended-modeset-hang-oldfb: SUCCESS (39.538s) [237.312881] [055/138] (767s left) gem_lmem_swapping (verify) [237.367734] Subtest verify: SKIP (0.000s) [237.392484] [056/138] (767s left) kms_async_flips (test-time-stamp) [237.453559] Starting subtest: test-time-stamp [237.825427] Starting dynamic subtest: pipe-A-eDP-1 [238.684231] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.856s) [239.061983] Starting dynamic subtest: pipe-B-eDP-1 [239.929775] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.876s) [240.306708] Starting dynamic subtest: pipe-C-eDP-1 [241.211118] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.915s) [241.597498] Starting dynamic subtest: pipe-D-eDP-1 [242.489931] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.902s) [242.491383] Subtest test-time-stamp: SUCCESS (5.036s) [243.786725] [057/138] (760s left) kms_flip (2x-wf_vblank-ts-check-interruptible) [243.853197] Starting subtest: 2x-wf_vblank-ts-check-interruptible [243.869886] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.015s) [243.937980] [058/138] (760s left) kms_ccs (pipe-b-bad-aux-stride-y-tiled-gen12-mc-ccs) [244.343394] Starting subtest: pipe-B-bad-aux-stride-y-tiled-gen12-mc-ccs [244.346569] Subtest pipe-B-bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.000s) [245.194509] [059/138] (759s left) gem_readwrite (beyond-eob) [245.253061] Subtest beyond-EOB: SKIP (0.000s) [245.284041] [060/138] (759s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render) [245.344600] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render [248.705793] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (3.362s) [248.815187] [061/138] (756s left) gem_mmap_wc (write-prefaulted) [248.862907] Subtest write-prefaulted: SKIP (0.000s) [248.894035] [062/138] (755s left) gem_exec_reloc (basic-cpu-read) [248.926645] Subtest basic-cpu-read: SKIP (0.000s) [248.987038] [063/138] (755s left) vc4/vc4_tiling (set-bad-handle) [249.061136] Subtest set-bad-handle: SKIP (0.000s) [249.110526] [064/138] (755s left) prime_busy (after-wait) [249.158972] Starting subtest: after-wait [249.162551] Starting dynamic subtest: rcs0 [249.185451] Dynamic subtest rcs0: SUCCESS (0.023s) [249.197996] Starting dynamic subtest: bcs0 [249.225996] Dynamic subtest bcs0: SUCCESS (0.040s) [249.239215] Starting dynamic subtest: vcs0 [249.265479] Dynamic subtest vcs0: SUCCESS (0.038s) [249.277748] Starting dynamic subtest: vcs1 [249.280886] Dynamic subtest vcs1: SUCCESS (0.014s) [249.292186] Starting dynamic subtest: vecs0 [249.302589] Dynamic subtest vecs0: SUCCESS (0.022s) [249.309579] Starting dynamic subtest: ccs0 [249.322843] Dynamic subtest ccs0: SUCCESS (0.019s) [249.435573] Subtest after-wait: SUCCESS (0.274s) [249.500716] [065/138] (755s left) kms_ccs (pipe-d-crc-primary-basic-y-tiled-gen12-rc-ccs-cc) [249.904295] Starting subtest: pipe-D-crc-primary-basic-y-tiled-gen12-rc-ccs-cc [249.907444] Subtest pipe-D-crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s) [250.751569] [066/138] (754s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt) [250.843810] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt [250.845683] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [250.931397] [067/138] (754s left) kms_psr2_sf (cursor-plane-update-sf) [256.130929] Starting subtest: cursor-plane-update-sf [256.136494] Starting dynamic subtest: pipe-A-eDP-1 [257.517432] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.378s) [257.527630] Starting dynamic subtest: pipe-B-eDP-1 [258.903971] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.389s) [258.905290] Subtest cursor-plane-update-sf: SUCCESS (2.774s) [259.850982] [068/138] (745s left) i915_pm_rps (reset) [259.903295] Starting subtest: reset [259.933249] Subtest reset: FAIL (0.013s) [259.961186] [069/138] (745s left) gem_pxp (hw-rejects-pxp-buffer) [262.543816] Starting subtest: hw-rejects-pxp-buffer [262.545608] Subtest hw-rejects-pxp-buffer: SUCCESS (0.000s) [262.626275] [070/138] (742s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render) [262.679583] Starting subtest: fbc-rgb101010-draw-render [266.295638] Subtest fbc-rgb101010-draw-render: SUCCESS (3.618s) [266.412110] [071/138] (738s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite) [266.468450] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite [269.016420] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (2.549s) [269.144498] [072/138] (735s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling) [269.236316] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling [269.238456] Starting dynamic subtest: pipe-A-default-mode [269.553506] Dynamic subtest pipe-A-default-mode: SKIP (0.313s) [269.556062] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.317s) [270.479689] [073/138] (734s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0) [270.544288] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0 [271.588796] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: FAIL (0.981s) [271.660954] [074/138] (733s left) syncobj_timeline (single-wait-for-submit-available-signaled) [271.699963] Starting subtest: single-wait-for-submit-available-signaled [271.701228] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s) [271.748439] [075/138] (733s left) kms_ccs (pipe-c-bad-pixel-format-4-tiled-mtl-rc-ccs-cc) [272.139451] Starting subtest: pipe-C-bad-pixel-format-4-tiled-mtl-rc-ccs-cc [272.140836] Subtest pipe-C-bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.000s) [273.038023] [076/138] (732s left) kms_cursor_legacy (forked-bo) [273.141927] Starting subtest: forked-bo [273.143122] Starting dynamic subtest: pipe-A [278.611663] Dynamic subtest pipe-A: SUCCESS (5.464s) [278.625604] Starting dynamic subtest: pipe-B [284.151264] Dynamic subtest pipe-B: SUCCESS (5.539s) [284.164206] Starting dynamic subtest: pipe-C [289.702529] Dynamic subtest pipe-C: SUCCESS (5.550s) [289.717697] Starting dynamic subtest: pipe-D [295.259706] Dynamic subtest pipe-D: SUCCESS (5.556s) [295.273660] Starting dynamic subtest: all-pipes [300.818726] Dynamic subtest all-pipes: SUCCESS (5.557s) [300.819963] Subtest forked-bo: SUCCESS (27.674s) [300.969638] [077/138] (704s left) kms_plane_cursor (primary) [301.050210] Starting subtest: primary [301.052190] Starting dynamic subtest: pipe-A-eDP-1-size-64 [303.968734] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.917s) [303.992306] Starting dynamic subtest: pipe-A-eDP-1-size-128 [306.934334] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.952s) [306.960609] Starting dynamic subtest: pipe-A-eDP-1-size-256 [309.890419] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.941s) [310.205262] Starting dynamic subtest: pipe-B-eDP-1-size-64 [313.983435] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.788s) [314.009409] Starting dynamic subtest: pipe-B-eDP-1-size-128 [316.907163] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.908s) [316.935269] Starting dynamic subtest: pipe-B-eDP-1-size-256 [319.899600] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.974s) [320.224903] Starting dynamic subtest: pipe-C-eDP-1-size-64 [323.463795] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.251s) [323.488877] Starting dynamic subtest: pipe-C-eDP-1-size-128 [325.985064] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.504s) [326.013503] Starting dynamic subtest: pipe-C-eDP-1-size-256 [328.497506] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.494s) [328.815619] Starting dynamic subtest: pipe-D-eDP-1-size-64 [332.113623] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (3.309s) [332.140690] Starting dynamic subtest: pipe-D-eDP-1-size-128 [334.637625] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.505s) [334.659175] Starting dynamic subtest: pipe-D-eDP-1-size-256 [337.181861] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.527s) [337.487159] Subtest primary: SUCCESS (36.437s) [338.382368] [078/138] (666s left) gem_exec_schedule (deep) [338.562317] Starting subtest: deep [338.563530] Starting dynamic subtest: rcs0 [345.202649] Dynamic subtest rcs0: SUCCESS (6.641s) [345.210464] Starting dynamic subtest: vcs0 [351.792357] Dynamic subtest vcs0: SUCCESS (6.589s) [351.806931] Starting dynamic subtest: vcs1 [358.368283] Dynamic subtest vcs1: SUCCESS (6.576s) [358.382038] Starting dynamic subtest: vecs0 [364.845507] Dynamic subtest vecs0: SUCCESS (6.476s) [364.862459] Starting dynamic subtest: ccs0 [372.386224] Dynamic subtest ccs0: SUCCESS (7.540s) [372.387394] Subtest deep: SUCCESS (33.827s) [372.858624] [079/138] (632s left) gem_exec_fence (basic-wait-all) [372.912365] Starting subtest: basic-wait-all [372.973099] Subtest basic-wait-all: SUCCESS (0.063s) [374.535437] [080/138] (630s left) kms_big_fb (y-tiled-16bpp-rotate-270) [374.601348] Starting subtest: y-tiled-16bpp-rotate-270 [374.603682] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s) [374.682718] [081/138] (630s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation) [374.733756] Starting subtest: plane-downscale-factor-0-75-with-rotation [374.734963] Starting dynamic subtest: pipe-A-eDP-1 [375.158775] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.426s) [375.170220] Starting dynamic subtest: pipe-B-eDP-1 [376.731245] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.570s) [376.743791] Starting dynamic subtest: pipe-C-eDP-1 [378.297802] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.565s) [378.311972] Starting dynamic subtest: pipe-D-eDP-1 [379.867253] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.566s) [379.869564] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (5.135s) [381.134823] [082/138] (624s left) v3d/v3d_wait_bo (used-bo-0ns) [381.207953] Subtest used-bo-0ns: SKIP (0.000s) [381.253989] [083/138] (624s left) perf (global-sseu-config-invalid) [381.384761] Subtest global-sseu-config-invalid: SKIP (0.000s) [381.400630] [084/138] (623s left) gem_close (basic) [381.445612] Starting subtest: basic [381.446640] Subtest basic: SUCCESS (0.000s) [381.532363] [085/138] (623s left) gem_exec_capture (capture) [381.597711] Starting subtest: capture [381.599457] Starting dynamic subtest: rcs0-smem [382.453842] Dynamic subtest rcs0-smem: SUCCESS (0.855s) [382.466332] Starting dynamic subtest: bcs0-smem [383.279443] Dynamic subtest bcs0-smem: SUCCESS (0.825s) [383.289495] Starting dynamic subtest: vcs0-smem [384.119482] Dynamic subtest vcs0-smem: SUCCESS (0.839s) [384.126085] Starting dynamic subtest: vcs1-smem [385.437416] Dynamic subtest vcs1-smem: SUCCESS (1.318s) [385.441787] Starting dynamic subtest: vecs0-smem [386.262839] Dynamic subtest vecs0-smem: SUCCESS (0.825s) [386.267266] Starting dynamic subtest: ccs0-smem [387.095766] Dynamic subtest ccs0-smem: SUCCESS (0.833s) [387.097110] Subtest capture: SUCCESS (5.499s) [387.185791] [086/138] (618s left) kms_chamelium_hpd (vga-hpd-fast) [387.544591] Subtest vga-hpd-fast: SKIP (0.000s) [388.386203] [087/138] (617s left) kms_psr (psr2_dpms) [388.431061] Starting subtest: psr2_dpms [391.526811] Subtest psr2_dpms: SUCCESS (3.094s) [392.460861] [088/138] (612s left) kms_ccs (pipe-b-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc) [392.856915] Starting subtest: pipe-B-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc [392.860446] Subtest pipe-B-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.001s) [393.687934] [089/138] (611s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt) [393.739267] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt [393.741616] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [393.810820] [090/138] (611s left) gem_exec_flush (basic-wb-prw-default) [393.874150] Starting subtest: basic-wb-prw-default [399.338669] Subtest basic-wb-prw-default: SUCCESS (5.464s) [399.519436] [091/138] (605s left) sw_sync (alloc_merge_fence) [399.558441] Starting subtest: alloc_merge_fence [399.559536] Subtest alloc_merge_fence: SUCCESS (0.000s) [399.604222] [092/138] (605s left) tools_test (tools_test) [399.643028] Starting subtest: tools_test [399.734978] Subtest tools_test: SUCCESS (0.101s) [399.791024] [093/138] (605s left) syncobj_timeline (multi-wait-for-submit-available-submitted) [399.826652] Starting subtest: multi-wait-for-submit-available-submitted [399.827626] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s) [399.876467] [094/138] (605s left) kms_psr (primary_mmap_cpu) [399.928127] Starting subtest: primary_mmap_cpu [401.699764] Subtest primary_mmap_cpu: SUCCESS (1.771s) [402.623376] [095/138] (602s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc) [402.687392] Starting subtest: psr-rgb101010-draw-mmap-wc [407.712795] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (5.023s) [407.834094] [096/138] (597s left) kms_vblank (ts-continuation-modeset) [407.914184] Starting subtest: ts-continuation-modeset [407.915235] Starting dynamic subtest: pipe-A-eDP-1 [409.492424] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.572s) [409.504630] Starting dynamic subtest: pipe-D-eDP-1 [411.844167] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.350s) [411.845686] Subtest ts-continuation-modeset: SUCCESS (3.930s) [412.747555] [097/138] (592s left) kms_ccs (pipe-d-bad-pixel-format-4-tiled-mtl-rc-ccs-cc) [413.159090] Starting subtest: pipe-D-bad-pixel-format-4-tiled-mtl-rc-ccs-cc [413.160796] Subtest pipe-D-bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.000s) [413.986936] [098/138] (591s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180) [414.060072] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180 [415.149751] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.090s) [415.291722] [099/138] (590s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-pwrite) [415.342976] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-pwrite [420.355651] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-pwrite: SUCCESS (5.013s) [420.502497] [100/138] (585s left) api_intel_bb (delta-check) [420.562112] Starting subtest: delta-check [420.567405] Subtest delta-check: SUCCESS (0.006s) [420.676717] [101/138] (585s left) kms_ccs (pipe-c-random-ccs-data-4-tiled-dg2-mc-ccs) [421.071555] Starting subtest: pipe-C-random-ccs-data-4-tiled-dg2-mc-ccs [421.075379] Subtest pipe-C-random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.000s) [421.963679] [102/138] (583s left) gem_mmap_gtt (hang-user) [422.018207] Subtest hang-user: SKIP (0.000s) [422.054866] [103/138] (583s left) kms_ccs (pipe-d-missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc) [422.491031] Starting subtest: pipe-D-missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc [422.492852] Subtest pipe-D-missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.000s) [423.287922] [104/138] (582s left) gem_render_copy (y-tiled-to-vebox-x-tiled) [423.327491] Starting subtest: y-tiled-to-vebox-x-tiled [423.329855] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s) [423.505155] [105/138] (582s left) device_reset (unbind-cold-reset-rebind) [423.600931] Subtest unbind-cold-reset-rebind: SKIP (0.000s) [423.662105] [106/138] (582s left) gem_fence_thrash (bo-write-verify-y) [423.729575] Starting subtest: bo-write-verify-y [423.734154] Subtest bo-write-verify-y: SKIP (0.002s) [423.751482] [107/138] (582s left) kms_rotation_crc (primary-x-tiled-reflect-x-180) [423.837146] Starting subtest: primary-x-tiled-reflect-x-180 [431.402909] Subtest primary-x-tiled-reflect-x-180: SUCCESS (7.568s) [432.651575] [108/138] (573s left) kms_flip (2x-blocking-absolute-wf_vblank) [432.706938] Starting subtest: 2x-blocking-absolute-wf_vblank [432.719288] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.014s) [432.798074] [109/138] (573s left) perf_pmu (module-unload) [432.861853] Starting subtest: module-unload [469.899180] Subtest module-unload: SUCCESS (37.035s) [469.914687] [110/138] (535s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc) [470.895062] Starting subtest: fbc-rgb101010-draw-mmap-wc [474.551536] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (3.661s) [474.645348] [111/138] (531s left) gen7_exec_parse (basic-allowed) [474.692337] Subtest basic-allowed: SKIP (0.000s) [474.712975] [112/138] (531s left) gem_eio (hibernate) [474.814851] Starting subtest: hibernate [489.541657] Subtest hibernate: SUCCESS (14.726s) [494.504724] [113/138] (514s left) syncobj_wait (multi-wait-all-for-submit-signaled) [494.554760] Starting subtest: multi-wait-all-for-submit-signaled [494.555977] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s) [494.618141] [114/138] (514s left) drm_fdinfo (virtual-idle) [494.665998] Starting subtest: virtual-idle [497.723931] Subtest virtual-idle: SUCCESS (3.055s) [497.790757] [115/138] (511s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite) [497.871358] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite [497.873169] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [497.949733] [116/138] (511s left) kms_lease (lease-revoke) [498.007484] Starting subtest: lease-revoke [498.008602] Starting dynamic subtest: pipe-A-eDP-1 [498.030390] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.023s) [498.036104] Starting dynamic subtest: pipe-B-eDP-1 [498.051904] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.021s) [498.058831] Starting dynamic subtest: pipe-C-eDP-1 [498.083052] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.030s) [498.098580] Starting dynamic subtest: pipe-D-eDP-1 [498.124400] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.040s) [498.125622] Subtest lease-revoke: SUCCESS (0.118s) [498.231724] [117/138] (510s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels) [498.293140] Starting subtest: plane-all-modeset-transition-internal-panels [498.294276] Starting dynamic subtest: pipe-A-eDP-1 [499.964634] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.669s) [500.295069] Starting dynamic subtest: pipe-B-eDP-1 [501.700251] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.418s) [502.011456] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (3.719s) [502.925404] [118/138] (506s left) gem_exec_whisper (basic-queues-forked) [502.986036] Starting subtest: basic-queues-forked [526.636094] Subtest basic-queues-forked: SUCCESS (23.646s) [526.821318] [119/138] (482s left) gem_eio (create) [527.068524] Starting subtest: create [528.461992] Subtest create: SUCCESS (1.396s) [530.538377] [120/138] (478s left) kms_atomic_transition (plane-all-modeset-transition-fencing) [530.628310] Starting subtest: plane-all-modeset-transition-fencing [530.630572] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s) [530.691385] [121/138] (478s left) gem_ctx_exec (basic-close-race) [530.753703] Starting subtest: basic-close-race [536.210395] Subtest basic-close-race: SUCCESS (5.451s) [537.521494] [122/138] (471s left) kms_atomic_interruptible (legacy-pageflip) [538.079457] Starting subtest: legacy-pageflip [538.080691] Starting dynamic subtest: pipe-A-eDP-1 [545.559945] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.481s) [545.561510] Subtest legacy-pageflip: SUCCESS (7.483s) [546.486739] [123/138] (462s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen) [546.567616] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen [546.569858] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [546.647266] [124/138] (462s left) gem_exec_params (invalid-fence-in) [546.696700] Starting subtest: invalid-fence-in [546.697940] Subtest invalid-fence-in: SUCCESS (0.000s) [546.781766] [125/138] (462s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render) [546.855625] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render [551.812437] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (4.958s) [551.928410] [126/138] (457s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip) [551.990406] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip [551.992548] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s) [552.087068] [127/138] (457s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling) [552.132777] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling [552.133900] Starting dynamic subtest: pipe-A-default-mode [552.421521] Dynamic subtest pipe-A-default-mode: SKIP (0.286s) [552.423636] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.288s) [553.358627] [128/138] (455s left) gem_exec_schedule (u-semaphore-resolve) [553.431373] Starting subtest: u-semaphore-resolve [553.458980] Subtest u-semaphore-resolve: SUCCESS (0.027s) [553.782302] [129/138] (455s left) kms_legacy_colorkey (invalid-plane) [553.854258] Starting subtest: invalid-plane [553.855240] Starting dynamic subtest: zero-id [553.856155] Dynamic subtest zero-id: SUCCESS (0.000s) [553.869918] Starting dynamic subtest: outrange-id [553.870853] Dynamic subtest outrange-id: SUCCESS (0.000s) [553.871761] Subtest invalid-plane: SUCCESS (0.001s) [553.919193] [130/138] (455s left) kms_getfb (getfb-handle-zero) [553.964753] Starting subtest: getfb-handle-zero [553.965826] Subtest getfb-handle-zero: SUCCESS (0.000s) [554.051257] [131/138] (455s left) kms_content_protection (uevent) [554.168079] Starting subtest: uevent [557.657912] Subtest uevent: SKIP (3.488s) [558.918588] [132/138] (450s left) gem_userptr_blits (nohangcheck) [559.004328] Starting subtest: nohangcheck [560.284314] Subtest nohangcheck: FAIL (1.245s) [560.317967] [133/138] (449s left) i915_getparams_basic (basic-subslice-total) [560.377621] Starting subtest: basic-subslice-total [560.379967] Subtest basic-subslice-total: SUCCESS (0.000s) [560.445358] [134/138] (449s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [560.520352] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu [565.531999] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (5.012s) [565.656815] [135/138] (443s left) kms_ccs (pipe-a-bad-pixel-format-4-tiled-dg2-rc-ccs) [565.709400] Starting subtest: pipe-A-bad-pixel-format-4-tiled-dg2-rc-ccs [565.711737] Subtest pipe-A-bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.000s) [566.874051] [136/138] (442s left) syncobj_timeline (wait-for-submit-delayed-submit) [566.925436] Starting subtest: wait-for-submit-delayed-submit [567.031151] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s) [567.099541] [137/138] (442s left) kms_flip (2x-modeset-vs-vblank-race) [567.156590] Starting subtest: 2x-modeset-vs-vblank-race [567.171476] Subtest 2x-modeset-vs-vblank-race: SKIP (0.015s) [567.244175] [138/138] (442s left) kms_ccs (pipe-b-bad-rotation-90-y-tiled-gen12-rc-ccs-cc) [567.634371] Starting subtest: pipe-B-bad-rotation-90-y-tiled-gen12-rc-ccs-cc [567.637183] Subtest pipe-B-bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s) [568.509952] Closing watchdogs Done.