[61.594356] Initializing watchdogs [61.594422] /dev/watchdog0 [61.601736] [001/130] (960s left) gem_render_copy (y-tiled) [61.678391] Starting subtest: y-tiled [61.680450] Subtest y-tiled: SKIP (0.000s) [61.861286] [002/130] (960s left) kms_psr (fbc-pr-primary-mmap-gtt) [63.874317] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s) [63.900740] [003/130] (958s left) gem_ccs (large-ctrl-surf-copy) [64.016714] Starting subtest: large-ctrl-surf-copy [64.686396] Subtest large-ctrl-surf-copy: SUCCESS (0.668s) [64.804457] [004/130] (957s left) kms_rotation_crc (primary-y-tiled-reflect-x-0) [66.809184] Starting subtest: primary-y-tiled-reflect-x-0 [66.912854] Subtest primary-y-tiled-reflect-x-0: SKIP (0.102s) [66.988823] [005/130] (955s left) syncobj_timeline (single-wait-available-submitted) [67.417182] Starting subtest: single-wait-available-submitted [67.418289] Subtest single-wait-available-submitted: SUCCESS (0.001s) [67.781604] [006/130] (954s left) gem_exec_schedule (u-semaphore-resolve) [67.935288] Starting subtest: u-semaphore-resolve [68.055363] Subtest u-semaphore-resolve: SUCCESS (0.119s) [68.506862] [007/130] (953s left) gem_ringfill (basic-all) [68.938797] Starting subtest: basic-all [70.837192] Subtest basic-all: SUCCESS (1.896s) [70.988422] [008/130] (951s left) gem_ctx_persistence (legacy-engines-hostile) [71.100372] Starting subtest: legacy-engines-hostile [71.101294] Starting dynamic subtest: render [71.188544] Dynamic subtest render: SUCCESS (0.088s) [71.197096] Starting dynamic subtest: bsd1 [71.295116] Dynamic subtest bsd1: SUCCESS (0.105s) [71.305461] Starting dynamic subtest: bsd2 [71.393308] Dynamic subtest bsd2: SUCCESS (0.097s) [71.403716] Starting dynamic subtest: blt [71.466554] Dynamic subtest blt: SUCCESS (0.072s) [71.488172] Starting dynamic subtest: vebox [71.535954] Dynamic subtest vebox: SUCCESS (0.068s) [71.537662] Subtest legacy-engines-hostile: SUCCESS (0.435s) [71.681776] [009/130] (950s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt) [73.728488] Starting subtest: fbcpsr-rgb565-draw-blt [73.730194] Subtest fbcpsr-rgb565-draw-blt: SKIP (0.000s) [73.825469] [010/130] (948s left) i915_pm_rps (thresholds-idle) [73.982897] Starting subtest: thresholds-idle [73.984905] Subtest thresholds-idle: SKIP (0.001s) [74.109736] [011/130] (948s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180) [76.169085] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180 [76.171031] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s) [76.259028] [012/130] (946s left) kms_dp_linktrain_fallback (dp-fallback) [78.329169] Starting subtest: dp-fallback [78.331804] Subtest dp-fallback: SKIP (0.000s) [78.386393] [013/130] (944s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu) [80.465554] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu [80.467369] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [80.560512] [014/130] (941s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs) [82.663195] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs [82.664178] Starting dynamic subtest: pipe-A-HDMI-A-1 [82.667797] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [82.674358] Starting dynamic subtest: pipe-B-HDMI-A-1 [82.678101] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [82.684427] Starting dynamic subtest: pipe-C-HDMI-A-1 [82.688051] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [82.694242] Starting dynamic subtest: pipe-D-HDMI-A-1 [82.697813] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s) [82.699414] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.004s) [82.876928] [015/130] (939s left) kms_content_protection (lic-type-0) [84.985904] Starting subtest: lic-type-0 [85.282920] Subtest lic-type-0: SKIP (0.294s) [85.501714] [016/130] (937s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers) [87.515218] Starting subtest: plane-scaler-unity-scaling-with-modifiers [87.516174] Starting dynamic subtest: pipe-A [88.069779] Dynamic subtest pipe-A: SUCCESS (0.554s) [88.091884] Starting dynamic subtest: pipe-B [88.660240] Dynamic subtest pipe-B: SUCCESS (0.590s) [88.676843] Starting dynamic subtest: pipe-C [89.235806] Dynamic subtest pipe-C: SUCCESS (0.575s) [89.252324] Starting dynamic subtest: pipe-D [89.810429] Dynamic subtest pipe-D: SUCCESS (0.574s) [89.811839] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (2.295s) [89.968370] [017/130] (932s left) kms_feature_discovery (chamelium) [91.993240] Starting subtest: chamelium [91.995033] Subtest chamelium: SKIP (0.000s) [92.051430] [018/130] (930s left) gem_ctx_engines (execute-allforone) [92.218183] Starting subtest: execute-allforone [92.253063] Subtest execute-allforone: SUCCESS (0.035s) [92.498513] [019/130] (930s left) kms_psr (psr2-primary-blt) [94.514282] Subtest psr2-primary-blt: SKIP (0.000s) [94.542699] [020/130] (928s left) gem_lmem_swapping (heavy-random) [100.571952] Starting subtest: heavy-random [100.572894] Starting dynamic subtest: lmem0 [105.097390] Dynamic subtest lmem0: SUCCESS (4.525s) [105.098341] Subtest heavy-random: SUCCESS (4.525s) [107.109771] [021/130] (915s left) syncobj_wait (wait-any-snapshot) [113.880525] Starting subtest: wait-any-snapshot [113.963180] Subtest wait-any-snapshot: SUCCESS (0.082s) [114.023976] [022/130] (908s left) gem_mmap_gtt (basic-small-copy-xy) [114.120938] Subtest basic-small-copy-XY: SKIP (0.000s) [114.155843] [023/130] (908s left) gem_exec_parallel (basic) [114.240241] Starting subtest: basic [114.241185] Starting dynamic subtest: rcs0 [115.821157] Dynamic subtest rcs0: SUCCESS (1.580s) [115.843520] Starting dynamic subtest: bcs0 [117.344390] Dynamic subtest bcs0: SUCCESS (1.523s) [117.352675] Starting dynamic subtest: vcs0 [118.871619] Dynamic subtest vcs0: SUCCESS (1.527s) [118.879465] Starting dynamic subtest: vcs1 [120.384394] Dynamic subtest vcs1: SUCCESS (1.513s) [120.392478] Starting dynamic subtest: vecs0 [121.886364] Dynamic subtest vecs0: SUCCESS (1.502s) [121.893194] Starting dynamic subtest: vecs1 [123.389529] Dynamic subtest vecs1: SUCCESS (1.503s) [123.397697] Starting dynamic subtest: ccs0 [124.874134] Dynamic subtest ccs0: SUCCESS (1.484s) [124.875199] Subtest basic: SUCCESS (10.634s) [125.104335] [024/130] (897s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy) [127.150248] Starting subtest: 2x-long-cursor-vs-flip-legacy [127.153136] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.002s) [127.217225] [025/130] (895s left) gem_mmap_gtt (basic-write-cpu-read-gtt) [127.363794] Subtest basic-write-cpu-read-gtt: SKIP (0.000s) [127.411907] [026/130] (895s left) gem_exec_params (invalid-bsd-ring) [127.510794] Starting subtest: invalid-bsd-ring [127.511614] Subtest invalid-bsd-ring: SUCCESS (0.000s) [127.640166] [027/130] (895s left) kms_cursor_edge_walk (64x64-top-bottom) [129.655166] Starting subtest: 64x64-top-bottom [129.656178] Starting dynamic subtest: pipe-A-HDMI-A-1 [132.994341] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.337s) [133.001335] Starting dynamic subtest: pipe-D-HDMI-A-1 [136.207442] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (3.212s) [136.208366] Subtest 64x64-top-bottom: SUCCESS (6.552s) [136.338239] [028/130] (886s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-blt) [138.350801] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-blt [140.627530] Subtest fbc-1p-offscren-pri-shrfb-draw-blt: SUCCESS (2.277s) [140.762257] [029/130] (882s left) kms_pm_rpm (dpms-mode-unset-non-lpsp) [145.053107] Starting subtest: dpms-mode-unset-non-lpsp [146.273885] Subtest dpms-mode-unset-non-lpsp: SKIP (1.219s) [147.426926] [030/130] (875s left) gem_exec_fence (submit3) [147.691576] Starting subtest: submit3 [147.701637] Subtest submit3: SKIP (0.000s) [148.374080] [031/130] (874s left) gem_close_race (basic-threads) [148.487362] Starting subtest: basic-threads [149.769555] Subtest basic-threads: SUCCESS (1.282s) [150.024331] [032/130] (872s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180) [152.133063] Starting subtest: linear-max-hw-stride-64bpp-rotate-180 [153.391522] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.258s) [153.559059] [033/130] (869s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render) [155.603539] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render [155.605331] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [155.678961] [034/130] (867s left) api_intel_bb (render-ccs) [155.839168] Starting subtest: render-ccs [155.929665] Subtest render-ccs: SUCCESS (0.091s) [156.055425] [035/130] (867s left) kms_big_fb (y-tiled-64bpp-rotate-180) [158.101261] Starting subtest: y-tiled-64bpp-rotate-180 [158.103147] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s) [158.202677] [036/130] (864s left) gem_exec_reloc (basic-gtt-cpu-active) [158.349586] Subtest basic-gtt-cpu-active: SKIP (0.000s) [158.406168] [037/130] (864s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled) [158.507525] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [158.508460] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s) [158.614355] [038/130] (864s left) gem_exec_whisper (basic-normal) [158.740069] Starting subtest: basic-normal [161.826748] Subtest basic-normal: SUCCESS (3.085s) [161.990981] [039/130] (861s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy) [164.007379] Starting subtest: flip-vs-cursor-busy-crc-legacy [164.796613] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.789s) [164.938202] [040/130] (858s left) kms_chamelium_color (ctm-max) [166.955311] Subtest ctm-max: SKIP (0.000s) [166.978937] [041/130] (856s left) gem_exec_flush (basic-uc-rw-default) [167.061836] Subtest basic-uc-rw-default: SKIP (0.000s) [167.121783] [042/130] (856s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt) [169.183496] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt [169.185312] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [169.284103] [043/130] (854s left) kms_psr (psr-cursor-plane-move) [171.364254] Subtest psr-cursor-plane-move: SKIP (0.000s) [171.396368] [044/130] (851s left) kms_prop_blob (basic) [171.500928] Starting subtest: basic [171.502072] Subtest basic: SUCCESS (0.000s) [171.609195] [045/130] (851s left) gem_render_copy (yf-tiled-ccs-to-y-tiled) [171.719969] Starting subtest: yf-tiled-ccs-to-y-tiled [171.721917] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s) [171.898660] [046/130] (851s left) kms_lease (lease-again) [173.922229] Starting subtest: lease-again [173.923168] Starting dynamic subtest: pipe-A-HDMI-A-1 [173.927174] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.003s) [173.934954] Starting dynamic subtest: pipe-B-HDMI-A-1 [173.935948] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.003s) [173.943838] Starting dynamic subtest: pipe-C-HDMI-A-1 [173.944741] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.003s) [173.952182] Starting dynamic subtest: pipe-D-HDMI-A-1 [173.953166] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.003s) [173.954056] Subtest lease-again: SUCCESS (0.016s) [174.021430] [047/130] (849s left) kms_async_flips (test-time-stamp) [176.091383] Starting subtest: test-time-stamp [176.311404] Starting dynamic subtest: pipe-A-HDMI-A-1 [176.589850] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.278s) [176.785426] Starting dynamic subtest: pipe-B-HDMI-A-1 [176.879442] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.100s) [177.052896] Starting dynamic subtest: pipe-C-HDMI-A-1 [177.154369] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.107s) [177.325394] Starting dynamic subtest: pipe-D-HDMI-A-1 [177.419333] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.099s) [177.420345] Subtest test-time-stamp: SUCCESS (1.327s) [177.756087] [048/130] (845s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb) [179.784295] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s) [179.814654] [049/130] (843s left) kms_properties (connector-properties-atomic) [181.852253] Starting subtest: connector-properties-atomic [181.854275] Starting dynamic subtest: pipe-A-HDMI-A-1 [182.621147] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.767s) [182.629756] Starting dynamic subtest: pipe-None-DP-1 [182.631532] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s) [182.639671] Starting dynamic subtest: pipe-None-DP-2 [182.641478] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s) [182.649242] Starting dynamic subtest: pipe-None-DP-3 [182.651039] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s) [182.658846] Starting dynamic subtest: pipe-None-HDMI-A-2 [182.660963] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s) [182.668699] Starting dynamic subtest: pipe-None-DP-4 [182.670675] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s) [182.678053] Starting dynamic subtest: pipe-None-HDMI-A-3 [182.679677] Dynamic subtest pipe-None-HDMI-A-3: SUCCESS (0.001s) [182.680514] Subtest connector-properties-atomic: SUCCESS (0.781s) [182.773497] [050/130] (840s left) perf_pmu (busy-hang) [182.852534] Starting subtest: busy-hang [182.853419] Starting dynamic subtest: rcs0 [184.146548] Dynamic subtest rcs0: SUCCESS (1.294s) [184.155116] Aborting: Lockdep not active /proc/lockdep_stats contents: lock-classes: 2169 [max: 8192] direct dependencies: 23450 [max: 524288] indirect dependencies: 164202 all direct dependencies: 477140 dependency chains: 34338 [max: 524288] dependency chain hlocks used: 142550 [max: 2621440] dependency chain hlocks lost: 0 in-hardirq chains: 336 in-softirq chains: 825 in-process chains: 33177 stack-trace entries: 298168 [max: 524288] number of stack traces: 13256 number of stack hash chains: 9096 combined max dependencies: 645559844 hardirq-safe locks: 109 hardirq-unsafe locks: 1278 softirq-safe locks: 231 softirq-unsafe locks: 1192 irq-safe locks: 246 irq-unsafe locks: 1278 hardirq-read-safe locks: 5 hardirq-read-unsafe locks: 417 softirq-read-safe locks: 9 softirq-read-unsafe locks: 413 irq-read-safe locks: 9 irq-read-unsafe locks: 417 uncategorized locks: 356 unused locks: 1 max locking depth: 16 max bfs queue depth: 360 max lock class index: 2168 debug_locks: 0 zapped classes: 335 zapped lock chains: 8682 large chain blocks: 1 [184.157165] Starting dynamic subtest: bcs0 [185.398285] Dynamic subtest bcs0: SUCCESS (1.251s) [185.399799] Starting dynamic subtest: vcs0 [186.649246] Dynamic subtest vcs0: SUCCESS (1.249s) [186.650743] Starting dynamic subtest: vcs1 [187.906275] Dynamic subtest vcs1: SUCCESS (1.255s) [187.907772] Starting dynamic subtest: vecs0 [189.154258] Dynamic subtest vecs0: SUCCESS (1.246s) [189.155753] Starting dynamic subtest: vecs1 [190.407230] Dynamic subtest vecs1: SUCCESS (1.251s) [190.408721] Starting dynamic subtest: ccs0 [191.644209] Dynamic subtest ccs0: SUCCESS (1.235s) [191.645694] Subtest busy-hang: SUCCESS (8.792s) [191.733536] Closing watchdogs Done.