[30.904419] Initializing watchdogs [30.904478] /dev/watchdog0 [30.908883] [001/141] (960s left) perf (oa-formats) [31.003840] Starting subtest: oa-formats [31.004609] Starting dynamic subtest: 0-rcs0 [31.017327] Dynamic subtest 0-rcs0: SUCCESS (0.014s) [31.018181] Subtest oa-formats: SUCCESS (0.014s) [31.032923] [002/141] (960s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt) [31.142160] Starting subtest: psr-rgb565-draw-mmap-gtt [31.143592] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s) [31.192798] [003/141] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [31.292758] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu [31.294140] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [31.342728] [004/141] (960s left) syncobj_wait (invalid-signal-bad-pad) [31.388563] Starting subtest: invalid-signal-bad-pad [31.389292] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [31.426150] [005/141] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-blt) [31.536500] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-blt [31.537883] Subtest fbcpsr-1p-offscren-pri-indfb-draw-blt: SKIP (0.000s) [31.575937] [006/141] (959s left) kms_flip (2x-flip-vs-panning) [31.657476] Starting subtest: 2x-flip-vs-panning [31.669685] Subtest 2x-flip-vs-panning: SKIP (0.013s) [31.709142] [007/141] (959s left) kms_ccs (pipe-b-missing-ccs-buffer-yf_tiled_ccs) [31.953979] Starting subtest: pipe-B-missing-ccs-buffer-yf_tiled_ccs [31.955515] Subtest pipe-B-missing-ccs-buffer-yf_tiled_ccs: SKIP (0.000s) [32.213631] [008/141] (959s left) kms_flip (2x-flip-vs-absolute-wf_vblank) [32.296045] Starting subtest: 2x-flip-vs-absolute-wf_vblank [32.308129] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.012s) [32.347953] [009/141] (959s left) kms_hdr (bpc-switch-suspend) [32.444155] Starting subtest: bpc-switch-suspend [32.445542] Subtest bpc-switch-suspend: SKIP (0.000s) [32.479938] [010/141] (959s left) kms_ccs (pipe-d-missing-ccs-buffer-y_tiled_gen12_mc_ccs) [32.880809] Starting subtest: pipe-D-missing-ccs-buffer-y_tiled_gen12_mc_ccs [32.882272] Subtest pipe-D-missing-ccs-buffer-y_tiled_gen12_mc_ccs: SKIP (0.000s) [32.983154] [011/141] (958s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [33.083837] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc [33.085332] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [33.140991] [012/141] (958s left) perf_pmu (init-busy) [33.191619] Starting subtest: init-busy [33.192391] Starting dynamic subtest: rcs0 [33.193159] Dynamic subtest rcs0: SUCCESS (0.001s) [33.196602] Starting dynamic subtest: bcs0 [33.197402] Dynamic subtest bcs0: SUCCESS (0.000s) [33.200364] Starting dynamic subtest: vcs0 [33.201118] Dynamic subtest vcs0: SUCCESS (0.000s) [33.204118] Starting dynamic subtest: vcs1 [33.204917] Dynamic subtest vcs1: SUCCESS (0.000s) [33.207867] Starting dynamic subtest: vecs0 [33.208597] Dynamic subtest vecs0: SUCCESS (0.000s) [33.209316] Subtest init-busy: SUCCESS (0.002s) [33.233089] [013/141] (958s left) kms_vblank (pipe-a-wait-forked-hang) [33.327876] Starting subtest: pipe-A-wait-forked-hang [47.081951] Subtest pipe-A-wait-forked-hang: SUCCESS (13.754s) [47.186490] [014/141] (944s left) gem_exec_whisper (basic-fds-forked-all) [47.242447] Starting subtest: basic-fds-forked-all [70.682826] Subtest basic-fds-forked-all: SUCCESS (23.431s) [70.832754] [015/141] (920s left) gem_userptr_blits (process-exit-busy) [70.903861] Starting subtest: process-exit-busy [70.917906] Subtest process-exit-busy: SUCCESS (0.014s) [70.996026] [016/141] (920s left) i915_pm_rpm (sysfs-read) [72.575942] Starting subtest: sysfs-read [73.039411] Subtest sysfs-read: SUCCESS (0.463s) [73.181735] [017/141] (918s left) syncobj_wait (wait-for-submit-delayed-submit) [73.232352] Starting subtest: wait-for-submit-delayed-submit [73.335352] Subtest wait-for-submit-delayed-submit: SUCCESS (0.101s) [73.384070] [018/141] (918s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc) [73.492365] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc [73.493853] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [73.538149] [019/141] (918s left) kms_prop_blob (basic) [73.589117] Starting subtest: basic [73.589936] Subtest basic: SUCCESS (0.000s) [73.637378] [020/141] (917s left) kms_ccs (pipe-a-bad-pixel-format-4_tiled_mtl_rc_ccs) [73.735797] Starting subtest: pipe-A-bad-pixel-format-4_tiled_mtl_rc_ccs [73.737273] Subtest pipe-A-bad-pixel-format-4_tiled_mtl_rc_ccs: SKIP (0.000s) [74.157453] [021/141] (917s left) kms_cursor_crc (cursor-rapid-movement-256x256) [74.257049] Starting subtest: cursor-rapid-movement-256x256 [74.261498] Starting dynamic subtest: pipe-A-HDMI-A-1 [74.484646] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.223s) [74.508499] Starting dynamic subtest: pipe-D-HDMI-A-1 [74.701539] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.196s) [74.702312] Subtest cursor-rapid-movement-256x256: SUCCESS (0.444s) [74.803344] [022/141] (916s left) kms_lease (cursor_implicit_plane) [74.900819] Starting subtest: cursor_implicit_plane [74.901525] Starting dynamic subtest: pipe-A-HDMI-A-1 [75.048507] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.147s) [75.053863] Starting dynamic subtest: pipe-B-HDMI-A-1 [75.201645] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.150s) [75.210438] Starting dynamic subtest: pipe-C-HDMI-A-1 [75.339654] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.135s) [75.343770] Starting dynamic subtest: pipe-D-HDMI-A-1 [75.471547] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.131s) [75.472312] Subtest cursor_implicit_plane: SUCCESS (0.571s) [75.540678] [023/141] (916s left) kms_pipe_crc_basic (read-crc) [75.635953] Starting subtest: read-crc [75.636745] Starting dynamic subtest: pipe-A-HDMI-A-1 [75.918225] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.282s) [75.925353] Starting dynamic subtest: pipe-B-HDMI-A-1 [76.216672] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.294s) [76.222966] Starting dynamic subtest: pipe-C-HDMI-A-1 [76.487626] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.267s) [76.492363] Starting dynamic subtest: pipe-D-HDMI-A-1 [76.763914] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.275s) [76.764639] Subtest read-crc: SUCCESS (1.128s) [76.842746] [024/141] (914s left) kms_big_fb (x-tiled-64bpp-rotate-90) [76.953518] Starting subtest: x-tiled-64bpp-rotate-90 [76.991887] Subtest x-tiled-64bpp-rotate-90: SKIP (0.038s) [77.076226] [025/141] (914s left) kms_plane_lowres (tiling-4) [77.172374] Starting subtest: tiling-4 [77.173858] Subtest tiling-4: SKIP (0.000s) [77.209785] [026/141] (914s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt) [77.311779] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt [77.313167] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [77.376276] [027/141] (914s left) syncobj_timeline (signal) [77.426350] Starting subtest: signal [77.427154] Subtest signal: SUCCESS (0.000s) [77.459889] [028/141] (914s left) kms_content_protection (uevent) [77.563149] Starting subtest: uevent [77.876159] Subtest uevent: SKIP (0.311s) [77.983161] [029/141] (913s left) kms_sequence (queue-idle) [78.093537] Starting subtest: queue-idle [78.094306] Starting dynamic subtest: HDMI-A-1-pipe-A [79.251874] Dynamic subtest HDMI-A-1-pipe-A: SUCCESS (1.157s) [79.257871] Starting dynamic subtest: HDMI-A-1-pipe-B [80.428618] Dynamic subtest HDMI-A-1-pipe-B: SUCCESS (1.174s) [80.435964] Starting dynamic subtest: HDMI-A-1-pipe-C [81.593552] Dynamic subtest HDMI-A-1-pipe-C: SUCCESS (1.161s) [81.601905] Starting dynamic subtest: HDMI-A-1-pipe-D [82.757217] Dynamic subtest HDMI-A-1-pipe-D: SUCCESS (1.162s) [82.757995] Subtest queue-idle: SUCCESS (4.664s) [82.831094] [030/141] (908s left) gem_exec_fair (basic-flow) [82.886579] Starting subtest: basic-flow [82.887429] Starting dynamic subtest: rcs0 [89.897337] Dynamic subtest rcs0: SUCCESS (7.003s) [89.898144] Subtest basic-flow: SUCCESS (7.003s) [90.049754] [031/141] (901s left) syncobj_wait (reset-signaled) [90.105780] Starting subtest: reset-signaled [90.106552] Subtest reset-signaled: SUCCESS (0.000s) [90.145342] [032/141] (901s left) kms_rmfb (rmfb-ioctl) [90.252381] Starting subtest: rmfb-ioctl [90.254228] Starting dynamic subtest: pipe-A-HDMI-A-1 [90.350825] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.097s) [90.355828] Starting dynamic subtest: pipe-B-HDMI-A-1 [90.508770] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.156s) [90.513779] Starting dynamic subtest: pipe-C-HDMI-A-1 [90.666723] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.157s) [90.671750] Starting dynamic subtest: pipe-D-HDMI-A-1 [90.824813] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.157s) [90.825571] Subtest rmfb-ioctl: SUCCESS (0.573s) [90.969272] [033/141] (900s left) kms_ccs (pipe-d-bad-aux-stride-y_tiled_gen12_rc_ccs_cc) [91.385932] Starting subtest: pipe-D-bad-aux-stride-y_tiled_gen12_rc_ccs_cc [91.386693] Subtest pipe-D-bad-aux-stride-y_tiled_gen12_rc_ccs_cc: SUCCESS (0.001s) [91.477750] [034/141] (900s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite) [91.577092] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite [91.578603] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [91.640024] [035/141] (900s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt) [91.742324] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt [91.743702] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [91.798072] [036/141] (900s left) kms_ccs (pipe-c-bad-rotation-90-4_tiled_dg2_rc_ccs) [92.083590] Starting subtest: pipe-C-bad-rotation-90-4_tiled_dg2_rc_ccs [92.085129] Subtest pipe-C-bad-rotation-90-4_tiled_dg2_rc_ccs: SKIP (0.000s) [92.306144] [037/141] (899s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling) [92.405551] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling [92.407529] Starting dynamic subtest: pipe-A-valid-mode [92.468180] Dynamic subtest pipe-A-valid-mode: SKIP (0.060s) [92.469700] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.061s) [92.537289] [038/141] (899s left) gem_exec_schedule (u-semaphore-codependency) [92.595987] Starting subtest: u-semaphore-codependency [92.601881] Subtest u-semaphore-codependency: SUCCESS (0.006s) [92.845602] [039/141] (898s left) i915_hangman (engine-engine-hang) [92.897617] Starting subtest: engine-engine-hang [92.898407] Starting dynamic subtest: rcs0 [93.457026] Dynamic subtest rcs0: SUCCESS (0.559s) [93.461581] Starting dynamic subtest: bcs0 [94.016886] Dynamic subtest bcs0: SUCCESS (0.559s) [94.027953] Starting dynamic subtest: vcs0 [94.587842] Dynamic subtest vcs0: SUCCESS (0.570s) [94.595535] Starting dynamic subtest: vcs1 [95.150765] Dynamic subtest vcs1: SUCCESS (0.562s) [95.159074] Starting dynamic subtest: vecs0 [95.710701] Dynamic subtest vecs0: SUCCESS (0.559s) [95.712274] Subtest engine-engine-hang: SUCCESS (2.813s) [95.759756] [040/141] (896s left) vc4/vc4_mmap (mmap-bad-handle) [95.833410] Subtest mmap-bad-handle: SKIP (0.000s) [95.865920] [041/141] (896s left) gem_userptr_blits (unsync-unmap-cycles) [95.929901] Subtest unsync-unmap-cycles: SKIP (0.000s) [96.009956] [042/141] (895s left) kms_big_fb (yf-tiled-32bpp-rotate-90) [96.110868] Starting subtest: yf-tiled-32bpp-rotate-90 [96.112455] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s) [96.172614] [043/141] (895s left) kms_psr (psr2_sprite_render) [96.221654] Subtest psr2_sprite_render: SKIP (0.000s) [96.238601] [044/141] (895s left) sw_sync (sync_merge_invalid) [96.285177] Starting subtest: sync_merge_invalid [96.288195] Subtest sync_merge_invalid: SUCCESS (0.002s) [96.305315] [045/141] (895s left) gem_ctx_shared (disjoint-timelines) [96.360120] Starting subtest: disjoint-timelines [96.380042] Subtest disjoint-timelines: SUCCESS (0.020s) [96.566134] [046/141] (895s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt) [96.677324] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt [96.678868] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [96.731161] [047/141] (895s left) kms_ccs (pipe-c-bad-aux-stride-y_tiled_gen12_rc_ccs) [97.066405] Starting subtest: pipe-C-bad-aux-stride-y_tiled_gen12_rc_ccs [97.067341] Subtest pipe-C-bad-aux-stride-y_tiled_gen12_rc_ccs: SUCCESS (0.000s) [97.233127] [048/141] (894s left) kms_ccs (pipe-b-bad-pixel-format-y_tiled_gen12_rc_ccs) [97.447229] Starting subtest: pipe-B-bad-pixel-format-y_tiled_gen12_rc_ccs [97.448055] Subtest pipe-B-bad-pixel-format-y_tiled_gen12_rc_ccs: SUCCESS (0.000s) [97.751519] [049/141] (894s left) api_intel_allocator (reopen) [97.801342] Starting subtest: reopen [97.805112] Subtest reopen: SUCCESS (0.004s) [97.876492] [050/141] (894s left) gem_close_race (multigpu-basic-process) [97.935103] Starting subtest: multigpu-basic-process [97.936486] Subtest multigpu-basic-process: SKIP (0.000s) [98.085152] [051/141] (893s left) vc4/vc4_perfmon (get-values-valid-perfmon) [98.162659] Subtest get-values-valid-perfmon: SKIP (0.000s) [98.194550] [052/141] (893s left) gem_exec_reloc (basic-wc-read) [98.255691] Starting subtest: basic-wc-read [98.259939] Subtest basic-wc-read: SUCCESS (0.004s) [98.349948] [053/141] (893s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted) [98.398202] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted [98.398921] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s) [98.432498] [054/141] (893s left) gem_exec_capture (userptr) [98.490451] Starting subtest: userptr [99.767819] Subtest userptr: SUCCESS (1.269s) [99.843587] [055/141] (892s left) v3d/v3d_submit_cl (bad-in-sync) [99.921114] Subtest bad-in-sync: SKIP (0.000s) [99.953365] [056/141] (892s left) gem_mmap_gtt (hang-busy) [100.014620] Starting subtest: hang-busy [128.481642] Subtest hang-busy: SUCCESS (28.431s) [128.521156] [057/141] (863s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling) [128.615585] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling [128.617225] Starting dynamic subtest: pipe-A-valid-mode [129.353638] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.736s) [129.354399] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SUCCESS (0.738s) [129.466186] [058/141] (862s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite) [129.569058] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite [129.570454] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [129.618762] [059/141] (862s left) kms_big_fb (y-tiled-64bpp-rotate-0) [129.722399] Starting subtest: y-tiled-64bpp-rotate-0 [131.097711] Subtest y-tiled-64bpp-rotate-0: SUCCESS (1.375s) [131.186615] [060/141] (860s left) gem_mmap_wc (write-prefaulted) [131.314247] Starting subtest: write-prefaulted [131.353703] Subtest write-prefaulted: SUCCESS (0.040s) [131.405945] [061/141] (860s left) gem_exec_fence (parallel) [131.598400] Starting subtest: parallel [131.599253] Starting dynamic subtest: rcs0 [133.772488] Dynamic subtest rcs0: SUCCESS (2.148s) [133.777300] Starting dynamic subtest: bcs0 [135.922852] Dynamic subtest bcs0: SUCCESS (2.149s) [135.927445] Starting dynamic subtest: vcs0 [138.072657] Dynamic subtest vcs0: SUCCESS (2.149s) [138.077317] Starting dynamic subtest: vcs1 [140.221652] Dynamic subtest vcs1: SUCCESS (2.148s) [140.226247] Starting dynamic subtest: vecs0 [142.372629] Dynamic subtest vecs0: SUCCESS (2.150s) [142.374103] Subtest parallel: SUCCESS (10.748s) [142.760671] [062/141] (849s left) kms_plane_scaling (planes-upscale-20x20) [142.859231] Starting subtest: planes-upscale-20x20 [142.859973] Starting dynamic subtest: pipe-A-HDMI-A-1 [142.915105] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.055s) [142.920755] Starting dynamic subtest: pipe-B-HDMI-A-1 [143.024294] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.107s) [143.029840] Starting dynamic subtest: pipe-C-HDMI-A-1 [143.132933] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.107s) [143.138491] Starting dynamic subtest: pipe-D-HDMI-A-1 [143.248902] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.114s) [143.249660] Subtest planes-upscale-20x20: SUCCESS (0.391s) [143.386623] [063/141] (848s left) perf_pmu (most-busy-check-all) [143.436794] Starting subtest: most-busy-check-all [143.437557] Starting dynamic subtest: rcs0 [143.952924] Dynamic subtest rcs0: SUCCESS (0.516s) [143.958608] Starting dynamic subtest: bcs0 [144.468682] Dynamic subtest bcs0: SUCCESS (0.515s) [144.476887] Starting dynamic subtest: vcs0 [144.986389] Dynamic subtest vcs0: SUCCESS (0.513s) [144.992147] Starting dynamic subtest: vcs1 [145.503343] Dynamic subtest vcs1: SUCCESS (0.517s) [145.509411] Starting dynamic subtest: vecs0 [146.021362] Dynamic subtest vecs0: SUCCESS (0.518s) [146.022649] Subtest most-busy-check-all: SUCCESS (2.585s) [146.066895] [064/141] (846s left) kms_ccs (pipe-d-crc-primary-rotation-180-y_tiled_gen12_mc_ccs) [146.454614] Starting subtest: pipe-D-crc-primary-rotation-180-y_tiled_gen12_mc_ccs [146.456267] Subtest pipe-D-crc-primary-rotation-180-y_tiled_gen12_mc_ccs: SKIP (0.000s) [146.587542] [065/141] (845s left) gem_wait (await) [146.644151] Starting subtest: await [146.645020] Starting dynamic subtest: all-engines [147.666723] Dynamic subtest all-engines: SUCCESS (1.021s) [147.673667] Starting dynamic subtest: rcs0 [148.694503] Dynamic subtest rcs0: SUCCESS (1.027s) [148.701831] Starting dynamic subtest: bcs0 [149.717690] Dynamic subtest bcs0: SUCCESS (1.021s) [149.724223] Starting dynamic subtest: vcs0 [150.737347] Dynamic subtest vcs0: SUCCESS (1.019s) [150.745946] Starting dynamic subtest: vcs1 [151.760507] Dynamic subtest vcs1: SUCCESS (1.022s) [151.768512] Starting dynamic subtest: vecs0 [152.781888] Dynamic subtest vecs0: SUCCESS (1.016s) [152.783183] Subtest await: SUCCESS (6.134s) [152.945614] [066/141] (839s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [153.056053] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [153.299517] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.244s) [153.390941] [067/141] (838s left) kms_cursor_crc (cursor-onscreen-64x21) [153.500505] Starting subtest: cursor-onscreen-64x21 [153.505714] Starting dynamic subtest: pipe-A-HDMI-A-1 [154.658231] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.153s) [154.683375] Starting dynamic subtest: pipe-D-HDMI-A-1 [155.913166] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.235s) [155.913966] Subtest cursor-onscreen-64x21: SUCCESS (2.414s) [156.013469] [068/141] (836s left) gem_exec_gttfill (engines) [156.077470] Starting subtest: engines [156.078241] Starting dynamic subtest: rcs0 [179.526554] Dynamic subtest rcs0: SUCCESS (23.448s) [179.532702] Starting dynamic subtest: bcs0 [202.693241] Dynamic subtest bcs0: SUCCESS (23.166s) [202.698466] Starting dynamic subtest: vcs0 [225.912253] Dynamic subtest vcs0: SUCCESS (23.217s) [225.917500] Starting dynamic subtest: vcs1 [249.160261] Dynamic subtest vcs1: SUCCESS (23.248s) [249.165319] Starting dynamic subtest: vecs0 [272.538510] Dynamic subtest vecs0: SUCCESS (23.369s) [272.539306] Subtest engines: SUCCESS (116.453s) [272.691058] [069/141] (719s left) gem_ctx_persistence (engines-cleanup) [272.790137] Starting subtest: engines-cleanup [272.790886] Starting dynamic subtest: rcs0 [272.822813] Dynamic subtest rcs0: SUCCESS (0.032s) [272.832998] Starting dynamic subtest: bcs0 [272.858685] Dynamic subtest bcs0: SUCCESS (0.034s) [272.873347] Starting dynamic subtest: vcs0 [272.901709] Dynamic subtest vcs0: SUCCESS (0.041s) [272.916524] Starting dynamic subtest: vcs1 [272.935789] Dynamic subtest vcs1: SUCCESS (0.032s) [272.949990] Starting dynamic subtest: vecs0 [272.978798] Dynamic subtest vecs0: SUCCESS (0.041s) [272.980202] Subtest engines-cleanup: SUCCESS (0.189s) [273.028833] [070/141] (719s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu) [273.145890] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu [273.147307] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [273.205295] [071/141] (719s left) kms_psr (sprite_blt) [273.253190] Subtest sprite_blt: SKIP (0.000s) [273.272590] [072/141] (719s left) syncobj_basic (bad-destroy) [273.324318] Starting subtest: bad-destroy [273.325054] Subtest bad-destroy: SUCCESS (0.000s) [273.367589] [073/141] (718s left) kms_plane (plane-position-hole-dpms) [273.479269] Starting subtest: plane-position-hole-dpms [273.482112] Starting dynamic subtest: pipe-A-planes [275.427659] Dynamic subtest pipe-A-planes: SUCCESS (1.946s) [275.433852] Starting dynamic subtest: pipe-B-planes [277.306879] Dynamic subtest pipe-B-planes: SUCCESS (1.877s) [277.307688] Subtest plane-position-hole-dpms: SUCCESS (3.828s) [277.414492] [074/141] (714s left) kms_vblank (pipe-d-wait-busy-hang) [277.515044] Starting subtest: pipe-D-wait-busy-hang [291.805341] Subtest pipe-D-wait-busy-hang: SUCCESS (14.290s) [291.937941] [075/141] (700s left) kms_ccs (pipe-c-crc-primary-basic-y_tiled_ccs) [292.243090] Starting subtest: pipe-C-crc-primary-basic-y_tiled_ccs [292.244697] Subtest pipe-C-crc-primary-basic-y_tiled_ccs: SKIP (0.000s) [292.457017] [076/141] (699s left) gem_render_copy (linear-to-vebox-y-tiled) [292.516206] Starting subtest: linear-to-vebox-y-tiled [292.516961] Starting dynamic subtest: smem [292.623887] Dynamic subtest smem: SUCCESS (0.107s) [292.624763] Subtest linear-to-vebox-y-tiled: SUCCESS (0.108s) [292.779382] [077/141] (699s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt) [292.880651] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt [292.882257] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [292.930427] [078/141] (699s left) kms_ccs (pipe-a-crc-primary-rotation-180-yf_tiled_ccs) [293.093748] Starting subtest: pipe-A-crc-primary-rotation-180-yf_tiled_ccs [293.095483] Subtest pipe-A-crc-primary-rotation-180-yf_tiled_ccs: SKIP (0.000s) [293.439340] [079/141] (698s left) kms_flip (nonblocking-read) [293.521500] Starting subtest: nonblocking-read [293.522305] Subtest nonblocking-read: SUCCESS (0.000s) [293.574508] [080/141] (698s left) api_intel_allocator (reserve-simple) [293.626050] Starting subtest: reserve-simple [293.626809] Subtest reserve-simple: SUCCESS (0.001s) [293.697584] [081/141] (698s left) syncobj_basic (bad-handle-to-fd) [293.744474] Starting subtest: bad-handle-to-fd [293.745330] Subtest bad-handle-to-fd: SUCCESS (0.000s) [293.780470] [082/141] (698s left) kms_chamelium_edid (dp-mode-timings) [293.934764] Subtest dp-mode-timings: SKIP (0.000s) [293.990098] [083/141] (698s left) prime_mmap (test_forked_cpu_write) [294.040827] Starting subtest: test_forked_cpu_write [294.041574] Starting dynamic subtest: test_forked_cpu_write-smem [294.052341] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.012s) [294.053088] Subtest test_forked_cpu_write: SUCCESS (0.013s) [294.123189] [084/141] (698s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode) [294.272140] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s) [294.328189] [085/141] (698s left) syncobj_timeline (single-wait-for-submit-available-signaled) [294.381952] Starting subtest: single-wait-for-submit-available-signaled [294.382807] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s) [294.425912] [086/141] (698s left) gem_ctx_engines (execute-oneforall) [294.482122] Starting subtest: execute-oneforall [294.683255] Subtest execute-oneforall: SUCCESS (0.192s) [294.835370] [087/141] (697s left) gem_fenced_exec_thrash (too-many-fences) [294.897106] Starting subtest: too-many-fences [297.047983] Subtest too-many-fences: SUCCESS (2.151s) [297.120819] [088/141] (695s left) kms_flip (2x-dpms-vs-vblank-race) [297.213399] Starting subtest: 2x-dpms-vs-vblank-race [297.226095] Subtest 2x-dpms-vs-vblank-race: SKIP (0.012s) [297.274424] [089/141] (695s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt) [297.376687] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt [297.378121] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [297.423949] [090/141] (695s left) gem_spin_batch (legacy-resubmit) [297.476777] Starting subtest: legacy-resubmit [297.477619] Starting dynamic subtest: default [297.479546] Dynamic subtest default: SUCCESS (0.001s) [297.485208] Starting dynamic subtest: render [297.486046] Dynamic subtest render: SUCCESS (0.001s) [297.491441] Starting dynamic subtest: bsd [297.492156] Dynamic subtest bsd: SUCCESS (0.001s) [297.497011] Starting dynamic subtest: bsd1 [297.497732] Dynamic subtest bsd1: SUCCESS (0.001s) [297.502364] Starting dynamic subtest: bsd2 [297.503074] Dynamic subtest bsd2: SUCCESS (0.001s) [297.507425] Starting dynamic subtest: blt [297.508128] Dynamic subtest blt: SUCCESS (0.001s) [297.512425] Starting dynamic subtest: vebox [297.513128] Dynamic subtest vebox: SUCCESS (0.001s) [297.513881] Subtest legacy-resubmit: SUCCESS (0.013s) [297.650291] [091/141] (694s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc) [297.764533] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc [297.766019] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [297.823609] [092/141] (694s left) gem_exec_alignment (pi-isolated) [297.873323] Starting subtest: pi-isolated [310.416121] Killing the test because the kernel is tainted. [313.008600] Aborting: Lockdep not active /proc/lockdep_stats contents: lock-classes: 1783 [max: 8192] direct dependencies: 16896 [max: 32768] indirect dependencies: 133605 all direct dependencies: 371208 dependency chains: 23930 [max: 131072] dependency chain hlocks used: 98784 [max: 655360] dependency chain hlocks lost: 0 in-hardirq chains: 258 in-softirq chains: 661 in-process chains: 23011 stack-trace entries: 153143 [max: 1048576] number of stack traces: 8098 number of stack hash chains: 6421 combined max dependencies: 3945591496 hardirq-safe locks: 105 hardirq-unsafe locks: 1064 softirq-safe locks: 215 softirq-unsafe locks: 974 irq-safe locks: 228 irq-unsafe locks: 1064 hardirq-read-safe locks: 4 hardirq-read-unsafe locks: 320 softirq-read-safe locks: 8 softirq-read-unsafe locks: 315 irq-read-safe locks: 8 irq-read-unsafe locks: 320 uncategorized locks: 285 unused locks: 1 max locking depth: 16 max bfs queue depth: 390 max lock class index: 1782 chain lookup misses: 24215 chain lookup hits: 588567735 cyclic checks: 24326 redundant checks: 0 redundant links: 0 find-mask forwards checks: 4042 find-mask backwards checks: 2675 hardirq on events: 372213158 hardirq off events: 372213150 redundant hardirq ons: 44 redundant hardirq offs: 27 softirq on events: 3768381 softirq off events: 3768381 redundant softirq ons: 0 redundant softirq offs: 0 debug_locks: 0 zapped classes: 1 zapped lock chains: 117 large chain blocks: 1 [313.009678] Closing watchdogs Done.