[43.352459] Initializing watchdogs [43.352601] /dev/watchdog0 [43.367256] [001/144] (960s left) gen7_exec_parse (batch-without-end) [43.490866] Subtest batch-without-end: SKIP (0.000s) [43.517897] [002/144] (960s left) kms_big_joiner (2x-modeset) [43.627308] Subtest 2x-modeset: SKIP (0.000s) [43.652746] [003/144] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt) [43.729850] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt [43.733764] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [43.809311] [004/144] (960s left) gem_exec_whisper (basic-forked) [43.896031] Starting subtest: basic-forked [65.811031] Subtest basic-forked: SUCCESS (21.912s) [65.991311] [005/144] (937s left) perf (invalid-oa-exponent) [66.151853] Starting subtest: invalid-oa-exponent [66.168257] Subtest invalid-oa-exponent: SUCCESS (0.015s) [66.189152] [006/144] (937s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite) [66.257821] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite [71.497417] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.246s) [71.604409] [007/144] (932s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic) [71.744062] Starting subtest: 2x-long-cursor-vs-flip-atomic [71.751089] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s) [71.840715] [008/144] (932s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size) [71.969881] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size [71.974900] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s) [72.111566] [009/144] (931s left) kms_ccs (pipe-b-missing-ccs-buffer-4-tiled-mtl-mc-ccs) [72.503118] Starting subtest: pipe-B-missing-ccs-buffer-4-tiled-mtl-mc-ccs [72.527965] Subtest pipe-B-missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.022s) [73.358584] [010/144] (930s left) api_intel_allocator (gem-pool) [73.426408] Starting subtest: gem-pool [73.437238] Subtest gem-pool: SUCCESS (0.013s) [73.531588] [011/144] (930s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary) [73.610247] Starting subtest: fbc-shrfb-scaledprimary [77.693713] Subtest fbc-shrfb-scaledprimary: SUCCESS (4.086s) [77.826653] [012/144] (926s left) gem_exec_reloc (basic-range) [77.905390] Subtest basic-range: SKIP (0.000s) [77.944271] [013/144] (926s left) gem_exec_fair (basic-none-share) [78.037355] Subtest basic-none-share: SKIP (0.000s) [78.084326] [014/144] (926s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc) [78.169927] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc [80.754270] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (2.590s) [80.875193] [015/144] (923s left) kms_psr2_sf (fbc-overlay-plane-update-continuous-sf) [86.160231] Starting subtest: fbc-overlay-plane-update-continuous-sf [86.163658] Starting dynamic subtest: pipe-A-eDP-1 [86.990533] Dynamic subtest pipe-A-eDP-1: SKIP (0.830s) [87.000770] Starting dynamic subtest: pipe-B-eDP-1 [88.267323] Dynamic subtest pipe-B-eDP-1: SKIP (1.274s) [88.272422] Subtest fbc-overlay-plane-update-continuous-sf: SKIP (2.108s) [89.608084] [016/144] (914s left) gem_exec_params (invalid-ring2) [89.689288] Starting subtest: invalid-ring2 [89.691833] Subtest invalid-ring2: SUCCESS (0.000s) [89.780975] [017/144] (914s left) kms_chamelium_edid (vga-edid-read) [90.154368] Subtest vga-edid-read: SKIP (0.000s) [91.034443] [018/144] (913s left) gem_mmap_wc (write-read-distinct) [91.108564] Subtest write-read-distinct: SKIP (0.000s) [91.158166] [019/144] (913s left) gem_exec_schedule (semaphore-user) [91.254327] Starting subtest: semaphore-user [91.278597] Subtest semaphore-user: SUCCESS (0.029s) [92.511672] [020/144] (911s left) kms_addfb_basic (tile-pitch-mismatch) [92.604210] Starting subtest: tile-pitch-mismatch [92.608277] Subtest tile-pitch-mismatch: SKIP (0.000s) [92.693199] [021/144] (911s left) gem_render_copy_redux (flink) [92.770427] Starting subtest: flink [93.691352] Subtest flink: SUCCESS (0.922s) [93.782771] [022/144] (910s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt) [93.915584] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt [93.919954] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [94.012467] [023/144] (910s left) kms_ccs (pipe-c-bad-rotation-90-y-tiled-ccs) [94.400492] Starting subtest: pipe-C-bad-rotation-90-y-tiled-ccs [94.406598] Subtest pipe-C-bad-rotation-90-y-tiled-ccs: SKIP (0.000s) [95.284369] [024/144] (909s left) kms_cursor_legacy (flip-vs-cursor-legacy) [95.371580] Starting subtest: flip-vs-cursor-legacy [101.751902] Subtest flip-vs-cursor-legacy: SUCCESS (6.377s) [102.648230] [025/144] (901s left) vc4/vc4_wait_seqno (bad-seqno-0ns) [102.720049] Subtest bad-seqno-0ns: SKIP (0.000s) [102.767499] [026/144] (901s left) kms_cursor_legacy (cursor-vs-flip-varying-size) [102.872158] Starting subtest: cursor-vs-flip-varying-size [132.355654] Subtest cursor-vs-flip-varying-size: SUCCESS (29.478s) [133.231856] [027/144] (871s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt) [133.306929] Starting subtest: fbc-rgb101010-draw-mmap-gtt [133.311408] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s) [133.387867] [028/144] (871s left) kms_getfb (getfb2-into-addfb2) [133.443277] Starting subtest: getfb2-into-addfb2 [133.446034] Subtest getfb2-into-addfb2: SUCCESS (0.000s) [133.539039] [029/144] (871s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip) [133.653372] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip [134.765406] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.113s) [134.876047] [030/144] (869s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt) [134.981398] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt [138.336120] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (3.361s) [138.469413] [031/144] (866s left) kms_plane_alpha_blend (constant-alpha-max) [138.560222] Starting subtest: constant-alpha-max [138.873042] Starting dynamic subtest: pipe-A-eDP-1 [140.105795] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.230s) [140.120642] Starting dynamic subtest: pipe-D-eDP-1 [141.992098] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.886s) [141.994582] Subtest constant-alpha-max: SUCCESS (3.431s) [142.917737] [032/144] (861s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled) [142.980339] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled [142.982969] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s) [143.059300] [033/144] (861s left) kms_sequence (queue-busy) [143.159350] Starting subtest: queue-busy [143.161954] Starting dynamic subtest: pipe-A-eDP-1 [145.107030] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.944s) [145.117871] Starting dynamic subtest: pipe-B-eDP-1 [147.845050] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.737s) [147.861287] Starting dynamic subtest: pipe-C-eDP-1 [150.517839] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.669s) [150.528293] Starting dynamic subtest: pipe-D-eDP-1 [153.215728] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.696s) [153.218225] Subtest queue-busy: SUCCESS (10.055s) [154.101472] [034/144] (850s left) core_setmaster (master-drop-set-user) [154.686161] Starting subtest: master-drop-set-user [154.708203] Subtest master-drop-set-user: SUCCESS (0.022s) [154.723483] [035/144] (850s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180) [154.814750] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180 [155.858287] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.046s) [156.010997] [036/144] (848s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render) [156.137499] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render [156.141547] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [156.218815] [037/144] (848s left) kms_psr (psr2-no-drrs) [156.331052] Starting subtest: psr2-no-drrs [156.333406] Starting dynamic subtest: eDP-1 [158.039522] Dynamic subtest eDP-1: SUCCESS (1.709s) [158.042737] Subtest psr2-no-drrs: SUCCESS (1.710s) [158.968965] [038/144] (845s left) perf (short-reads) [159.069601] Starting subtest: short-reads [159.084218] Subtest short-reads: SUCCESS (0.014s) [159.113918] [039/144] (845s left) fbdev (write) [159.182890] Starting subtest: write [159.549831] Subtest write: SUCCESS (0.366s) [159.603403] [040/144] (845s left) prime_busy (after) [159.682633] Starting subtest: after [159.687942] Starting dynamic subtest: rcs0 [159.726333] Dynamic subtest rcs0: SUCCESS (0.040s) [159.742608] Starting dynamic subtest: bcs0 [159.781813] Dynamic subtest bcs0: SUCCESS (0.055s) [159.797912] Starting dynamic subtest: vcs0 [159.826445] Dynamic subtest vcs0: SUCCESS (0.044s) [159.841840] Starting dynamic subtest: vcs1 [159.873699] Dynamic subtest vcs1: SUCCESS (0.043s) [159.889336] Starting dynamic subtest: vecs0 [159.913547] Dynamic subtest vecs0: SUCCESS (0.042s) [159.926280] Starting dynamic subtest: ccs0 [159.957257] Dynamic subtest ccs0: SUCCESS (0.042s) [160.069432] Subtest after: SUCCESS (0.385s) [160.143251] [041/144] (844s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled) [160.213032] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled [160.317577] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.102s) [160.391738] [042/144] (844s left) syncobj_timeline (wait-all-complex) [160.465027] Starting subtest: wait-all-complex [160.685273] Subtest wait-all-complex: SUCCESS (0.220s) [160.758183] [043/144] (844s left) kms_busy (extended-pageflip-hang-newfb) [160.850877] Starting subtest: extended-pageflip-hang-newfb [160.853474] Starting dynamic subtest: pipe-A [174.404632] Dynamic subtest pipe-A: SUCCESS (13.555s) [174.418525] Starting dynamic subtest: pipe-D [189.376344] Dynamic subtest pipe-D: SUCCESS (14.965s) [189.379056] Subtest extended-pageflip-hang-newfb: SUCCESS (28.528s) [190.263580] [044/144] (814s left) kms_ccs (pipe-b-bad-pixel-format-4-tiled-dg2-rc-ccs) [190.688307] Starting subtest: pipe-B-bad-pixel-format-4-tiled-dg2-rc-ccs [190.693566] Subtest pipe-B-bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.000s) [191.518838] [045/144] (813s left) drm_fdinfo (virtual-busy-idle) [191.591462] Starting subtest: virtual-busy-idle [191.596826] Subtest virtual-busy-idle: SKIP (0.000s) [191.662894] [046/144] (813s left) gem_eio (wait-wedge-1us) [191.909874] Starting subtest: wait-wedge-1us [193.641544] Subtest wait-wedge-1us: SUCCESS (1.731s) [193.751517] [047/144] (811s left) kms_flip (2x-flip-vs-blocking-wf-vblank) [193.824761] Starting subtest: 2x-flip-vs-blocking-wf-vblank [193.838539] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.014s) [193.916392] [048/144] (811s left) gem_exec_schedule (preempt-engines) [194.010690] Starting subtest: preempt-engines [194.013444] Starting dynamic subtest: rcs0 [196.353980] Dynamic subtest rcs0: SUCCESS (2.339s) [196.372335] Starting dynamic subtest: bcs0 [198.669946] Dynamic subtest bcs0: SUCCESS (2.317s) [198.688189] Starting dynamic subtest: vcs0 [201.017488] Dynamic subtest vcs0: SUCCESS (2.346s) [201.036400] Starting dynamic subtest: vcs1 [203.387408] Dynamic subtest vcs1: SUCCESS (2.369s) [203.405514] Starting dynamic subtest: vecs0 [205.740157] Dynamic subtest vecs0: SUCCESS (2.352s) [205.758143] Starting dynamic subtest: ccs0 [208.103071] Dynamic subtest ccs0: SUCCESS (2.362s) [208.105663] Subtest preempt-engines: SUCCESS (14.092s) [208.424065] [049/144] (796s left) gem_exec_params (sol-reset-not-gen7) [208.502276] Starting subtest: sol-reset-not-gen7 [208.515424] Subtest sol-reset-not-gen7: SUCCESS (0.010s) [208.608532] [050/144] (796s left) v3d/v3d_submit_csd (bad-multisync-out-sync) [208.670157] Subtest bad-multisync-out-sync: SKIP (0.000s) [208.715491] [051/144] (796s left) gem_pxp (fail-invalid-protected-context) [211.306976] Subtest fail-invalid-protected-context: SKIP (0.000s) [211.380527] [052/144] (793s left) kms_vrr (flip-suspend) [211.513686] Starting subtest: flip-suspend [211.518633] Subtest flip-suspend: SKIP (0.000s) [211.584222] [053/144] (793s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip) [211.654212] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip [211.658453] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [211.712734] [054/144] (793s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs) [211.797625] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs [211.803416] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s) [211.982517] [055/144] (793s left) gem_mmap_wc (read) [212.067078] Subtest read: SKIP (0.000s) [212.119045] [056/144] (793s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs) [212.200128] Starting subtest: mixed-tiled-to-yf-tiled-ccs [212.205242] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s) [212.387129] [057/144] (793s left) kms_prop_blob (blob-prop-core) [212.458370] Starting subtest: blob-prop-core [212.460731] Subtest blob-prop-core: SUCCESS (0.000s) [212.541611] [058/144] (792s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c) [212.613929] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s) [212.666130] [059/144] (792s left) kms_lease (lease-uevent) [212.747731] Starting subtest: lease-uevent [213.765664] Subtest lease-uevent: SUCCESS (1.017s) [213.855502] [060/144] (791s left) gem_render_tiled_blits (basic) [213.935034] Subtest basic: SKIP (0.000s) [213.992319] [061/144] (791s left) gem_exec_fence (submit-chain) [214.203170] Starting subtest: submit-chain [214.239816] Subtest submit-chain: SUCCESS (0.038s) [216.516855] [062/144] (789s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt) [216.643743] Starting subtest: psr-rgb101010-draw-mmap-gtt [216.649184] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s) [216.720685] [063/144] (788s left) syncobj_timeline (invalid-signal-bad-pad) [216.809092] Starting subtest: invalid-signal-bad-pad [216.811767] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [216.898070] [064/144] (788s left) gem_ctx_persistence (legacy-engines-hang) [216.966276] Starting subtest: legacy-engines-hang [216.968802] Starting dynamic subtest: render [217.029083] Dynamic subtest render: SUCCESS (0.063s) [217.047419] Starting dynamic subtest: bsd1 [217.111934] Dynamic subtest bsd1: SUCCESS (0.081s) [217.131124] Starting dynamic subtest: bsd2 [217.161632] Dynamic subtest bsd2: SUCCESS (0.045s) [217.178654] Starting dynamic subtest: blt [217.249716] Dynamic subtest blt: SUCCESS (0.086s) [217.268795] Starting dynamic subtest: vebox [217.334169] Dynamic subtest vebox: SUCCESS (0.085s) [217.336833] Subtest legacy-engines-hang: SUCCESS (0.369s) [217.413384] [065/144] (788s left) kms_ccs (pipe-d-bad-rotation-90-y-tiled-gen12-mc-ccs) [217.848619] Starting subtest: pipe-D-bad-rotation-90-y-tiled-gen12-mc-ccs [217.854357] Subtest pipe-D-bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.000s) [218.735878] [066/144] (787s left) kms_flip (flip-vs-expired-vblank) [218.832167] Starting subtest: flip-vs-expired-vblank [218.834462] Starting dynamic subtest: A-eDP1 [227.637500] Dynamic subtest A-eDP1: SUCCESS (8.806s) [227.657910] Starting dynamic subtest: B-eDP1 [236.470815] Dynamic subtest B-eDP1: SUCCESS (8.832s) [236.489609] Starting dynamic subtest: C-eDP1 [245.296149] Dynamic subtest C-eDP1: SUCCESS (8.821s) [245.315846] Starting dynamic subtest: D-eDP1 [254.126298] Dynamic subtest D-eDP1: SUCCESS (8.829s) [254.132278] Subtest flip-vs-expired-vblank: SUCCESS (35.304s) [255.430770] [067/144] (750s left) kms_psr (pr-cursor-blt) [255.525858] Starting subtest: pr-cursor-blt [255.530370] Subtest pr-cursor-blt: SKIP (0.000s) [255.636568] [068/144] (750s left) kms_ccs (pipe-c-crc-primary-rotation-180-yf-tiled-ccs) [256.067082] Starting subtest: pipe-C-crc-primary-rotation-180-yf-tiled-ccs [256.072986] Subtest pipe-C-crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.000s) [256.953391] [069/144] (748s left) gem_readwrite (write-bad-handle) [257.011187] Subtest write-bad-handle: SKIP (0.000s) [257.051435] [070/144] (748s left) i915_pm_rps (thresholds-idle-park) [257.124900] Starting subtest: thresholds-idle-park [257.127649] Starting dynamic subtest: gt0 [257.135842] Dynamic subtest gt0: SKIP (0.008s) [257.156061] Starting dynamic subtest: gt1 [257.161152] Dynamic subtest gt1: SKIP (0.001s) [257.166226] Subtest thresholds-idle-park: SKIP (0.011s) [257.214274] [071/144] (748s left) drm_fdinfo (basics) [257.276779] Starting subtest: basics [257.279077] Subtest basics: SUCCESS (0.000s) [257.341094] [072/144] (748s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt) [257.487704] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt [257.492034] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [257.577976] [073/144] (748s left) kms_vblank (crtc-id) [257.686765] Starting subtest: crtc-id [257.689317] Starting dynamic subtest: pipe-A-eDP-1 [258.144795] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.458s) [258.164172] Starting dynamic subtest: pipe-D-eDP-1 [259.387298] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.234s) [259.389907] Subtest crtc-id: SUCCESS (1.700s) [260.284989] [074/144] (745s left) kms_atomic_interruptible (legacy-setmode) [260.397977] Starting subtest: legacy-setmode [260.400311] Starting dynamic subtest: pipe-A-eDP-1 [267.328990] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.929s) [267.331677] Subtest legacy-setmode: SUCCESS (6.931s) [268.220951] [075/144] (737s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc) [268.342358] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc [273.272972] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.935s) [273.369977] [076/144] (732s left) kms_ccs (pipe-a-bad-rotation-90-4-tiled-mtl-rc-ccs) [273.756774] Starting subtest: pipe-A-bad-rotation-90-4-tiled-mtl-rc-ccs [274.629383] Subtest pipe-A-bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.874s) [275.829092] [077/144] (730s left) kms_ccs (pipe-a-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs) [276.204716] Starting subtest: pipe-A-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs [278.282385] Subtest pipe-A-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (2.078s) [279.463891] [078/144] (726s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt) [279.563459] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt [279.568691] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [279.645197] [079/144] (726s left) sw_sync (sync_busy_fork) [279.705029] Starting subtest: sync_busy_fork [280.728733] Subtest sync_busy_fork: SUCCESS (1.023s) [280.796327] [080/144] (725s left) i915_pm_rpm (system-suspend-devices) [282.652471] Starting subtest: system-suspend-devices [295.365982] Subtest system-suspend-devices: SUCCESS (12.713s) [296.173649] [081/144] (710s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite) [296.280182] Starting subtest: fbcpsr-rgb565-draw-pwrite [301.284933] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (5.011s) [301.408763] [082/144] (704s left) gem_media_vme [301.540221] [083/144] (704s left) kms_selftest (drm_dp_mst_helper) [301.598656] Starting subtest: drm_dp_mst_helper [301.729916] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode [301.755076] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.029s) [301.776681] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div [301.779074] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.007s) [301.795390] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode [301.797706] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.008s) [301.800026] Subtest drm_dp_mst_helper: SUCCESS (0.177s) [301.966101] [084/144] (704s left) kms_ccs (pipe-c-missing-ccs-buffer-4-tiled-mtl-mc-ccs) [302.389905] Starting subtest: pipe-C-missing-ccs-buffer-4-tiled-mtl-mc-ccs [302.412270] Subtest pipe-C-missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.023s) [303.249836] [085/144] (703s left) kms_atomic (plane-primary-legacy) [303.356725] Starting subtest: plane-primary-legacy [303.359391] Starting dynamic subtest: pipe-A-eDP-1 [303.815073] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.458s) [303.817480] Subtest plane-primary-legacy: SUCCESS (0.460s) [304.703791] [086/144] (701s left) kms_cursor_crc (cursor-rapid-movement-512x512) [304.958023] Starting subtest: cursor-rapid-movement-512x512 [304.962713] Subtest cursor-rapid-movement-512x512: SKIP (0.001s) [305.108391] [087/144] (701s left) syncobj_wait (reset-signaled) [305.175843] Starting subtest: reset-signaled [305.178701] Subtest reset-signaled: SUCCESS (0.000s) [305.272680] [088/144] (701s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y-tiled-gen12-mc-ccs) [305.685947] Starting subtest: pipe-A-crc-sprite-planes-basic-y-tiled-gen12-mc-ccs [305.692193] Subtest pipe-A-crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.001s) [306.542957] [089/144] (699s left) kms_cursor_crc (cursor-onscreen-128x128) [306.750610] Starting subtest: cursor-onscreen-128x128 [306.753079] Starting dynamic subtest: pipe-A-eDP-1 [309.221264] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.467s) [309.258822] Starting dynamic subtest: pipe-D-eDP-1 [312.447884] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.204s) [312.451421] Subtest cursor-onscreen-128x128: SUCCESS (5.696s) [313.332496] [090/144] (693s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite) [313.457499] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite [313.462244] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [313.552081] [091/144] (693s left) kms_addfb_basic (too-high) [313.655473] Starting subtest: too-high [313.658136] Subtest too-high: SUCCESS (0.000s) [313.752946] [092/144] (692s left) kms_plane_lowres (tiling-y) [313.837810] Starting subtest: tiling-y [313.842593] Subtest tiling-y: SKIP (0.000s) [313.905651] [093/144] (692s left) kms_chamelium_audio (dp-audio) [314.317260] Subtest dp-audio: SKIP (0.000s) [315.159866] [094/144] (691s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling) [315.263990] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling [315.266521] Starting dynamic subtest: pipe-A-default-mode [318.139687] Dynamic subtest pipe-A-default-mode: SUCCESS (2.875s) [318.142484] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.877s) [319.038581] [095/144] (687s left) kms_color (ctm-signed) [319.144722] Starting subtest: ctm-signed [319.147430] Starting dynamic subtest: pipe-A [321.388493] Dynamic subtest pipe-A: SUCCESS (2.244s) [321.408230] Starting dynamic subtest: pipe-B [324.402791] Dynamic subtest pipe-B: SUCCESS (3.008s) [324.422855] Starting dynamic subtest: pipe-C [327.300352] Dynamic subtest pipe-C: SUCCESS (2.897s) [327.319905] Starting dynamic subtest: pipe-D [330.166351] Dynamic subtest pipe-D: SUCCESS (2.866s) [330.168942] Subtest ctm-signed: SUCCESS (11.021s) [331.085098] [096/144] (675s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers) [331.179385] Starting subtest: plane-upscale-factor-0-25-with-modifiers [331.181740] Starting dynamic subtest: pipe-A-eDP-1 [331.753095] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.573s) [331.765523] Starting dynamic subtest: pipe-B-eDP-1 [333.480113] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.725s) [333.493352] Starting dynamic subtest: pipe-C-eDP-1 [335.200736] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.718s) [335.220764] Starting dynamic subtest: pipe-D-eDP-1 [336.945780] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.743s) [336.948401] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (5.768s) [338.254498] [097/144] (668s left) perf (gen12-group-concurrent-oa-buffer-read) [338.361190] Starting subtest: gen12-group-concurrent-oa-buffer-read [348.420925] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.058s) [348.459494] [098/144] (658s left) sriov_basic (enable-vfs-autoprobe-off) [348.528554] Subtest enable-vfs-autoprobe-off: SKIP (0.000s) [348.579101] [099/144] (658s left) gem_wait (await) [348.668979] Starting subtest: await [348.671521] Starting dynamic subtest: all-engines [349.762426] Dynamic subtest all-engines: SUCCESS (1.092s) [349.789253] Starting dynamic subtest: rcs0 [350.828677] Dynamic subtest rcs0: SUCCESS (1.064s) [350.860077] Starting dynamic subtest: bcs0 [351.894305] Dynamic subtest bcs0: SUCCESS (1.064s) [351.922569] Starting dynamic subtest: vcs0 [352.955070] Dynamic subtest vcs0: SUCCESS (1.060s) [352.983588] Starting dynamic subtest: vcs1 [354.021044] Dynamic subtest vcs1: SUCCESS (1.064s) [354.047185] Starting dynamic subtest: vecs0 [355.083788] Dynamic subtest vecs0: SUCCESS (1.060s) [355.113693] Starting dynamic subtest: ccs0 [356.147932] Dynamic subtest ccs0: SUCCESS (1.063s) [356.150732] Subtest await: SUCCESS (7.479s) [356.365770] [100/144] (650s left) kms_pm_rpm (modeset-lpsp) [358.606617] Starting subtest: modeset-lpsp [362.725096] Subtest modeset-lpsp: SUCCESS (4.119s) [362.829170] [101/144] (644s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling) [362.920365] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling [362.922900] Starting dynamic subtest: pipe-A-default-mode [365.915392] Dynamic subtest pipe-A-default-mode: SUCCESS (2.994s) [365.918384] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.996s) [366.830547] [102/144] (640s left) kms_psr2_su (page_flip-xrgb8888) [366.897439] Subtest page_flip-XRGB8888: SKIP (0.000s) [366.926204] [103/144] (639s left) kms_ccs (pipe-c-bad-pixel-format-4-tiled-dg2-rc-ccs) [367.355439] Starting subtest: pipe-C-bad-pixel-format-4-tiled-dg2-rc-ccs [367.361353] Subtest pipe-C-bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.000s) [368.267346] [104/144] (638s left) syncobj_wait (reset-multiple-signaled) [368.341586] Starting subtest: reset-multiple-signaled [368.344058] Subtest reset-multiple-signaled: SUCCESS (0.000s) [368.421108] [105/144] (638s left) v3d/v3d_submit_cl (bad-flag) [368.502686] Subtest bad-flag: SKIP (0.000s) [368.552867] [106/144] (638s left) gem_exec_balancer (fairslice) [368.621446] Starting subtest: fairslice [371.350275] Subtest fairslice: SUCCESS (2.727s) [372.544267] [107/144] (634s left) gem_ctx_param (invalid-get-engines) [372.596646] Starting subtest: invalid-get-engines [372.599059] Subtest invalid-get-engines: SUCCESS (0.000s) [372.692526] [108/144] (634s left) gem_mmap_gtt (basic-wc) [372.756294] Subtest basic-wc: SKIP (0.000s) [372.808291] [109/144] (634s left) kms_cursor_edge_walk (256x256-top-bottom) [372.895763] Starting subtest: 256x256-top-bottom [372.898230] Starting dynamic subtest: pipe-A-eDP-1 [376.465742] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.568s) [376.480401] Starting dynamic subtest: pipe-D-eDP-1 [379.790554] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.323s) [379.792987] Subtest 256x256-top-bottom: SUCCESS (6.896s) [380.746632] [110/144] (626s left) gem_softpin (noreloc) [380.826934] Starting subtest: noreloc [386.220318] Subtest noreloc: SUCCESS (5.393s) [386.318267] [111/144] (620s left) vc4/vc4_perfmon (get-values-invalid-pointer) [386.378842] Subtest get-values-invalid-pointer: SKIP (0.000s) [386.432384] [112/144] (620s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions) [386.556251] Starting subtest: cursorB-vs-flipB-atomic-transitions [386.561483] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.003s) [386.701751] [113/144] (620s left) kms_addfb_basic (addfb25-modifier-no-flag) [386.776471] Starting subtest: addfb25-modifier-no-flag [386.779199] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [386.882314] [114/144] (620s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [386.955120] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt [386.959127] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [387.041531] [115/144] (620s left) kms_atomic (atomic-invalid-params) [387.159135] Starting subtest: atomic-invalid-params [387.161800] Starting dynamic subtest: pipe-A-eDP-1 [387.579141] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.419s) [387.581794] Subtest atomic-invalid-params: SUCCESS (0.421s) [388.475330] [116/144] (618s left) kms_psr (fbc-psr2-sprite-mmap-cpu) [388.587896] Starting subtest: fbc-psr2-sprite-mmap-cpu [388.590291] Starting dynamic subtest: eDP-1 [388.595043] Dynamic subtest eDP-1: SKIP (0.000s) [388.599569] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s) [388.701145] [117/144] (618s left) gem_exec_params (readonly) [388.771342] Starting subtest: readonly [388.777909] Subtest readonly: SUCCESS (0.007s) [388.873765] [118/144] (618s left) kms_chamelium_frames (dp-crc-multiple) [389.249462] Subtest dp-crc-multiple: SKIP (0.000s) [390.107984] [119/144] (617s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite) [390.207068] Starting subtest: fbc-rgb565-draw-pwrite [393.591310] Subtest fbc-rgb565-draw-pwrite: SUCCESS (3.388s) [393.700800] [120/144] (613s left) gem_ctx_shared (single-timeline) [393.765343] Starting subtest: single-timeline [393.790176] Subtest single-timeline: SUCCESS (0.018s) [394.004383] [121/144] (613s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip) [394.097129] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip [394.102057] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s) [394.181182] [122/144] (613s left) sysfs_preempt_timeout (timeout) [394.248181] Starting subtest: timeout [394.250557] Starting dynamic subtest: vecs0 [403.442388] Dynamic subtest vecs0: SUCCESS (9.193s) [403.475692] Starting dynamic subtest: ccs0 [404.802341] Dynamic subtest ccs0: SUCCESS (1.358s) [404.822668] Starting dynamic subtest: vcs0 [414.445857] Dynamic subtest vcs0: SUCCESS (9.639s) [414.468590] Starting dynamic subtest: bcs0 [415.825748] Dynamic subtest bcs0: SUCCESS (1.377s) [415.843074] Starting dynamic subtest: rcs0 [417.144328] Dynamic subtest rcs0: SUCCESS (1.317s) [417.165880] Starting dynamic subtest: vcs1 [426.479313] Dynamic subtest vcs1: SUCCESS (9.332s) [426.482577] Subtest timeout: SUCCESS (32.228s) [426.557557] [123/144] (580s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite) [426.656212] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite [426.661798] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [426.723105] [124/144] (580s left) kms_plane_scaling (planes-downscale-factor-0-25-upscale-factor-0-25) [426.783768] Starting subtest: planes-downscale-factor-0-25-upscale-factor-0-25 [426.786343] Starting dynamic subtest: pipe-A-eDP-1 [426.795848] Dynamic subtest pipe-A-eDP-1: SKIP (0.008s) [426.816259] Starting dynamic subtest: pipe-B-eDP-1 [426.824750] Dynamic subtest pipe-B-eDP-1: SKIP (0.016s) [426.840742] Starting dynamic subtest: pipe-C-eDP-1 [426.845712] Dynamic subtest pipe-C-eDP-1: SKIP (0.023s) [426.857490] Starting dynamic subtest: pipe-D-eDP-1 [426.861419] Dynamic subtest pipe-D-eDP-1: SKIP (0.016s) [426.866291] Subtest planes-downscale-factor-0-25-upscale-factor-0-25: SKIP (0.067s) [426.920112] [125/144] (580s left) vc4/vc4_mmap (mmap-bad-handle) [426.980927] Subtest mmap-bad-handle: SKIP (0.000s) [427.036043] [126/144] (580s left) kms_dsc (dsc-basic) [427.101347] Starting subtest: dsc-basic [427.105317] Subtest dsc-basic: SKIP (0.000s) [427.166077] [127/144] (580s left) gen9_exec_parse (unaligned-jump) [427.252455] Subtest unaligned-jump: SKIP (0.000s) [427.313911] [128/144] (580s left) kms_ccs (pipe-d-bad-pixel-format-y-tiled-ccs) [427.727855] Starting subtest: pipe-D-bad-pixel-format-y-tiled-ccs [427.733671] Subtest pipe-D-bad-pixel-format-y-tiled-ccs: SKIP (0.000s) [428.603616] [129/144] (579s left) kms_properties (crtc-properties-atomic) [428.701668] Starting subtest: crtc-properties-atomic [432.519300] Subtest crtc-properties-atomic: SUCCESS (3.819s) [433.405411] [130/144] (574s left) kms_content_protection (lic-type-1) [433.564770] Starting subtest: lic-type-1 [437.131690] Subtest lic-type-1: SKIP (3.563s) [438.414062] [131/144] (569s left) kms_ccs (pipe-b-crc-primary-basic-y-tiled-gen12-rc-ccs-cc) [438.807904] Starting subtest: pipe-B-crc-primary-basic-y-tiled-gen12-rc-ccs-cc [438.813125] Subtest pipe-B-crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s) [439.680032] [132/144] (568s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render) [439.793552] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render [444.657675] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (4.863s) [444.764485] [133/144] (563s left) gem_mmap_gtt (cpuset-big-copy-xy) [444.838295] Subtest cpuset-big-copy-XY: SKIP (0.000s) [444.895466] [134/144] (562s left) kms_atomic_transition (plane-all-modeset-transition) [444.974611] Starting subtest: plane-all-modeset-transition [444.978619] Subtest plane-all-modeset-transition: SKIP (0.000s) [445.044132] [135/144] (562s left) gem_exec_store (dword) [445.123103] Starting subtest: dword [445.125724] Starting dynamic subtest: rcs0 [445.184965] Dynamic subtest rcs0: SUCCESS (0.061s) [445.205634] Starting dynamic subtest: bcs0 [445.233036] Dynamic subtest bcs0: SUCCESS (0.047s) [445.252270] Starting dynamic subtest: vcs0 [446.457380] Dynamic subtest vcs0: SUCCESS (1.221s) [446.480064] Starting dynamic subtest: vcs1 [448.441116] Dynamic subtest vcs1: SUCCESS (1.982s) [448.465154] Starting dynamic subtest: vecs0 [450.491096] Dynamic subtest vecs0: SUCCESS (2.046s) [450.513990] Starting dynamic subtest: ccs0 [450.540966] Dynamic subtest ccs0: SUCCESS (0.051s) [450.543928] Subtest dword: SUCCESS (5.418s) [450.735163] [136/144] (557s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling) [450.825062] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling [450.827433] Starting dynamic subtest: pipe-A-default-mode [451.132781] Dynamic subtest pipe-A-default-mode: SKIP (0.301s) [451.137609] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.303s) [452.029047] [137/144] (555s left) syncobj_wait (multi-wait-for-submit-submitted) [452.086823] Starting subtest: multi-wait-for-submit-submitted [452.188474] Subtest multi-wait-for-submit-submitted: SUCCESS (0.103s) [452.267422] [138/144] (555s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt) [452.394580] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt [452.399447] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [452.479096] [139/144] (555s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc) [452.884684] Starting subtest: pipe-D-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc [454.586898] Subtest pipe-D-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (1.703s) [455.803203] [140/144] (552s left) kms_psr (psr-primary-render) [455.904102] Starting subtest: psr-primary-render [455.906601] Starting dynamic subtest: eDP-1 [457.783650] Dynamic subtest eDP-1: SUCCESS (1.879s) [457.786404] Subtest psr-primary-render: SUCCESS (1.880s) [458.673962] [141/144] (549s left) kms_big_fb (x-tiled-16bpp-rotate-0) [458.780160] Starting subtest: x-tiled-16bpp-rotate-0 [459.971443] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.191s) [460.109112] [142/144] (548s left) gem_spin_batch (resubmit-new) [460.180670] Starting subtest: resubmit-new [460.183248] Starting dynamic subtest: rcs0 [460.191465] Dynamic subtest rcs0: SUCCESS (0.011s) [460.204418] Starting dynamic subtest: bcs0 [460.206150] Dynamic subtest bcs0: SUCCESS (0.008s) [460.213483] Starting dynamic subtest: vcs0 [460.215558] Dynamic subtest vcs0: SUCCESS (0.010s) [460.235956] Starting dynamic subtest: vcs1 [460.237891] Dynamic subtest vcs1: SUCCESS (0.007s) [460.248834] Starting dynamic subtest: vecs0 [460.250710] Dynamic subtest vecs0: SUCCESS (0.005s) [460.258377] Starting dynamic subtest: ccs0 [460.260268] Dynamic subtest ccs0: SUCCESS (0.004s) [460.262169] Subtest resubmit-new: SUCCESS (0.048s) [461.476539] [143/144] (546s left) syncobj_timeline (signal-array) [461.542869] Starting subtest: signal-array [461.545061] Subtest signal-array: SUCCESS (0.000s) [461.642383] [144/144] (546s left) gem_ctx_isolation (clean) [461.710826] Starting subtest: clean [461.713290] Starting dynamic subtest: rcs0 [461.741193] Dynamic subtest rcs0: SUCCESS (0.031s) [461.750414] Starting dynamic subtest: bcs0 [461.788585] Dynamic subtest bcs0: SUCCESS (0.046s) [461.797455] Starting dynamic subtest: vcs0 [461.856712] Dynamic subtest vcs0: SUCCESS (0.068s) [461.877861] Starting dynamic subtest: vcs1 [463.435474] Dynamic subtest vcs1: SUCCESS (1.578s) [463.456787] Starting dynamic subtest: vecs0 [465.484509] Dynamic subtest vecs0: SUCCESS (2.048s) [465.506548] Starting dynamic subtest: ccs0 [467.472935] Dynamic subtest ccs0: SUCCESS (1.986s) [467.475810] Subtest clean: SUCCESS (5.762s) [467.695431] Closing watchdogs Done.