[55.200967] Initializing watchdogs
[55.201316]   /dev/watchdog0
[55.218197] [001/142] (960s left) gem_softpin (evict-snoop)
[55.474302] Starting subtest: evict-snoop
[55.477979] Subtest evict-snoop: SKIP (0.000s)
[55.581480] [002/142] (960s left) kms_cursor_legacy (single-bo)
[55.888222] Starting subtest: single-bo
[55.889949] Starting dynamic subtest: pipe-A
[61.299693] Dynamic subtest pipe-A: SUCCESS (5.411s)
[61.311781] Starting dynamic subtest: pipe-B
[66.705989] Dynamic subtest pipe-B: SUCCESS (5.405s)
[66.718206] Starting dynamic subtest: pipe-C
[72.111527] Dynamic subtest pipe-C: SUCCESS (5.405s)
[72.123826] Starting dynamic subtest: all-pipes
[77.521901] Dynamic subtest all-pipes: SUCCESS (5.408s)
[77.523727] Subtest single-bo: SUCCESS (21.631s)
[77.597198] [003/142] (938s left) kms_color (legacy-gamma)
[77.903891] Starting subtest: legacy-gamma
[77.905761] Starting dynamic subtest: pipe-A
[78.513862] Dynamic subtest pipe-A: SUCCESS (0.612s)
[78.533748] Starting dynamic subtest: pipe-B
[79.368985] Dynamic subtest pipe-B: SUCCESS (0.855s)
[79.384761] Starting dynamic subtest: pipe-C
[80.389947] Dynamic subtest pipe-C: SUCCESS (1.020s)
[80.391284] Subtest legacy-gamma: SUCCESS (2.488s)
[80.726963] [004/142] (935s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[81.126247] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[81.410154] [005/142] (934s left) perf_pmu (busy)
[81.622423] Starting subtest: busy
[81.623773] Starting dynamic subtest: rcs0
[82.182679] Dynamic subtest rcs0: SUCCESS (0.560s)
[82.200123] Starting dynamic subtest: bcs0
[82.723791] Dynamic subtest bcs0: SUCCESS (0.541s)
[82.738617] Starting dynamic subtest: vcs0
[83.267675] Dynamic subtest vcs0: SUCCESS (0.544s)
[83.282883] Starting dynamic subtest: vecs0
[83.805902] Dynamic subtest vecs0: SUCCESS (0.538s)
[83.808089] Subtest busy: SUCCESS (2.184s)
[83.891993] [006/142] (931s left) kms_rotation_crc (primary-rotation-180)
[84.205765] Starting subtest: primary-rotation-180
[88.586171] Subtest primary-rotation-180: SUCCESS (4.385s)
[89.009872] [007/142] (926s left) kms_setmode (basic)
[89.216527] Starting subtest: basic
[89.630113] Starting dynamic subtest: pipe-A-DP-1
[91.942054] Dynamic subtest pipe-A-DP-1: SUCCESS (2.312s)
[92.094279] Starting dynamic subtest: pipe-B-DP-1
[94.388806] Dynamic subtest pipe-B-DP-1: SUCCESS (2.304s)
[94.485456] Subtest basic: SUCCESS (5.269s)
[94.818973] [008/142] (921s left) sw_sync (timeline_closed)
[95.023037] Starting subtest: timeline_closed
[95.024566] Subtest timeline_closed: SUCCESS (0.000s)
[95.085539] [009/142] (920s left) kms_ccs (pipe-c-bad-rotation-90-y_tiled_gen12_mc_ccs)
[95.664990] Starting subtest: pipe-C-bad-rotation-90-y_tiled_gen12_mc_ccs
[95.667460] Subtest pipe-C-bad-rotation-90-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[96.067068] [010/142] (919s left) kms_ccs (pipe-b-bad-aux-stride-y_tiled_ccs)
[96.615248] Starting subtest: pipe-B-bad-aux-stride-y_tiled_ccs
[96.618764] Subtest pipe-B-bad-aux-stride-y_tiled_ccs: SUCCESS (0.003s)
[97.053068] [011/142] (919s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[97.365226] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[97.367831] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[97.468188] [012/142] (918s left) kms_psr2_su (page_flip-xrgb8888)
[97.670871] Subtest page_flip-XRGB8888: SKIP (0.000s)
[97.717242] [013/142] (918s left) gem_workarounds (reset-context)
[97.952039] Starting subtest: reset-context
[97.983904] Subtest reset-context: SUCCESS (0.030s)
[98.104179] [014/142] (918s left) gem_softpin (evict-single-offset)
[98.314075] Starting subtest: evict-single-offset
[134.172286] Subtest evict-single-offset: SUCCESS (35.859s)
[134.270152] [015/142] (881s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[134.617509] Starting subtest: multi-wait-for-submit-submitted-signaled
[134.620591] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.003s)
[134.702782] [016/142] (881s left) gem_exec_whisper (basic-fds-priority)
[134.930533] Starting subtest: basic-fds-priority
[155.403823] Subtest basic-fds-priority: SUCCESS (20.471s)
[155.609497] [017/142] (860s left) kms_frontbuffer_tracking (fbc-stridechange)
[155.930837] Starting subtest: fbc-stridechange
[157.567504] Subtest fbc-stridechange: SUCCESS (1.639s)
[157.722052] [018/142] (858s left) gem_ctx_persistence (legacy-engines-queued)
[157.936137] Starting subtest: legacy-engines-queued
[157.937459] Starting dynamic subtest: render
[157.986847] Dynamic subtest render: SUCCESS (0.051s)
[158.006323] Starting dynamic subtest: bsd
[158.046925] Dynamic subtest bsd: SUCCESS (0.059s)
[158.067217] Starting dynamic subtest: blt
[158.196686] Dynamic subtest blt: SUCCESS (0.148s)
[158.216078] Starting dynamic subtest: vebox
[158.258971] Dynamic subtest vebox: SUCCESS (0.060s)
[158.260395] Subtest legacy-engines-queued: SUCCESS (0.323s)
[158.355190] [019/142] (857s left) gen7_exec_parse (load-register-reg)
[158.567786] Subtest load-register-reg: SKIP (0.000s)
[158.622250] [020/142] (857s left) kms_vblank (pipe-a-wait-forked)
[158.924117] Starting subtest: pipe-A-wait-forked
[161.264402] Subtest pipe-A-wait-forked: SUCCESS (2.343s)
[161.598384] [021/142] (854s left) gem_ctx_isolation (nonpriv)
[161.826125] Starting subtest: nonpriv
[161.827535] Starting dynamic subtest: rcs0
[164.157674] Dynamic subtest rcs0: SUCCESS (2.330s)
[164.176171] Starting dynamic subtest: bcs0
[167.131285] Dynamic subtest bcs0: SUCCESS (2.974s)
[167.149368] Starting dynamic subtest: vcs0
[169.366720] Dynamic subtest vcs0: SUCCESS (2.235s)
[169.384653] Starting dynamic subtest: vecs0
[171.598704] Dynamic subtest vecs0: SUCCESS (2.232s)
[171.600252] Subtest nonpriv: SUCCESS (9.773s)
[171.795881] [022/142] (844s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[172.095885] Starting subtest: disable-crc-after-crtc
[172.097284] Starting dynamic subtest: pipe-A-DP-1
[172.839895] Dynamic subtest pipe-A-DP-1: SUCCESS (0.741s)
[172.862725] Starting dynamic subtest: pipe-B-DP-1
[173.846344] Dynamic subtest pipe-B-DP-1: SUCCESS (1.004s)
[173.867643] Starting dynamic subtest: pipe-C-DP-1
[175.017097] Dynamic subtest pipe-C-DP-1: SUCCESS (1.165s)
[175.018306] Subtest disable-crc-after-crtc: SUCCESS (2.919s)
[175.344867] [023/142] (841s left) debugfs_test (basic-hwmon)
[175.556791] Starting subtest: basic-hwmon
[175.559520] Subtest basic-hwmon: SKIP (0.000s)
[175.744984] [024/142] (840s left) i915_module_load (reload-no-display)
[175.942291] Starting subtest: reload-no-display
[179.890739] Subtest reload-no-display: SUCCESS (3.948s)
[179.922718] [025/142] (836s left) kms_plane_scaling (intel-max-src-size)
[183.387750] Starting subtest: intel-max-src-size
[183.390298] Subtest intel-max-src-size: SKIP (0.000s)
[183.499839] [026/142] (833s left) feature_discovery (display-3x)
[183.878657] Starting subtest: display-3x
[183.881307] Subtest display-3x: SKIP (0.000s)
[183.958600] [027/142] (832s left) kms_sequence (queue-busy)
[184.254833] Starting subtest: queue-busy
[184.256177] Starting dynamic subtest: DP-1-pipe-A
[186.784022] Dynamic subtest DP-1-pipe-A: SUCCESS (2.529s)
[186.803708] Starting dynamic subtest: DP-1-pipe-B
[189.461103] Dynamic subtest DP-1-pipe-B: SUCCESS (2.674s)
[189.479417] Starting dynamic subtest: DP-1-pipe-C
[192.392613] Dynamic subtest DP-1-pipe-C: SUCCESS (2.929s)
[192.393945] Subtest queue-busy: SUCCESS (8.140s)
[192.717769] [028/142] (824s left) syncobj_timeline (wait-all-for-submit-complex)
[192.918680] Starting subtest: wait-all-for-submit-complex
[193.135261] Subtest wait-all-for-submit-complex: SUCCESS (0.216s)
[193.216085] [029/142] (823s left) kms_ccs (pipe-b-crc-primary-rotation-180-4_tiled_mtl_rc_ccs)
[193.721044] Starting subtest: pipe-B-crc-primary-rotation-180-4_tiled_mtl_rc_ccs
[193.723535] Subtest pipe-B-crc-primary-rotation-180-4_tiled_mtl_rc_ccs: SKIP (0.001s)
[194.200962] [030/142] (822s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[194.431180] Starting subtest: untiled-to-tiled
[194.569639] Subtest untiled-to-tiled: SUCCESS (0.137s)
[194.668739] [031/142] (822s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[194.976310] Starting subtest: 2x-flip-vs-cursor-atomic
[194.979542] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.004s)
[195.068151] [032/142] (821s left) perf_pmu (semaphore-busy)
[195.275766] Starting subtest: semaphore-busy
[195.278085] Starting dynamic subtest: rcs0
[196.840778] Dynamic subtest rcs0: SUCCESS (1.562s)
[196.859447] Starting dynamic subtest: bcs0
[198.407963] Dynamic subtest bcs0: SUCCESS (1.566s)
[198.426845] Starting dynamic subtest: vcs0
[199.969408] Dynamic subtest vcs0: SUCCESS (1.559s)
[199.987327] Starting dynamic subtest: vecs0
[201.519498] Dynamic subtest vecs0: SUCCESS (1.548s)
[201.521130] Subtest semaphore-busy: SUCCESS (6.242s)
[201.633268] [033/142] (815s left) syncobj_timeline (invalid-signal-illegal-point)
[201.836919] Starting subtest: invalid-signal-illegal-point
[201.838467] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[201.918224] [034/142] (815s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[202.501513] Starting subtest: plane-primary-overlay-mutable-zpos
[202.505556] Subtest plane-primary-overlay-mutable-zpos: SKIP (0.001s)
[202.928179] [035/142] (814s left) gem_madvise (dontneed-before-mmap)
[203.124647] Starting subtest: dontneed-before-mmap
[203.140901] Subtest dontneed-before-mmap: SUCCESS (0.015s)
[203.226083] [036/142] (813s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[203.521407] Starting subtest: read-crc-frame-sequence
[203.522966] Starting dynamic subtest: pipe-A-DP-1
[204.050470] Dynamic subtest pipe-A-DP-1: SUCCESS (0.529s)
[204.071375] Starting dynamic subtest: pipe-B-DP-1
[204.867141] Dynamic subtest pipe-B-DP-1: SUCCESS (0.812s)
[204.886506] Starting dynamic subtest: pipe-C-DP-1
[205.815556] Dynamic subtest pipe-C-DP-1: SUCCESS (0.945s)
[205.817299] Subtest read-crc-frame-sequence: SUCCESS (2.297s)
[206.132468] [037/142] (810s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-render)
[206.442833] Starting subtest: psr-1p-offscren-pri-indfb-draw-render
[206.445692] Subtest psr-1p-offscren-pri-indfb-draw-render: SKIP (0.000s)
[206.547521] [038/142] (810s left) api_intel_bb (full-batch)
[206.749662] Starting subtest: full-batch
[206.756515] Subtest full-batch: SUCCESS (0.007s)
[206.864797] [039/142] (810s left) gem_exec_balancer (invalid-balancer)
[207.089128] Starting subtest: invalid-balancer
[210.853217] Subtest invalid-balancer: SUCCESS (3.763s)
[214.797439] [040/142] (802s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[215.084557] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[215.090765] Starting dynamic subtest: A-DP1
[216.374332] Dynamic subtest A-DP1: SUCCESS (1.285s)
[216.392906] Starting dynamic subtest: B-DP1
[217.529835] Dynamic subtest B-DP1: SUCCESS (1.151s)
[217.549287] Starting dynamic subtest: C-DP1
[218.643870] Dynamic subtest C-DP1: SUCCESS (1.116s)
[218.645365] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (3.561s)
[218.995827] [041/142] (798s left) kms_scaling_modes (scaling-mode-center)
[219.299428] Starting subtest: scaling-mode-center
[219.302460] Subtest scaling-mode-center: SKIP (0.001s)
[219.392635] [042/142] (797s left) gem_lmem_swapping (verify-random)
[219.602261] Subtest verify-random: SKIP (0.000s)
[219.657697] [043/142] (797s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[219.956296] Starting subtest: cursor-vs-flip-atomic
[258.290352] Subtest cursor-vs-flip-atomic: SUCCESS (38.330s)
[258.625509] [044/142] (758s left) kms_flip (busy-flip)
[258.904803] Starting subtest: busy-flip
[258.912392] Starting dynamic subtest: A-DP1
[259.956336] Dynamic subtest A-DP1: SUCCESS (1.048s)
[259.976463] Starting dynamic subtest: B-DP1
[260.923241] Dynamic subtest B-DP1: SUCCESS (0.965s)
[260.944773] Starting dynamic subtest: C-DP1
[261.892366] Dynamic subtest C-DP1: SUCCESS (0.963s)
[261.893784] Subtest busy-flip: SUCCESS (2.988s)
[262.320449] [045/142] (755s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[262.623217] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[262.625657] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[262.716682] [046/142] (754s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[263.022958] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[263.024604] Starting dynamic subtest: pipe-A-valid-mode
[263.717753] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.694s)
[263.719593] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SUCCESS (0.698s)
[264.056478] [047/142] (753s left) kms_vblank (pipe-b-ts-continuation-modeset)
[264.357087] Starting subtest: pipe-B-ts-continuation-modeset
[265.374113] Subtest pipe-B-ts-continuation-modeset: SUCCESS (1.019s)
[265.710843] [048/142] (751s left) i915_pm_rc6_residency (rc6-fence)
[265.909361] Starting subtest: rc6-fence
[281.152746] Subtest rc6-fence: SUCCESS (15.244s)
[281.410390] [049/142] (736s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[281.718285] Starting subtest: fbcpsr-tiling-4
[281.721165] Subtest fbcpsr-tiling-4: SKIP (0.000s)
[281.828126] [050/142] (735s left) i915_fb_tiling
[282.132991] [051/142] (735s left) vc4/vc4_create_bo (create-bo-0)
[282.372465] Subtest create-bo-0: SKIP (0.000s)
[282.442860] [052/142] (735s left) gem_flink_basic (basic)
[282.646140] Starting subtest: basic
[282.648080] Subtest basic: SUCCESS (0.000s)
[282.743700] [053/142] (734s left) gem_ctx_persistence (engines-queued)
[282.952495] Starting subtest: engines-queued
[282.954363] Starting dynamic subtest: rcs0
[283.012964] Dynamic subtest rcs0: SUCCESS (0.059s)
[283.032508] Starting dynamic subtest: bcs0
[283.182635] Dynamic subtest bcs0: SUCCESS (0.167s)
[283.206261] Starting dynamic subtest: vcs0
[283.242722] Dynamic subtest vcs0: SUCCESS (0.057s)
[283.264912] Starting dynamic subtest: vecs0
[283.302506] Dynamic subtest vecs0: SUCCESS (0.057s)
[283.303914] Subtest engines-queued: SUCCESS (0.351s)
[283.393607] [054/142] (734s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[283.708269] Starting subtest: cursor-rapid-movement-64x64
[283.717627] Starting dynamic subtest: pipe-A-DP-1
[284.235526] Dynamic subtest pipe-A-DP-1: SUCCESS (0.518s)
[284.324595] Starting dynamic subtest: pipe-C-DP-1
[285.133345] Dynamic subtest pipe-C-DP-1: SUCCESS (0.831s)
[285.134545] Subtest cursor-rapid-movement-64x64: SUCCESS (1.427s)
[285.503206] [055/142] (732s left) kms_big_fb (linear-8bpp-rotate-270)
[285.818570] Starting subtest: linear-8bpp-rotate-270
[285.900612] Subtest linear-8bpp-rotate-270: SKIP (0.080s)
[286.016877] [056/142] (731s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[286.324274] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[286.326785] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[286.416946] [057/142] (731s left) kms_psr (primary_mmap_cpu)
[286.616234] Subtest primary_mmap_cpu: SKIP (0.000s)
[286.665435] [058/142] (731s left) kms_flip (nonblocking-read)
[286.953236] Starting subtest: nonblocking-read
[286.954631] Subtest nonblocking-read: SUCCESS (0.000s)
[287.067301] [059/142] (730s left) kms_fence_pin_leak
[291.230364] [060/142] (726s left) kms_ccs (pipe-d-bad-rotation-90-yf_tiled_ccs)
[291.915602] Subtest pipe-D-bad-rotation-90-yf_tiled_ccs: SKIP (0.000s)
[292.232583] [061/142] (725s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[292.452300] Starting subtest: yf-tiled-to-vebox-x-tiled
[292.454956] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[292.660550] [062/142] (725s left) kms_ccs (pipe-a-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc)
[293.093876] Starting subtest: pipe-A-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc
[293.096784] Subtest pipe-A-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[293.639522] [063/142] (724s left) kms_ccs (pipe-c-random-ccs-data-y_tiled_ccs)
[294.263592] Starting subtest: pipe-C-random-ccs-data-y_tiled_ccs
[294.268164] Subtest pipe-C-random-ccs-data-y_tiled_ccs: SKIP (0.000s)
[294.656506] [064/142] (723s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[294.972183] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[294.974882] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[295.072771] [065/142] (723s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[295.379777] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[295.382835] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[295.472616] [066/142] (722s left) kms_frontbuffer_tracking (fbc-2p-rte)
[295.789939] Starting subtest: fbc-2p-rte
[295.792897] Subtest fbc-2p-rte: SKIP (0.000s)
[295.889640] [067/142] (722s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[296.206773] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[296.210223] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[296.306264] [068/142] (721s left) kms_prop_blob (invalid-set-prop)
[296.506257] Starting subtest: invalid-set-prop
[296.507954] Subtest invalid-set-prop: SUCCESS (0.000s)
[296.589373] [069/142] (721s left) i915_query (query-topology-matches-eu-total)
[296.786702] Starting subtest: query-topology-matches-eu-total
[296.788372] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[296.872484] [070/142] (721s left) gem_exec_schedule (preempt-hang)
[297.220893] Starting subtest: preempt-hang
[297.222717] Starting dynamic subtest: rcs0
[297.503717] Dynamic subtest rcs0: SUCCESS (0.282s)
[297.529306] Starting dynamic subtest: bcs0
[297.819853] Dynamic subtest bcs0: SUCCESS (0.307s)
[297.841883] Starting dynamic subtest: vcs0
[298.090351] Dynamic subtest vcs0: SUCCESS (0.275s)
[298.118203] Starting dynamic subtest: vecs0
[298.363264] Dynamic subtest vecs0: SUCCESS (0.264s)
[298.364552] Subtest preempt-hang: SUCCESS (1.137s)
[298.606786] [071/142] (719s left) kms_ccs (pipe-b-bad-rotation-90-4_tiled_mtl_rc_ccs)
[299.103372] Starting subtest: pipe-B-bad-rotation-90-4_tiled_mtl_rc_ccs
[299.106051] Subtest pipe-B-bad-rotation-90-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[299.608606] [072/142] (718s left) syncobj_timeline (device-signal-unordered)
[299.813317] Starting subtest: device-signal-unordered
[299.817819] Subtest device-signal-unordered: SUCCESS (0.002s)
[299.908233] [073/142] (718s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[300.210881] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[300.213574] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[300.308466] [074/142] (718s left) kms_properties (invalid-properties-legacy)
[300.610402] Starting subtest: invalid-properties-legacy
[300.745369] Subtest invalid-properties-legacy: SUCCESS (0.137s)
[300.842572] [075/142] (717s left) syncobj_wait (wait-all-complex)
[301.048403] Starting subtest: wait-all-complex
[301.264684] Subtest wait-all-complex: SUCCESS (0.216s)
[301.358277] [076/142] (717s left) gem_create (create-massive)
[301.560433] Starting subtest: create-massive
[301.561767] Subtest create-massive: SUCCESS (0.000s)
[301.775767] [077/142] (716s left) gem_userptr_blits (userfault)
[301.988993] Starting subtest: userfault
[301.998040] Subtest userfault: SUCCESS (0.009s)
[302.176326] [078/142] (716s left) i915_selftest (perf)
[303.708127] Starting subtest: perf
[303.709759] Starting dynamic subtest: engine_cs
[304.979172] Dynamic subtest engine_cs: SUCCESS (1.271s)
[304.995655] Starting dynamic subtest: request
[309.367239] Dynamic subtest request: SUCCESS (4.386s)
[309.383782] Starting dynamic subtest: migrate
[310.793347] Dynamic subtest migrate: SUCCESS (1.424s)
[310.809999] Starting dynamic subtest: region
[313.461539] Dynamic subtest region: SUCCESS (2.665s)
[313.463148] Subtest perf: SUCCESS (9.756s)
[313.499795] [079/142] (705s left) kms_flip (basic-flip-vs-dpms)
[315.952778] Starting subtest: basic-flip-vs-dpms
[315.958801] Starting dynamic subtest: A-DP1
[317.343813] Dynamic subtest A-DP1: SUCCESS (1.383s)
[317.361493] Starting dynamic subtest: B-DP1
[318.473209] Dynamic subtest B-DP1: SUCCESS (1.117s)
[318.491153] Starting dynamic subtest: C-DP1
[319.578758] Dynamic subtest C-DP1: SUCCESS (1.104s)
[319.580077] Subtest basic-flip-vs-dpms: SUCCESS (3.620s)
[319.964609] [080/142] (698s left) i915_pm_rpm (system-suspend)
[321.825201] Starting subtest: system-suspend
[339.681696] Subtest system-suspend: SUCCESS (1.396s)
[345.059968] [081/142] (694s left) kms_ccs (pipe-b-missing-ccs-buffer-yf_tiled_ccs)
[345.596829] Starting subtest: pipe-B-missing-ccs-buffer-yf_tiled_ccs
[345.598195] Subtest pipe-B-missing-ccs-buffer-yf_tiled_ccs: SUCCESS (0.001s)
[346.061318] [082/142] (693s left) gem_pxp (create-regular-context-2)
[348.794912] Subtest create-regular-context-2: SKIP (0.000s)
[348.877054] [083/142] (691s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[349.193270] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[349.196385] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[349.294623] [084/142] (690s left) prime_mmap (test_aperture_limit)
[349.498916] Starting subtest: test_aperture_limit
[349.500321] Starting dynamic subtest: test_aperture_limit-smem
[349.526311] Dynamic subtest test_aperture_limit-smem: SUCCESS (0.027s)
[349.527896] Subtest test_aperture_limit: SUCCESS (0.029s)
[349.627315] [085/142] (690s left) kms_cursor_crc (cursor-onscreen-128x128)
[349.939860] Starting subtest: cursor-onscreen-128x128
[349.954038] Starting dynamic subtest: pipe-A-DP-1
[352.300849] Dynamic subtest pipe-A-DP-1: SUCCESS (2.346s)
[352.388328] Starting dynamic subtest: pipe-C-DP-1
[355.045135] Dynamic subtest pipe-C-DP-1: SUCCESS (2.679s)
[355.046694] Subtest cursor-onscreen-128x128: SUCCESS (5.106s)
[355.418902] [086/142] (684s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[355.749251] Starting subtest: 4-tiled-8bpp-rotate-90
[355.752512] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.000s)
[355.865642] [087/142] (684s left) gem_mmap (bad-object)
[356.066645] Starting subtest: bad-object
[356.068010] Subtest bad-object: SUCCESS (0.000s)
[356.164118] [088/142] (684s left) vc4/vc4_purgeable_bo (mark-willneed)
[356.405107] Subtest mark-willneed: SKIP (0.000s)
[356.481338] [089/142] (683s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-blt)
[356.794841] Starting subtest: fbc-1p-offscren-pri-indfb-draw-blt
[358.721925] Subtest fbc-1p-offscren-pri-indfb-draw-blt: SUCCESS (1.930s)
[358.865436] [090/142] (681s left) prime_udl
[359.130116] [091/142] (681s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[359.434779] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[359.437621] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[359.549048] [092/142] (680s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[359.854915] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[359.857584] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[359.965422] [093/142] (680s left) kms_ccs (pipe-d-random-ccs-data-4_tiled_dg2_mc_ccs)
[360.634951] Subtest pipe-D-random-ccs-data-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[360.956326] [094/142] (679s left) kms_vblank (pipe-d-wait-idle-hang)
[361.277053] Subtest pipe-D-wait-idle-hang: SKIP (0.000s)
[361.371977] [095/142] (679s left) kms_addfb_basic (invalid-get-prop)
[361.579530] Starting subtest: invalid-get-prop
[361.581046] Subtest invalid-get-prop: SUCCESS (0.000s)
[361.789253] [096/142] (678s left) gem_render_copy_redux (normal)
[362.026889] Starting subtest: normal
[364.282261] Subtest normal: SUCCESS (2.259s)
[364.389555] [097/142] (676s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[364.694220] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[364.698576] Starting dynamic subtest: pipe-A-DP-1
[365.021846] Dynamic subtest pipe-A-DP-1: SUCCESS (0.324s)
[365.050873] Starting dynamic subtest: pipe-B-DP-1
[365.418782] Dynamic subtest pipe-B-DP-1: SUCCESS (0.391s)
[365.447215] Starting dynamic subtest: pipe-C-DP-1
[365.523469] Dynamic subtest pipe-C-DP-1: SKIP (0.096s)
[365.525088] Subtest planes-downscale-factor-0-5-upscale-20x20: SUCCESS (0.829s)
[365.955016] [098/142] (674s left) kms_vblank (pipe-b-query-idle-hang)
[366.260962] Starting subtest: pipe-B-query-idle-hang
[373.311922] Subtest pipe-B-query-idle-hang: SUCCESS (7.055s)
[373.673438] [099/142] (667s left) gem_exec_schedule (implicit-write-read)
[373.906734] Starting subtest: implicit-write-read
[373.911190] Starting dynamic subtest: rcs0
[374.070987] Dynamic subtest rcs0: SUCCESS (0.156s)
[374.099520] Starting dynamic subtest: bcs0
[374.218763] Dynamic subtest bcs0: SUCCESS (0.148s)
[374.256724] Starting dynamic subtest: vcs0
[374.363289] Dynamic subtest vcs0: SUCCESS (0.137s)
[374.393089] Starting dynamic subtest: vecs0
[374.504862] Dynamic subtest vecs0: SUCCESS (0.137s)
[374.506654] Subtest implicit-write-read: SUCCESS (0.598s)
[374.889625] [100/142] (665s left) gem_mmap_gtt (basic-wc)
[375.093375] Starting subtest: basic-wc
[375.723193] Subtest basic-wc: SUCCESS (0.631s)
[375.839567] [101/142] (664s left) sysfs_timeslice_duration (duration)
[376.047967] Starting subtest: duration
[376.052626] Starting dynamic subtest: vecs0
[376.150433] Dynamic subtest vecs0: SUCCESS (0.100s)
[376.182238] Starting dynamic subtest: vcs0
[376.242784] Dynamic subtest vcs0: SUCCESS (0.089s)
[376.270895] Starting dynamic subtest: bcs0
[376.346026] Dynamic subtest bcs0: SUCCESS (0.098s)
[376.377517] Starting dynamic subtest: rcs0
[376.458793] Dynamic subtest rcs0: SUCCESS (0.109s)
[376.464595] Subtest duration: SUCCESS (0.413s)
[376.555819] [102/142] (664s left) v3d/v3d_submit_cl (bad-multisync-pad)
[376.795928] Subtest bad-multisync-pad: SKIP (0.000s)
[376.872367] [103/142] (664s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[377.202887] Starting subtest: extended-modeset-hang-oldfb-with-reset
[377.207165] Starting dynamic subtest: pipe-A
[379.122867] Dynamic subtest pipe-A: SUCCESS (1.915s)
[379.155162] Starting dynamic subtest: pipe-C
[381.224606] Dynamic subtest pipe-C: SUCCESS (2.093s)
[381.226127] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (4.022s)
[381.585733] [104/142] (659s left) gem_linear_blits (normal)
[383.303811] Starting subtest: normal
[399.322583] Subtest normal: SUCCESS (16.018s)
[399.454621] [105/142] (641s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[399.938366] Starting subtest: y-tiled-64bpp-rotate-180
[407.854739] Subtest y-tiled-64bpp-rotate-180: SUCCESS (7.915s)
[408.784110] [106/142] (632s left) drm_fdinfo (busy-idle-check-all)
[408.998754] Starting subtest: busy-idle-check-all
[409.001438] Starting dynamic subtest: rcs0
[409.624099] Dynamic subtest rcs0: SUCCESS (0.626s)
[409.654890] Starting dynamic subtest: bcs0
[410.261614] Dynamic subtest bcs0: SUCCESS (0.634s)
[410.286468] Starting dynamic subtest: vcs0
[410.893465] Dynamic subtest vcs0: SUCCESS (0.630s)
[410.921107] Starting dynamic subtest: vecs0
[411.529323] Dynamic subtest vecs0: SUCCESS (0.633s)
[411.531399] Subtest busy-idle-check-all: SUCCESS (2.533s)
[411.615932] [107/142] (629s left) gem_mmap_gtt (pf-nonblock)
[411.821056] Starting subtest: pf-nonblock
[411.827824] Subtest pf-nonblock: SUCCESS (0.007s)
[411.949663] [108/142] (629s left) gem_exec_store (basic)
[412.179141] Starting subtest: basic
[412.248346] Subtest basic: SUCCESS (0.069s)
[412.449775] [109/142] (628s left) kms_vblank (pipe-b-query-forked)
[412.757612] Starting subtest: pipe-B-query-forked
[415.534854] Subtest pipe-B-query-forked: SUCCESS (2.782s)
[415.866392] [110/142] (625s left) vc4/vc4_wait_bo (unused-bo-1ns)
[416.136804] Subtest unused-bo-1ns: SKIP (0.000s)
[416.215307] [111/142] (625s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[416.521317] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[416.522912] Starting dynamic subtest: pipe-A-valid-mode
[416.916794] Dynamic subtest pipe-A-valid-mode: SKIP (0.391s)
[416.919845] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SKIP (0.395s)
[417.287546] [112/142] (624s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[417.613723] Starting subtest: yf-tiled-8bpp-rotate-180
[417.616409] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[417.720612] [113/142] (623s left) v3d/v3d_submit_cl (bad-bo)
[417.958856] Subtest bad-bo: SKIP (0.000s)
[418.050350] [114/142] (623s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[418.367951] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[418.371189] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[418.470097] [115/142] (622s left) gem_exec_fence (syncobj-timeline-signal)
[419.341158] Starting subtest: syncobj-timeline-signal
[419.351896] Subtest syncobj-timeline-signal: SUCCESS (0.011s)
[419.588342] [116/142] (621s left) syncobj_wait (invalid-signal-bad-pad)
[419.794087] Starting subtest: invalid-signal-bad-pad
[419.796048] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[419.886933] [117/142] (621s left) gem_workarounds (suspend-resume-context)
[420.121916] Starting subtest: suspend-resume-context
[437.816379] Subtest suspend-resume-context: SUCCESS (1.216s)
[443.983062] [118/142] (620s left) kms_chamelium_color (ctm-red-to-blue)
[444.291087] Subtest ctm-red-to-blue: SKIP (0.000s)
[444.356541] [119/142] (619s left) gem_exec_alignment (many)
[444.566663] Starting subtest: many
[457.478179] Killing the test because the kernel is tainted.
[459.103430] Aborting: Lockdep not active

/proc/lockdep_stats contents:
 lock-classes:                         1837 [max: 8192]
 direct dependencies:                 18888 [max: 32768]
 indirect dependencies:              155159
 all direct dependencies:            360663
 dependency chains:                   27613 [max: 131072]
 dependency chain hlocks used:       119881 [max: 655360]
 dependency chain hlocks lost:            0
 in-hardirq chains:                     210
 in-softirq chains:                     718
 in-process chains:                   26685
 stack-trace entries:                228475 [max: 1048576]
 number of stack traces:              10981
 number of stack hash chains:          7957
 combined max dependencies:      4048506374
 hardirq-safe locks:                     89
 hardirq-unsafe locks:                 1085
 softirq-safe locks:                    204
 softirq-unsafe locks:                  994
 irq-safe locks:                        226
 irq-unsafe locks:                     1085
 hardirq-read-safe locks:                 3
 hardirq-read-unsafe locks:             326
 softirq-read-safe locks:                 8
 softirq-read-unsafe locks:             321
 irq-read-safe locks:                     8
 irq-read-unsafe locks:                 326
 uncategorized locks:                   315
 unused locks:                            1
 max locking depth:                      16
 max bfs queue depth:                   422
 max lock class index:                 1836
 chain lookup misses:                 40580
 chain lookup hits:               252438520
 cyclic checks:                       41005
 redundant checks:                        0
 redundant links:                         0
 find-mask forwards checks:            7601
 find-mask backwards checks:           3940
 hardirq on events:               149138205
 hardirq off events:              149138201
 redundant hardirq ons:                  38
 redundant hardirq offs:                 77
 softirq on events:                 1065723
 softirq off events:                1065723
 redundant softirq ons:                   0
 redundant softirq offs:                  0
 debug_locks:                             0

 zapped classes:                        898
 zapped lock chains:                  12904
 large chain blocks:                      1

[459.107365] Closing watchdogs
Done.