[58.856060] Initializing watchdogs [58.856142] /dev/watchdog0 [58.862149] [001/141] (960s left) kms_ccs (pipe-b-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs) [61.144925] Starting subtest: pipe-B-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs [63.003539] Subtest pipe-B-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs: SUCCESS (1.858s) [63.353391] [002/141] (956s left) kms_vblank (pipe-a-query-forked) [65.326459] Starting subtest: pipe-A-query-forked [67.659152] Subtest pipe-A-query-forked: SUCCESS (2.333s) [67.755316] [003/141] (951s left) syncobj_timeline (invalid-transfer-illegal-handle) [67.824489] Starting subtest: invalid-transfer-illegal-handle [67.825349] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s) [67.887962] [004/141] (951s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled) [67.955707] Starting subtest: invalid-multi-wait-unsubmitted-signaled [67.956512] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.001s) [68.027716] [005/141] (951s left) sw_sync (alloc_fence_invalid_timeline) [68.100187] Starting subtest: alloc_fence_invalid_timeline [68.101133] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s) [68.138841] [006/141] (951s left) kms_universal_plane (disable-primary-vs-flip-pipe-c) [70.126484] Starting subtest: disable-primary-vs-flip-pipe-C [71.295382] Subtest disable-primary-vs-flip-pipe-C: SUCCESS (1.168s) [71.413693] [007/141] (948s left) vc4/vc4_wait_bo (used-bo-0ns) [71.516239] Subtest used-bo-0ns: SKIP (0.000s) [71.563197] [008/141] (947s left) kms_chamelium_hpd (hdmi-hpd-storm-disable) [73.573124] Subtest hdmi-hpd-storm-disable: SKIP (0.000s) [73.628214] [009/141] (945s left) gem_exec_whisper (basic-normal-all) [73.708896] Starting subtest: basic-normal-all [75.891060] Subtest basic-normal-all: SUCCESS (2.181s) [76.113231] [010/141] (943s left) kms_rotation_crc (primary-y-tiled-reflect-x-90) [78.116534] Starting subtest: primary-y-tiled-reflect-x-90 [88.464677] Subtest primary-y-tiled-reflect-x-90: SUCCESS (10.347s) [88.609290] [011/141] (930s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render) [90.580424] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render [93.128662] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (2.549s) [93.258274] [012/141] (926s left) drm_fdinfo (busy-hang) [93.330146] Subtest busy-hang: SKIP (0.000s) [93.353451] [013/141] (926s left) kms_ccs (pipe-b-crc-primary-basic-y_tiled_ccs) [95.477135] Starting subtest: pipe-B-crc-primary-basic-y_tiled_ccs [95.479066] Subtest pipe-B-crc-primary-basic-y_tiled_ccs: SKIP (0.000s) [95.843705] [014/141] (923s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render) [97.823868] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render [97.825815] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [97.893271] [015/141] (921s left) gem_caching (writes) [97.975154] Starting subtest: writes [102.273398] Subtest writes: SUCCESS (4.298s) [102.405623] [016/141] (917s left) core_getclient [102.526666] [017/141] (917s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0) [104.517516] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0 [105.667155] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.144s) [105.777670] [018/141] (913s left) gem_exec_fence (syncobj-backward-timeline-chain-engines) [106.365157] Starting subtest: syncobj-backward-timeline-chain-engines [106.469936] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.105s) [106.736523] [019/141] (912s left) i915_pm_rps (reset) [106.807058] Starting subtest: reset [110.490232] Subtest reset: SUCCESS (3.683s) [110.566800] [020/141] (909s left) gem_render_copy (y-tiled-to-vebox-linear) [110.640474] Starting subtest: y-tiled-to-vebox-linear [110.641451] Starting dynamic subtest: smem [110.714814] Dynamic subtest smem: SUCCESS (0.074s) [110.720594] Starting dynamic subtest: lmem0 [110.848129] Dynamic subtest lmem0: SUCCESS (0.129s) [110.849216] Subtest y-tiled-to-vebox-linear: SUCCESS (0.203s) [111.118765] [021/141] (908s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [113.140549] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [113.661695] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.520s) [113.777029] [022/141] (905s left) sysfs_preempt_timeout (invalid) [113.847651] Starting subtest: invalid [113.848543] Starting dynamic subtest: vecs0 [113.849578] Dynamic subtest vecs0: SUCCESS (0.000s) [113.855517] Starting dynamic subtest: vcs0 [113.856731] Dynamic subtest vcs0: SUCCESS (0.000s) [113.862678] Starting dynamic subtest: bcs0 [113.863951] Dynamic subtest bcs0: SUCCESS (0.000s) [113.869785] Starting dynamic subtest: rcs0 [113.871080] Dynamic subtest rcs0: SUCCESS (0.000s) [113.881043] Starting dynamic subtest: vcs1 [113.882225] Dynamic subtest vcs1: SUCCESS (0.000s) [113.883229] Subtest invalid: SUCCESS (0.002s) [113.908246] [023/141] (905s left) feature_discovery (display-3x) [115.879791] Starting subtest: display-3x [115.881549] Subtest display-3x: SKIP (0.000s) [115.941871] [024/141] (903s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted) [116.021404] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted [116.022413] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.001s) [116.081436] [025/141] (903s left) kms_display_modes (mst-extended-mode-negative) [118.070532] Starting subtest: mst-extended-mode-negative [118.072743] Subtest mst-extended-mode-negative: SKIP (0.000s) [118.101272] [026/141] (901s left) gem_exec_flush (basic-uc-set-default) [118.173105] Subtest basic-uc-set-default: SKIP (0.000s) [118.223281] [027/141] (901s left) kms_cursor_crc (cursor-offscreen-512x512) [120.408452] Starting subtest: cursor-offscreen-512x512 [120.411300] Subtest cursor-offscreen-512x512: SKIP (0.002s) [120.589735] [028/141] (899s left) gem_ctx_isolation (clean) [120.697795] Starting subtest: clean [120.698759] Starting dynamic subtest: rcs0 [120.787386] Dynamic subtest rcs0: SUCCESS (0.089s) [120.793281] Starting dynamic subtest: bcs0 [120.915588] Dynamic subtest bcs0: SUCCESS (0.128s) [120.921735] Starting dynamic subtest: vcs0 [121.013946] Dynamic subtest vcs0: SUCCESS (0.098s) [121.019952] Starting dynamic subtest: vcs1 [121.122752] Dynamic subtest vcs1: SUCCESS (0.109s) [121.128800] Starting dynamic subtest: vecs0 [121.234612] Dynamic subtest vecs0: SUCCESS (0.112s) [121.235534] Subtest clean: SUCCESS (0.537s) [121.506395] [029/141] (898s left) syncobj_timeline (wait-all-snapshot) [121.605345] Starting subtest: wait-all-snapshot [121.687366] Subtest wait-all-snapshot: SUCCESS (0.082s) [121.750418] [030/141] (898s left) kms_psr (psr2_sprite_plane_move) [121.841246] Subtest psr2_sprite_plane_move: SKIP (0.000s) [121.866365] [031/141] (897s left) kms_draw_crc (draw-method-pwrite) [123.840298] Starting subtest: draw-method-pwrite [123.841339] Starting dynamic subtest: xrgb8888-untiled [124.393215] Dynamic subtest xrgb8888-untiled: SUCCESS (0.553s) [124.401974] Starting dynamic subtest: rgb565-untiled [124.859674] Dynamic subtest rgb565-untiled: SUCCESS (0.466s) [124.869168] Starting dynamic subtest: xrgb2101010-untiled [125.343609] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.483s) [125.364733] Starting dynamic subtest: xrgb8888-xtiled [126.193120] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.849s) [126.202473] Starting dynamic subtest: rgb565-xtiled [127.076692] Dynamic subtest rgb565-xtiled: SUCCESS (0.883s) [127.086486] Starting dynamic subtest: xrgb2101010-xtiled [127.893361] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.816s) [127.903245] Starting dynamic subtest: xrgb8888-ytiled [128.609348] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.716s) [128.618105] Starting dynamic subtest: rgb565-ytiled [129.059204] Dynamic subtest rgb565-ytiled: SUCCESS (0.449s) [129.067825] Starting dynamic subtest: xrgb2101010-ytiled [129.758130] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.699s) [129.759044] Subtest draw-method-pwrite: SUCCESS (5.918s) [129.826029] [032/141] (890s left) v3d/v3d_submit_csd (valid-multisync-submission) [129.942703] Subtest valid-multisync-submission: SKIP (0.000s) [129.998650] [033/141] (889s left) kms_ccs (pipe-a-crc-sprite-planes-basic-yf_tiled_ccs) [132.110216] Starting subtest: pipe-A-crc-sprite-planes-basic-yf_tiled_ccs [132.114362] Subtest pipe-A-crc-sprite-planes-basic-yf_tiled_ccs: SKIP (0.003s) [132.513280] [034/141] (887s left) kms_vblank (pipe-d-accuracy-idle) [134.487188] Starting subtest: pipe-D-accuracy-idle [137.891701] Subtest pipe-D-accuracy-idle: SUCCESS (3.406s) [138.007868] [035/141] (881s left) kms_addfb_basic (unused-handle) [138.077735] Starting subtest: unused-handle [138.078527] Subtest unused-handle: SUCCESS (0.000s) [140.074202] [036/141] (879s left) kms_cdclk (plane-scaling) [140.164558] Subtest plane-scaling: SKIP (0.000s) [140.183537] [037/141] (879s left) gem_exec_params (rel-constants-invalid-ring) [140.255007] Starting subtest: rel-constants-invalid-ring [140.255960] Subtest rel-constants-invalid-ring: SUCCESS (0.000s) [140.354088] [038/141] (879s left) kms_async_flips (crc) [142.359142] Starting subtest: crc [144.096566] Starting dynamic subtest: pipe-A-HDMI-A-3 [146.773234] Dynamic subtest pipe-A-HDMI-A-3: FAIL (2.624s) [148.459864] Starting dynamic subtest: pipe-B-HDMI-A-3 [150.895461] Dynamic subtest pipe-B-HDMI-A-3: FAIL (2.376s) [152.183104] Starting dynamic subtest: pipe-C-HDMI-A-3 [154.603745] Dynamic subtest pipe-C-HDMI-A-3: FAIL (2.372s) [155.517402] Starting dynamic subtest: pipe-D-HDMI-A-3 [157.967751] Dynamic subtest pipe-D-HDMI-A-3: FAIL (2.382s) [157.968880] Subtest crc: FAIL (15.538s) [158.592642] [039/141] (861s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt) [160.576314] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt [160.578553] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [160.663371] [040/141] (859s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode) [162.683565] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s) [162.741141] [041/141] (857s left) kms_frontbuffer_tracking (fbc-2p-rte) [164.717474] Starting subtest: fbc-2p-rte [164.719858] Subtest fbc-2p-rte: SKIP (0.000s) [164.813249] [042/141] (855s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt) [166.818588] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt [166.820600] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [166.912821] [043/141] (853s left) dmabuf_sync_file (export-basic) [167.013649] Starting subtest: export-basic [167.014713] Subtest export-basic: SUCCESS (0.001s) [167.065355] [044/141] (853s left) gem_userptr_blits (readonly-unsync) [167.148214] Subtest readonly-unsync: SKIP (0.000s) [167.294425] [045/141] (852s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu) [169.283339] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu [169.285500] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [169.362320] [046/141] (850s left) kms_chamelium_color (ctm-0-50) [171.353432] Subtest ctm-0-50: SKIP (0.000s) [171.395785] [047/141] (848s left) gen7_exec_parse (chained-batch) [171.470340] Subtest chained-batch: SKIP (0.000s) [171.510030] [048/141] (848s left) kms_sequence (get-busy) [173.508982] Starting subtest: get-busy [173.511980] Starting dynamic subtest: HDMI-A-3-pipe-A [175.986490] Dynamic subtest HDMI-A-3-pipe-A: SUCCESS (2.475s) [175.995492] Starting dynamic subtest: HDMI-A-3-pipe-B [178.790496] Dynamic subtest HDMI-A-3-pipe-B: SUCCESS (2.800s) [178.799590] Starting dynamic subtest: HDMI-A-3-pipe-C [181.981527] Dynamic subtest HDMI-A-3-pipe-C: SUCCESS (3.187s) [181.991829] Starting dynamic subtest: HDMI-A-3-pipe-D [185.549263] Dynamic subtest HDMI-A-3-pipe-D: SUCCESS (3.561s) [185.550159] Subtest get-busy: SUCCESS (12.039s) [185.660453] [049/141] (834s left) gem_create (create-size-update) [185.730818] Starting subtest: create-size-update [185.731689] Subtest create-size-update: SUCCESS (0.000s) [185.926820] [050/141] (834s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt) [187.903853] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt [187.905916] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [187.993796] [051/141] (832s left) perf (global-sseu-config-invalid) [188.138990] Starting subtest: global-sseu-config-invalid [188.140143] Starting dynamic subtest: 0-rcs0 [188.153046] Dynamic subtest 0-rcs0: SUCCESS (0.014s) [188.154185] Subtest global-sseu-config-invalid: SUCCESS (0.015s) [188.175479] [052/141] (832s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [190.160571] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip [190.162690] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s) [190.261019] [053/141] (829s left) gem_mmap_wc (write-cpu-read-wc-unflushed) [190.369967] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s) [190.402067] [054/141] (829s left) kms_content_protection (content_type_change) [192.422757] Starting subtest: content_type_change [192.703497] Subtest content_type_change: SKIP (0.274s) [192.849666] [055/141] (827s left) api_intel_bb (lot-of-buffers) [192.918231] Starting subtest: lot-of-buffers [194.833877] Subtest lot-of-buffers: SUCCESS (1.912s) [194.946063] Aborting: Lockdep not active /proc/lockdep_stats contents: lock-classes: 1791 [max: 8192] direct dependencies: 16594 [max: 32768] indirect dependencies: 123748 all direct dependencies: 364762 dependency chains: 23108 [max: 131072] dependency chain hlocks used: 95496 [max: 655360] dependency chain hlocks lost: 0 in-hardirq chains: 290 in-softirq chains: 618 in-process chains: 22200 stack-trace entries: 155617 [max: 1048576] number of stack traces: 8054 number of stack hash chains: 6397 combined max dependencies: 3999043929 hardirq-safe locks: 104 hardirq-unsafe locks: 1068 softirq-safe locks: 201 softirq-unsafe locks: 981 irq-safe locks: 222 irq-unsafe locks: 1068 hardirq-read-safe locks: 3 hardirq-read-unsafe locks: 315 softirq-read-safe locks: 7 softirq-read-unsafe locks: 310 irq-read-safe locks: 7 irq-read-unsafe locks: 315 uncategorized locks: 294 unused locks: 1 max locking depth: 15 max bfs queue depth: 380 max lock class index: 1790 chain lookup misses: 23333 chain lookup hits: 287597454 cyclic checks: 23308 redundant checks: 0 redundant links: 0 find-mask forwards checks: 3750 find-mask backwards checks: 2676 hardirq on events: 146974844 hardirq off events: 146974839 redundant hardirq ons: 36 redundant hardirq offs: 15 softirq on events: 405321 softirq off events: 405321 redundant softirq ons: 0 redundant softirq offs: 0 debug_locks: 0 zapped classes: 1 zapped lock chains: 110 large chain blocks: 1 [194.947818] Closing watchdogs Done.